builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-051 starttime: 1461166998.41 results: success (0) buildid: 20160420053128 builduid: 2ca941f4680a46ea86825a0bea70966a revision: 19954943888496006f660e90b3eee0c2482f5fca ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 08:43:18.406645) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 08:43:18.407400) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 08:43:18.407683) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 08:43:18.430305) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 08:43:18.430608) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1461166458.290806-512207186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-20 08:43:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 600K=0.02s 2016-04-20 08:43:19 (600 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164036 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 08:43:18.607959) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 08:43:18.608290) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1461166458.290806-512207186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018001 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 08:43:18.658498) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 08:43:18.658940) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 19954943888496006f660e90b3eee0c2482f5fca --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 19954943888496006f660e90b3eee0c2482f5fca --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1461166458.290806-512207186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-20 08:43:19,646 truncating revision to first 12 chars 2016-04-20 08:43:19,646 Setting DEBUG logging. 2016-04-20 08:43:19,646 attempt 1/10 2016-04-20 08:43:19,646 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/199549438884?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 08:43:19,892 unpacking tar archive at: fx-team-199549438884/testing/mozharness/ program finished with exit code 0 elapsedTime=0.543118 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 08:43:19.215250) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 08:43:19.215573) ========= script_repo_revision: 19954943888496006f660e90b3eee0c2482f5fca ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 08:43:19.216002) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 08:43:19.216316) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 08:43:19.224032) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-20 08:43:19.224337) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1461166458.290806-512207186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:43:20 INFO - MultiFileLogger online at 20160420 08:43:20 in /builds/slave/test 08:43:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:43:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:43:20 INFO - {'append_to_log': False, 08:43:20 INFO - 'base_work_dir': '/builds/slave/test', 08:43:20 INFO - 'blob_upload_branch': 'Fx-Team', 08:43:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:43:20 INFO - 'branch': 'Fx-Team', 08:43:20 INFO - 'buildbot_json_path': 'buildprops.json', 08:43:20 INFO - 'config_files': ('talos/linux_config.py',), 08:43:20 INFO - 'default_actions': ('clobber', 08:43:20 INFO - 'read-buildbot-config', 08:43:20 INFO - 'download-and-extract', 08:43:20 INFO - 'populate-webroot', 08:43:20 INFO - 'create-virtualenv', 08:43:20 INFO - 'install', 08:43:20 INFO - 'run-tests'), 08:43:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:43:20 INFO - 'download_minidump_stackwalk': True, 08:43:20 INFO - 'download_symbols': 'ondemand', 08:43:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:43:20 INFO - 'tooltool.py': '/tools/tooltool.py', 08:43:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:43:20 INFO - '/tools/misc-python/virtualenv.py')}, 08:43:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:43:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:43:20 INFO - 'installer_path': 'installer.exe', 08:43:20 INFO - 'log_level': 'info', 08:43:20 INFO - 'log_name': 'talos', 08:43:20 INFO - 'log_to_console': True, 08:43:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:43:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:43:20 INFO - 'opt_config_files': (), 08:43:20 INFO - 'pip_index': False, 08:43:20 INFO - 'sps_profile': False, 08:43:20 INFO - 'sps_profile_interval': 0, 08:43:20 INFO - 'suite': 'dromaeojs-e10s', 08:43:20 INFO - 'system_bits': '32', 08:43:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:43:20 INFO - 'title': 'talos-linux64-ix-051', 08:43:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:43:20 INFO - 'use_talos_json': True, 08:43:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:43:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:43:20 INFO - 'work_dir': 'build'} 08:43:20 INFO - ##### 08:43:20 INFO - ##### Running clobber step. 08:43:20 INFO - ##### 08:43:20 INFO - Running pre-action listener: _resource_record_pre_action 08:43:20 INFO - Running main action method: clobber 08:43:20 INFO - rmtree: /builds/slave/test/build 08:43:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:43:21 INFO - Running post-action listener: _resource_record_post_action 08:43:21 INFO - ##### 08:43:21 INFO - ##### Running read-buildbot-config step. 08:43:21 INFO - ##### 08:43:21 INFO - Running pre-action listener: _resource_record_pre_action 08:43:21 INFO - Running main action method: read_buildbot_config 08:43:21 INFO - Using buildbot properties: 08:43:21 INFO - { 08:43:21 INFO - "project": "", 08:43:21 INFO - "product": "firefox", 08:43:21 INFO - "script_repo_revision": "production", 08:43:21 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:43:21 INFO - "repository": "", 08:43:21 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:43:21 INFO - "buildid": "20160420053128", 08:43:21 INFO - "pgo_build": "True", 08:43:21 INFO - "basedir": "/builds/slave/test", 08:43:21 INFO - "buildnumber": 666, 08:43:21 INFO - "slavename": "talos-linux64-ix-051", 08:43:21 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:43:21 INFO - "platform": "ubuntu64_hw", 08:43:21 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:43:21 INFO - "branch": "fx-team", 08:43:21 INFO - "repo_path": "integration/fx-team", 08:43:21 INFO - "revision": "19954943888496006f660e90b3eee0c2482f5fca", 08:43:21 INFO - "stage_platform": "linux64-pgo", 08:43:21 INFO - "builduid": "2ca941f4680a46ea86825a0bea70966a", 08:43:21 INFO - "slavebuilddir": "test" 08:43:21 INFO - } 08:43:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/WjJUxYJcQBCFoLQqe3PNyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 08:43:21 INFO - Running post-action listener: _resource_record_post_action 08:43:21 INFO - ##### 08:43:21 INFO - ##### Running download-and-extract step. 08:43:21 INFO - ##### 08:43:21 INFO - Running pre-action listener: _resource_record_pre_action 08:43:21 INFO - Running main action method: download_and_extract 08:43:21 INFO - mkdir: /builds/slave/test/build/tests 08:43:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:21 INFO - https://queue.taskcluster.net/v1/task/WjJUxYJcQBCFoLQqe3PNyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:43:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WjJUxYJcQBCFoLQqe3PNyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:43:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WjJUxYJcQBCFoLQqe3PNyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:43:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WjJUxYJcQBCFoLQqe3PNyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:43:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WjJUxYJcQBCFoLQqe3PNyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:43:25 INFO - Downloaded 1361 bytes. 08:43:25 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:43:25 INFO - Using the following test package requirements: 08:43:25 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:43:25 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:43:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:43:25 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:43:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:43:25 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:43:25 INFO - u'jsshell-linux-x86_64.zip'], 08:43:25 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:43:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:43:25 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:43:25 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:43:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:43:25 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:43:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:43:25 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:43:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:43:25 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:43:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:43:25 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:43:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:25 INFO - https://queue.taskcluster.net/v1/task/WjJUxYJcQBCFoLQqe3PNyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:43:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WjJUxYJcQBCFoLQqe3PNyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:43:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WjJUxYJcQBCFoLQqe3PNyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:43:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WjJUxYJcQBCFoLQqe3PNyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:43:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WjJUxYJcQBCFoLQqe3PNyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:43:28 INFO - Downloaded 23839096 bytes. 08:43:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:43:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:43:29 INFO - Return code: 0 08:43:29 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:43:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:29 INFO - https://queue.taskcluster.net/v1/task/WjJUxYJcQBCFoLQqe3PNyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:43:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WjJUxYJcQBCFoLQqe3PNyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:43:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WjJUxYJcQBCFoLQqe3PNyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:43:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WjJUxYJcQBCFoLQqe3PNyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:43:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WjJUxYJcQBCFoLQqe3PNyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:43:32 INFO - Downloaded 23839096 bytes. 08:43:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:43:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:43:33 INFO - Return code: 0 08:43:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:33 INFO - https://queue.taskcluster.net/v1/task/WjJUxYJcQBCFoLQqe3PNyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:43:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WjJUxYJcQBCFoLQqe3PNyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:43:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WjJUxYJcQBCFoLQqe3PNyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:43:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WjJUxYJcQBCFoLQqe3PNyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:43:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WjJUxYJcQBCFoLQqe3PNyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:43:34 INFO - Downloaded 10845952 bytes. 08:43:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:43:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:43:34 INFO - Return code: 0 08:43:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:34 INFO - https://queue.taskcluster.net/v1/task/WjJUxYJcQBCFoLQqe3PNyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:43:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WjJUxYJcQBCFoLQqe3PNyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:43:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WjJUxYJcQBCFoLQqe3PNyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:43:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WjJUxYJcQBCFoLQqe3PNyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:43:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WjJUxYJcQBCFoLQqe3PNyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:43:36 INFO - Downloaded 58294456 bytes. 08:43:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WjJUxYJcQBCFoLQqe3PNyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:43:36 INFO - mkdir: /builds/slave/test/properties 08:43:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:43:36 INFO - Writing to file /builds/slave/test/properties/build_url 08:43:36 INFO - Contents: 08:43:36 INFO - build_url:https://queue.taskcluster.net/v1/task/WjJUxYJcQBCFoLQqe3PNyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:43:36 INFO - Running post-action listener: _resource_record_post_action 08:43:36 INFO - Running post-action listener: set_extra_try_arguments 08:43:36 INFO - ##### 08:43:36 INFO - ##### Running populate-webroot step. 08:43:36 INFO - ##### 08:43:36 INFO - Running pre-action listener: _resource_record_pre_action 08:43:36 INFO - Running main action method: populate_webroot 08:43:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:43:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:43:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:43:36 INFO - '--tppagecycles', 08:43:36 INFO - '7'], 08:43:36 INFO - 'tests': ['tsvgm']}}, 08:43:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:43:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:43:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:43:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:43:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:43:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:43:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:36 INFO - 'talos_options': ['--disable-e10s'], 08:43:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:43:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:43:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:36 INFO - 'talos_options': ['--disable-e10s'], 08:43:36 INFO - 'tests': ['damp', 'tps']}, 08:43:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:36 INFO - 'tests': ['damp', 'tps']}, 08:43:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:43:36 INFO - 'tests': ['dromaeo_dom']}, 08:43:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:43:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:43:36 INFO - 'tests': ['a11yr', 08:43:36 INFO - 'ts_paint', 08:43:36 INFO - 'tpaint', 08:43:36 INFO - 'sessionrestore', 08:43:36 INFO - 'sessionrestore_no_auto_restore', 08:43:36 INFO - 'tabpaint']}, 08:43:36 INFO - 'other-e10s': {'tests': ['a11yr', 08:43:36 INFO - 'ts_paint', 08:43:36 INFO - 'tpaint', 08:43:36 INFO - 'sessionrestore', 08:43:36 INFO - 'sessionrestore_no_auto_restore', 08:43:36 INFO - 'tabpaint']}, 08:43:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:43:36 INFO - 'ts_paint', 08:43:36 INFO - 'tpaint', 08:43:36 INFO - 'sessionrestore', 08:43:36 INFO - 'sessionrestore_no_auto_restore', 08:43:36 INFO - 'tabpaint']}, 08:43:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:43:36 INFO - 'ts_paint', 08:43:36 INFO - 'tpaint', 08:43:36 INFO - 'sessionrestore', 08:43:36 INFO - 'sessionrestore_no_auto_restore', 08:43:36 INFO - 'tabpaint']}, 08:43:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:43:36 INFO - 'tests': ['a11yr', 08:43:36 INFO - 'ts_paint', 08:43:36 INFO - 'tpaint', 08:43:36 INFO - 'sessionrestore', 08:43:36 INFO - 'sessionrestore_no_auto_restore', 08:43:36 INFO - 'tabpaint']}, 08:43:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:43:36 INFO - 'tests': ['a11yr', 08:43:36 INFO - 'ts_paint', 08:43:36 INFO - 'tpaint', 08:43:36 INFO - 'sessionrestore', 08:43:36 INFO - 'sessionrestore_no_auto_restore', 08:43:36 INFO - 'tabpaint']}, 08:43:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:43:36 INFO - 'tests': ['tsvgx', 08:43:36 INFO - 'tsvgr_opacity', 08:43:36 INFO - 'tart', 08:43:36 INFO - 'tscrollx', 08:43:36 INFO - 'cart']}, 08:43:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:43:36 INFO - 'tsvgr_opacity', 08:43:36 INFO - 'tart', 08:43:36 INFO - 'tscrollx', 08:43:36 INFO - 'cart']}, 08:43:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:36 INFO - 'talos_options': ['--disable-e10s'], 08:43:36 INFO - 'tests': ['tp5o']}, 08:43:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:36 INFO - 'tests': ['tp5o']}, 08:43:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:36 INFO - 'talos_options': ['--disable-e10s', 08:43:36 INFO - '--xperf_path', 08:43:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:43:36 INFO - 'tests': ['tp5n']}, 08:43:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:36 INFO - 'talos_options': ['--xperf_path', 08:43:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:43:36 INFO - 'tests': ['tp5n']}}, 08:43:36 INFO - 'talos.zip': {'path': '', 08:43:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:43:36 INFO - Running post-action listener: _resource_record_post_action 08:43:36 INFO - ##### 08:43:36 INFO - ##### Running create-virtualenv step. 08:43:36 INFO - ##### 08:43:36 INFO - Running pre-action listener: _resource_record_pre_action 08:43:36 INFO - Running main action method: create_virtualenv 08:43:36 INFO - Creating virtualenv /builds/slave/test/build/venv 08:43:36 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:43:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:43:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:43:37 INFO - Using real prefix '/usr' 08:43:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:43:37 INFO - Installing distribute.............................................................................................................................................................................................done. 08:43:39 INFO - Installing pip.................done. 08:43:39 INFO - Return code: 0 08:43:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:43:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5db0816f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25305a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c07a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461166458.290806-512207186', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:43:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:43:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:43:39 INFO - Using env: {'DISPLAY': ':0', 08:43:39 INFO - 'HOME': '/home/cltbld', 08:43:39 INFO - 'LANG': 'en_US.UTF-8', 08:43:39 INFO - 'LANGUAGE': 'en_US:en', 08:43:39 INFO - 'LOGNAME': 'cltbld', 08:43:39 INFO - 'MAIL': '/var/mail/cltbld', 08:43:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:39 INFO - 'MOZ_NO_REMOTE': '1', 08:43:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:39 INFO - 'NO_EM_RESTART': '1', 08:43:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:39 INFO - 'PWD': '/builds/slave/test', 08:43:39 INFO - 'SHELL': '/bin/bash', 08:43:39 INFO - 'SHLVL': '1', 08:43:39 INFO - 'TERM': 'linux', 08:43:39 INFO - 'TMOUT': '86400', 08:43:39 INFO - 'USER': 'cltbld', 08:43:39 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461166458.290806-512207186', 08:43:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:39 INFO - '_': '/tools/buildbot/bin/python'} 08:43:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:39 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:43:39 INFO - Cleaning up... 08:43:39 INFO - Return code: 0 08:43:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:43:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5db0816f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25305a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c07a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461166458.290806-512207186', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:43:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:43:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:43:39 INFO - Using env: {'DISPLAY': ':0', 08:43:39 INFO - 'HOME': '/home/cltbld', 08:43:39 INFO - 'LANG': 'en_US.UTF-8', 08:43:39 INFO - 'LANGUAGE': 'en_US:en', 08:43:39 INFO - 'LOGNAME': 'cltbld', 08:43:39 INFO - 'MAIL': '/var/mail/cltbld', 08:43:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:39 INFO - 'MOZ_NO_REMOTE': '1', 08:43:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:39 INFO - 'NO_EM_RESTART': '1', 08:43:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:39 INFO - 'PWD': '/builds/slave/test', 08:43:39 INFO - 'SHELL': '/bin/bash', 08:43:39 INFO - 'SHLVL': '1', 08:43:39 INFO - 'TERM': 'linux', 08:43:39 INFO - 'TMOUT': '86400', 08:43:39 INFO - 'USER': 'cltbld', 08:43:39 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461166458.290806-512207186', 08:43:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:39 INFO - '_': '/tools/buildbot/bin/python'} 08:43:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:39 INFO - Downloading/unpacking psutil>=0.7.1 08:43:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:43:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:43:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:43:41 INFO - Installing collected packages: psutil 08:43:41 INFO - Running setup.py install for psutil 08:43:42 INFO - building 'psutil._psutil_linux' extension 08:43:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:43:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:43:42 INFO - building 'psutil._psutil_posix' extension 08:43:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:43:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:43:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:43:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:43:42 INFO - Successfully installed psutil 08:43:42 INFO - Cleaning up... 08:43:42 INFO - Return code: 0 08:43:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:43:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5db0816f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25305a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c07a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461166458.290806-512207186', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:43:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:43:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:43:42 INFO - Using env: {'DISPLAY': ':0', 08:43:42 INFO - 'HOME': '/home/cltbld', 08:43:42 INFO - 'LANG': 'en_US.UTF-8', 08:43:42 INFO - 'LANGUAGE': 'en_US:en', 08:43:42 INFO - 'LOGNAME': 'cltbld', 08:43:42 INFO - 'MAIL': '/var/mail/cltbld', 08:43:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:42 INFO - 'MOZ_NO_REMOTE': '1', 08:43:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:42 INFO - 'NO_EM_RESTART': '1', 08:43:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:42 INFO - 'PWD': '/builds/slave/test', 08:43:42 INFO - 'SHELL': '/bin/bash', 08:43:42 INFO - 'SHLVL': '1', 08:43:42 INFO - 'TERM': 'linux', 08:43:42 INFO - 'TMOUT': '86400', 08:43:42 INFO - 'USER': 'cltbld', 08:43:42 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461166458.290806-512207186', 08:43:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:42 INFO - '_': '/tools/buildbot/bin/python'} 08:43:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:43:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:43:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:43:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:43:44 INFO - Installing collected packages: mozsystemmonitor 08:43:44 INFO - Running setup.py install for mozsystemmonitor 08:43:44 INFO - Successfully installed mozsystemmonitor 08:43:44 INFO - Cleaning up... 08:43:44 INFO - Return code: 0 08:43:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:43:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5db0816f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25305a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c07a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461166458.290806-512207186', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:43:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:43:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:43:44 INFO - Using env: {'DISPLAY': ':0', 08:43:44 INFO - 'HOME': '/home/cltbld', 08:43:44 INFO - 'LANG': 'en_US.UTF-8', 08:43:44 INFO - 'LANGUAGE': 'en_US:en', 08:43:44 INFO - 'LOGNAME': 'cltbld', 08:43:44 INFO - 'MAIL': '/var/mail/cltbld', 08:43:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:44 INFO - 'MOZ_NO_REMOTE': '1', 08:43:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:44 INFO - 'NO_EM_RESTART': '1', 08:43:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:44 INFO - 'PWD': '/builds/slave/test', 08:43:44 INFO - 'SHELL': '/bin/bash', 08:43:44 INFO - 'SHLVL': '1', 08:43:44 INFO - 'TERM': 'linux', 08:43:44 INFO - 'TMOUT': '86400', 08:43:44 INFO - 'USER': 'cltbld', 08:43:44 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461166458.290806-512207186', 08:43:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:44 INFO - '_': '/tools/buildbot/bin/python'} 08:43:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:44 INFO - Downloading/unpacking blobuploader==1.2.4 08:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:46 INFO - Downloading blobuploader-1.2.4.tar.gz 08:43:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:43:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:43:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:47 INFO - Downloading docopt-0.6.1.tar.gz 08:43:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:43:47 INFO - Installing collected packages: blobuploader, requests, docopt 08:43:47 INFO - Running setup.py install for blobuploader 08:43:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:43:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:43:47 INFO - Running setup.py install for requests 08:43:48 INFO - Running setup.py install for docopt 08:43:48 INFO - Successfully installed blobuploader requests docopt 08:43:48 INFO - Cleaning up... 08:43:48 INFO - Return code: 0 08:43:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:43:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5db0816f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25305a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c07a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461166458.290806-512207186', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:43:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:43:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:43:48 INFO - Using env: {'DISPLAY': ':0', 08:43:48 INFO - 'HOME': '/home/cltbld', 08:43:48 INFO - 'LANG': 'en_US.UTF-8', 08:43:48 INFO - 'LANGUAGE': 'en_US:en', 08:43:48 INFO - 'LOGNAME': 'cltbld', 08:43:48 INFO - 'MAIL': '/var/mail/cltbld', 08:43:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:48 INFO - 'MOZ_NO_REMOTE': '1', 08:43:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:48 INFO - 'NO_EM_RESTART': '1', 08:43:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:48 INFO - 'PWD': '/builds/slave/test', 08:43:48 INFO - 'SHELL': '/bin/bash', 08:43:48 INFO - 'SHLVL': '1', 08:43:48 INFO - 'TERM': 'linux', 08:43:48 INFO - 'TMOUT': '86400', 08:43:48 INFO - 'USER': 'cltbld', 08:43:48 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461166458.290806-512207186', 08:43:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:48 INFO - '_': '/tools/buildbot/bin/python'} 08:43:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:43:48 INFO - Running setup.py (path:/tmp/pip-3ettZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:43:48 INFO - Running setup.py (path:/tmp/pip-_Cnvmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:43:48 INFO - Running setup.py (path:/tmp/pip-4iKBRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:43:48 INFO - Running setup.py (path:/tmp/pip-nM37XN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:43:48 INFO - Running setup.py (path:/tmp/pip-MrU1Pw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:43:48 INFO - Running setup.py (path:/tmp/pip-6fv7LR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:43:48 INFO - Running setup.py (path:/tmp/pip-ugkDiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:43:48 INFO - Running setup.py (path:/tmp/pip-NCGJsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:43:49 INFO - Running setup.py (path:/tmp/pip-J0cxuz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:43:49 INFO - Running setup.py (path:/tmp/pip-tPJ3zP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:43:49 INFO - Running setup.py (path:/tmp/pip-YK_D7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:43:49 INFO - Running setup.py (path:/tmp/pip-_Zkaw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:43:49 INFO - Running setup.py (path:/tmp/pip-YnLeZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:43:49 INFO - Running setup.py (path:/tmp/pip-OLqutl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:49 INFO - Running setup.py (path:/tmp/pip-s9QuxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:43:49 INFO - Running setup.py (path:/tmp/pip-xaJV8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:43:49 INFO - Running setup.py (path:/tmp/pip-zaj1gK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:43:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:43:49 INFO - Running setup.py install for manifestparser 08:43:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:43:49 INFO - Running setup.py install for mozcrash 08:43:49 INFO - Running setup.py install for mozdebug 08:43:49 INFO - Running setup.py install for mozdevice 08:43:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:43:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:43:50 INFO - Running setup.py install for mozfile 08:43:50 INFO - Running setup.py install for mozhttpd 08:43:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:43:50 INFO - Running setup.py install for mozinfo 08:43:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:43:50 INFO - Running setup.py install for mozInstall 08:43:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:43:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:43:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:43:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:43:50 INFO - Running setup.py install for mozleak 08:43:50 INFO - Running setup.py install for mozlog 08:43:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:43:50 INFO - Running setup.py install for moznetwork 08:43:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:43:50 INFO - Running setup.py install for mozprocess 08:43:50 INFO - Running setup.py install for mozprofile 08:43:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:43:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:43:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:43:51 INFO - Running setup.py install for mozrunner 08:43:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:43:51 INFO - Running setup.py install for mozscreenshot 08:43:51 INFO - Running setup.py install for moztest 08:43:51 INFO - Running setup.py install for mozversion 08:43:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:43:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:43:51 INFO - Cleaning up... 08:43:51 INFO - Return code: 0 08:43:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:43:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5db0816f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25305a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c07a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461166458.290806-512207186', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:43:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:43:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:43:51 INFO - Using env: {'DISPLAY': ':0', 08:43:51 INFO - 'HOME': '/home/cltbld', 08:43:51 INFO - 'LANG': 'en_US.UTF-8', 08:43:51 INFO - 'LANGUAGE': 'en_US:en', 08:43:51 INFO - 'LOGNAME': 'cltbld', 08:43:51 INFO - 'MAIL': '/var/mail/cltbld', 08:43:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:51 INFO - 'MOZ_NO_REMOTE': '1', 08:43:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:51 INFO - 'NO_EM_RESTART': '1', 08:43:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:51 INFO - 'PWD': '/builds/slave/test', 08:43:51 INFO - 'SHELL': '/bin/bash', 08:43:51 INFO - 'SHLVL': '1', 08:43:51 INFO - 'TERM': 'linux', 08:43:51 INFO - 'TMOUT': '86400', 08:43:51 INFO - 'USER': 'cltbld', 08:43:51 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461166458.290806-512207186', 08:43:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:51 INFO - '_': '/tools/buildbot/bin/python'} 08:43:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:43:51 INFO - Running setup.py (path:/tmp/pip-t0S7Bq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:43:51 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:43:51 INFO - Running setup.py (path:/tmp/pip-H2bAnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:43:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:43:51 INFO - Running setup.py (path:/tmp/pip-4joNRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:43:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:43:51 INFO - Running setup.py (path:/tmp/pip-MtSF5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:43:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:43:51 INFO - Running setup.py (path:/tmp/pip-Zu6afV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:43:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:43:52 INFO - Running setup.py (path:/tmp/pip-K9IKp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:43:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:43:52 INFO - Running setup.py (path:/tmp/pip-CO0X7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:43:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:43:52 INFO - Running setup.py (path:/tmp/pip-y1ycUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:43:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:43:52 INFO - Running setup.py (path:/tmp/pip-4n6U94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:43:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:43:52 INFO - Running setup.py (path:/tmp/pip-_6R8YA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:43:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:43:52 INFO - Running setup.py (path:/tmp/pip-yY17fL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:43:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:43:52 INFO - Running setup.py (path:/tmp/pip-Uzbr4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:43:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:43:52 INFO - Running setup.py (path:/tmp/pip-vtQQ2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:43:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:43:52 INFO - Running setup.py (path:/tmp/pip-pKh4k8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:43:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:52 INFO - Running setup.py (path:/tmp/pip-i2J6gZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:43:52 INFO - Running setup.py (path:/tmp/pip-qOYCzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:43:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:43:52 INFO - Running setup.py (path:/tmp/pip-LvaImv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:43:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:43:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:43:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:43:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:43:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:43:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:43:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:54 INFO - Downloading blessings-1.6.tar.gz 08:43:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:43:54 INFO - Installing collected packages: blessings 08:43:54 INFO - Running setup.py install for blessings 08:43:54 INFO - Successfully installed blessings 08:43:54 INFO - Cleaning up... 08:43:55 INFO - Return code: 0 08:43:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:43:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:43:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:43:55 INFO - Reading from file tmpfile_stdout 08:43:55 INFO - Current package versions: 08:43:55 INFO - argparse == 1.2.1 08:43:55 INFO - blessings == 1.6 08:43:55 INFO - blobuploader == 1.2.4 08:43:55 INFO - docopt == 0.6.1 08:43:55 INFO - manifestparser == 1.1 08:43:55 INFO - mozInstall == 1.12 08:43:55 INFO - mozcrash == 0.17 08:43:55 INFO - mozdebug == 0.1 08:43:55 INFO - mozdevice == 0.48 08:43:55 INFO - mozfile == 1.2 08:43:55 INFO - mozhttpd == 0.7 08:43:55 INFO - mozinfo == 0.9 08:43:55 INFO - mozleak == 0.1 08:43:55 INFO - mozlog == 3.1 08:43:55 INFO - moznetwork == 0.27 08:43:55 INFO - mozprocess == 0.22 08:43:55 INFO - mozprofile == 0.28 08:43:55 INFO - mozrunner == 6.11 08:43:55 INFO - mozscreenshot == 0.1 08:43:55 INFO - mozsystemmonitor == 0.0 08:43:55 INFO - moztest == 0.7 08:43:55 INFO - mozversion == 1.4 08:43:55 INFO - psutil == 3.1.1 08:43:55 INFO - requests == 1.2.3 08:43:55 INFO - wsgiref == 0.1.2 08:43:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5db0816f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25305a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c07a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461166458.290806-512207186', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:43:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:43:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:43:55 INFO - Using env: {'DISPLAY': ':0', 08:43:55 INFO - 'HOME': '/home/cltbld', 08:43:55 INFO - 'LANG': 'en_US.UTF-8', 08:43:55 INFO - 'LANGUAGE': 'en_US:en', 08:43:55 INFO - 'LOGNAME': 'cltbld', 08:43:55 INFO - 'MAIL': '/var/mail/cltbld', 08:43:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:55 INFO - 'MOZ_NO_REMOTE': '1', 08:43:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:55 INFO - 'NO_EM_RESTART': '1', 08:43:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:55 INFO - 'PWD': '/builds/slave/test', 08:43:55 INFO - 'SHELL': '/bin/bash', 08:43:55 INFO - 'SHLVL': '1', 08:43:55 INFO - 'TERM': 'linux', 08:43:55 INFO - 'TMOUT': '86400', 08:43:55 INFO - 'USER': 'cltbld', 08:43:55 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461166458.290806-512207186', 08:43:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:55 INFO - '_': '/tools/buildbot/bin/python'} 08:43:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:43:55 INFO - Cleaning up... 08:43:55 INFO - Return code: 0 08:43:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5db0816f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25305a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c07a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461166458.290806-512207186', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:43:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:43:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:43:55 INFO - Using env: {'DISPLAY': ':0', 08:43:55 INFO - 'HOME': '/home/cltbld', 08:43:55 INFO - 'LANG': 'en_US.UTF-8', 08:43:55 INFO - 'LANGUAGE': 'en_US:en', 08:43:55 INFO - 'LOGNAME': 'cltbld', 08:43:55 INFO - 'MAIL': '/var/mail/cltbld', 08:43:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:55 INFO - 'MOZ_NO_REMOTE': '1', 08:43:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:55 INFO - 'NO_EM_RESTART': '1', 08:43:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:55 INFO - 'PWD': '/builds/slave/test', 08:43:55 INFO - 'SHELL': '/bin/bash', 08:43:55 INFO - 'SHLVL': '1', 08:43:55 INFO - 'TERM': 'linux', 08:43:55 INFO - 'TMOUT': '86400', 08:43:55 INFO - 'USER': 'cltbld', 08:43:55 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461166458.290806-512207186', 08:43:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:55 INFO - '_': '/tools/buildbot/bin/python'} 08:43:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:55 INFO - Downloading/unpacking jsonschema 08:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:43:57 INFO - Downloading/unpacking functools32 (from jsonschema) 08:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:57 INFO - Downloading functools32-3.2.3-2.tar.gz 08:43:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:43:57 INFO - warning: no files found matching '*.txt' 08:43:57 INFO - no previously-included directories found matching 'build' 08:43:57 INFO - no previously-included directories found matching 'dist' 08:43:57 INFO - no previously-included directories found matching '.git*' 08:43:57 INFO - Installing collected packages: jsonschema, functools32 08:43:57 INFO - Running setup.py install for functools32 08:43:57 INFO - warning: no files found matching '*.txt' 08:43:57 INFO - no previously-included directories found matching 'build' 08:43:57 INFO - no previously-included directories found matching 'dist' 08:43:57 INFO - no previously-included directories found matching '.git*' 08:43:57 INFO - Successfully installed jsonschema functools32 08:43:57 INFO - Cleaning up... 08:43:58 INFO - Return code: 0 08:43:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5db0816f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25305a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c07a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461166458.290806-512207186', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:43:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:43:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:43:58 INFO - Using env: {'DISPLAY': ':0', 08:43:58 INFO - 'HOME': '/home/cltbld', 08:43:58 INFO - 'LANG': 'en_US.UTF-8', 08:43:58 INFO - 'LANGUAGE': 'en_US:en', 08:43:58 INFO - 'LOGNAME': 'cltbld', 08:43:58 INFO - 'MAIL': '/var/mail/cltbld', 08:43:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:58 INFO - 'MOZ_NO_REMOTE': '1', 08:43:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:58 INFO - 'NO_EM_RESTART': '1', 08:43:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:58 INFO - 'PWD': '/builds/slave/test', 08:43:58 INFO - 'SHELL': '/bin/bash', 08:43:58 INFO - 'SHLVL': '1', 08:43:58 INFO - 'TERM': 'linux', 08:43:58 INFO - 'TMOUT': '86400', 08:43:58 INFO - 'USER': 'cltbld', 08:43:58 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461166458.290806-512207186', 08:43:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:58 INFO - '_': '/tools/buildbot/bin/python'} 08:43:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:58 INFO - Downloading/unpacking flake8 08:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:44:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:44:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:44:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:44:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:44:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:44:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:44:00 INFO - no previously-included directories found matching 'docs/_build' 08:44:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:44:00 INFO - Running setup.py install for pep8 08:44:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:44:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:44:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:44:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:44:00 INFO - no previously-included directories found matching 'docs/_build' 08:44:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:44:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:44:01 INFO - Cleaning up... 08:44:01 INFO - Return code: 0 08:44:01 INFO - Running post-action listener: _resource_record_post_action 08:44:01 INFO - Running post-action listener: _start_resource_monitoring 08:44:01 INFO - Starting resource monitoring. 08:44:01 INFO - ##### 08:44:01 INFO - ##### Running install step. 08:44:01 INFO - ##### 08:44:01 INFO - Running pre-action listener: _resource_record_pre_action 08:44:01 INFO - Running main action method: install 08:44:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:44:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:44:01 INFO - Reading from file tmpfile_stdout 08:44:01 INFO - Detecting whether we're running mozinstall >=1.0... 08:44:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:44:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:44:01 INFO - Reading from file tmpfile_stdout 08:44:01 INFO - Output received: 08:44:01 INFO - Usage: mozinstall [options] installer 08:44:01 INFO - Options: 08:44:01 INFO - -h, --help show this help message and exit 08:44:01 INFO - -d DEST, --destination=DEST 08:44:01 INFO - Directory to install application into. [default: 08:44:01 INFO - "/builds/slave/test"] 08:44:01 INFO - --app=APP Application being installed. [default: firefox] 08:44:01 INFO - mkdir: /builds/slave/test/build/application 08:44:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:44:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:44:18 INFO - Reading from file tmpfile_stdout 08:44:18 INFO - Output received: 08:44:18 INFO - /builds/slave/test/build/application/firefox/firefox 08:44:18 INFO - Running post-action listener: _resource_record_post_action 08:44:18 INFO - ##### 08:44:18 INFO - ##### Running run-tests step. 08:44:18 INFO - ##### 08:44:18 INFO - Running pre-action listener: _resource_record_pre_action 08:44:18 INFO - Running main action method: run_tests 08:44:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:44:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:44:18 INFO - Python 2.7.3 08:44:18 INFO - Return code: 0 08:44:18 INFO - grabbing minidump binary from tooltool 08:44:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:44:18 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c07a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:44:18 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:44:18 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:44:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:44:18 INFO - Return code: 0 08:44:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:44:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:44:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:44:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:44:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:44:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:44:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:44:19 INFO - Return code: 0 08:44:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WjJUxYJcQBCFoLQqe3PNyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:44:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WjJUxYJcQBCFoLQqe3PNyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:44:19 INFO - Using env: {'DISPLAY': ':0', 08:44:19 INFO - 'HOME': '/home/cltbld', 08:44:19 INFO - 'LANG': 'en_US.UTF-8', 08:44:19 INFO - 'LANGUAGE': 'en_US:en', 08:44:19 INFO - 'LOGNAME': 'cltbld', 08:44:19 INFO - 'MAIL': '/var/mail/cltbld', 08:44:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:44:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:44:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:19 INFO - 'MOZ_NO_REMOTE': '1', 08:44:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:44:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:19 INFO - 'NO_EM_RESTART': '1', 08:44:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:19 INFO - 'PWD': '/builds/slave/test', 08:44:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:44:19 INFO - 'SHELL': '/bin/bash', 08:44:19 INFO - 'SHLVL': '1', 08:44:19 INFO - 'TERM': 'linux', 08:44:19 INFO - 'TMOUT': '86400', 08:44:19 INFO - 'USER': 'cltbld', 08:44:19 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461166458.290806-512207186', 08:44:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:19 INFO - '_': '/tools/buildbot/bin/python'} 08:44:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WjJUxYJcQBCFoLQqe3PNyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:44:19 INFO - mozversion application_buildid: 20160420053128 08:44:19 INFO - mozversion application_changeset: 19954943888496006f660e90b3eee0c2482f5fca 08:44:19 INFO - mozversion application_display_name: Nightly 08:44:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:44:19 INFO - mozversion application_name: Firefox 08:44:19 INFO - mozversion application_remotingname: firefox 08:44:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:44:19 INFO - mozversion application_vendor: Mozilla 08:44:19 INFO - mozversion application_version: 48.0a1 08:44:19 INFO - mozversion platform_buildid: 20160420053128 08:44:19 INFO - mozversion platform_changeset: 19954943888496006f660e90b3eee0c2482f5fca 08:44:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:44:19 INFO - mozversion platform_version: 48.0a1 08:44:19 INFO - using testdate: 1461167059 08:44:19 INFO - actual date: 1461167059 08:44:19 INFO - starting webserver on 'localhost:34698' 08:44:19 INFO - SUITE-START | Running 2 tests 08:44:19 INFO - TEST-START | dromaeo_css 08:44:19 INFO - operating with platform_type : linux_ 08:44:19 INFO - Initialising browser for dromaeo_css test... 08:44:19 INFO - TEST-INFO | started process 938 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUj06Z6/profile http://localhost:34698/getInfo.html) 08:44:23 INFO - PROCESS | 938 | 08:44:23 INFO - PROCESS | 938 | (process:1013): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:44:23 INFO - PROCESS | 938 | __metrics Screen width/height:1600/1200 08:44:23 INFO - PROCESS | 938 | colorDepth:24 08:44:23 INFO - PROCESS | 938 | Browser inner width/height: 1024/697 08:44:23 INFO - PROCESS | 938 | __metrics 08:44:24 ERROR - PROCESS | 938 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:44:25 INFO - TEST-INFO | 938: exit 0 08:44:25 INFO - Browser initialized. 08:44:25 INFO - Running cycle 1/1 for dromaeo_css test... 08:44:25 INFO - TEST-INFO | started process 1065 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUj06Z6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:44:27 INFO - PROCESS | 1065 | 08:44:27 INFO - PROCESS | 1065 | (process:1136): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:44:37 INFO - PROCESS | 1065 | RSS: Main: 163434496 08:44:37 INFO - PROCESS | 1065 | 08:45:26 INFO - PROCESS | 1065 | 1461167126785 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:47:34 INFO - PROCESS | 1065 | Cycle 1(1): loaded http://localhost:34698/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34698/tests/dromaeo/cssquery-ext.html) 08:47:35 INFO - PROCESS | 1065 | RSS: Main: 168607744 08:47:35 INFO - PROCESS | 1065 | 08:50:37 INFO - PROCESS | 1065 | Cycle 1(1): loaded http://localhost:34698/tests/dromaeo/cssquery-ext.html (next: http://localhost:34698/tests/dromaeo/cssquery-jquery.html) 08:50:38 INFO - PROCESS | 1065 | RSS: Main: 165457920 08:50:38 INFO - PROCESS | 1065 | 08:53:40 INFO - PROCESS | 1065 | Cycle 1(1): loaded http://localhost:34698/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34698/tests/dromaeo/cssquery-mootools.html) 08:53:40 INFO - PROCESS | 1065 | RSS: Main: 167272448 08:53:40 INFO - PROCESS | 1065 | 08:56:42 INFO - PROCESS | 1065 | Cycle 1(1): loaded http://localhost:34698/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34698/tests/dromaeo/cssquery-prototype.html) 08:56:43 INFO - PROCESS | 1065 | RSS: Main: 164696064 08:56:43 INFO - PROCESS | 1065 | 08:59:45 INFO - PROCESS | 1065 | Cycle 1(1): loaded http://localhost:34698/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34698/tests/dromaeo/cssquery-yui.html) 08:59:46 INFO - PROCESS | 1065 | RSS: Main: 165523456 08:59:46 INFO - PROCESS | 1065 | 09:02:48 INFO - PROCESS | 1065 | Cycle 1(1): loaded http://localhost:34698/tests/dromaeo/cssquery-yui.html (next: http://localhost:34698/tests/dromaeo/cssquery-dojo.html) 09:02:48 INFO - PROCESS | 1065 | RSS: Main: 167149568 09:02:48 INFO - PROCESS | 1065 | 09:02:48 INFO - PROCESS | 1065 | __start_tp_report 09:02:48 INFO - PROCESS | 1065 | _x_x_mozilla_page_load 09:02:48 INFO - PROCESS | 1065 | _x_x_mozilla_page_load_details 09:02:48 INFO - PROCESS | 1065 | |i|pagename|runs| 09:02:48 INFO - PROCESS | 1065 | |0;dojo.html;3159.573457583226;3203.4874420092783;3213.6464988851235;3226.1289451848;3245.17248101734;5420.674759514432;5429.891402171954;5450.373207081187;5483.7532311046;5504.17437384392;5336.466353364662;5411.188321751739;5418.972905135469;5473.124300111983;5491.945080549193;4853.0779151961015;4918.336024636664;4958.305837182797;4978.452370239271;5009.9729555441045;889.8713943752306;4807.927881081787;4841.709497430148;4855.32025516428;4956.330895329139;4935.629827762932;4951.480094590071;4963.553280204781;4963.578095861856;4988;4965.180745177077;4969.82605608802;4988.251762235657;4999.150144475411;5018.071656743514;4819.397575303087;4868.196747536652;4877.0489754497885;4890.1931181355385;4912.336834527365;5366.758495867695;5371.221172929942;5433.891322173574;5438.129899216146;5454.290942177491;5683.971580142114;5755.453231943001;5906.616069955482;5915.940840591582;5937.050071988461;5803.941960580382;5809.2738407699035;5900.350961394243;5910.852228694274;5919.940800591982;5484;5496.148097045005;5502.944970550283;5504.311961004874;5512.779488820443;5832.504237139806;5965.582409231312;5969.641821490724;5991.191189189403;5999.550033747487;5772.04761214395;5813.88372232553;5818.970905145447;5823.2429784128635;5823.30120385548;5812.941870581325;5816;5839.649621022752;5843.561732870052;5848.9707551462825;5787.131930210502;5850;5869.618474799125;5896.705164741746;5937.139114828412;5759.65442073477;5796.710164491758;5826.708664566755;5839.562032847553;5843.503302219359;4291.849785257501;4363.47638283408;4377.737335759864;4392;4434.046679963823;3829.8468061277795;3896.7077469189926;3970.463987361727;3979.820908059144;4003.01926028125;5462.863428414242;5463.07127788269;5552.41699621542;5571.4150014248735;5687.4596913294;5905;5936.881262374728;5937.910931336033;5952.613080149777;5957.285125784933;5425.945740542544;5581.553475721932;5631.211630371751;5657.773689052392;5671.120976248688;4990.875228119254;5000.124978128885;5000.499950004971;5025.422076461181;5029.145045342228;6098.595953128913;6111.105587097722;6113.137324171455;6116.424137124188;6125.449118208436;5759.1937128802;5864;5913.911291330547;5917.526597872074;5973;6042.456178943916;6106.542009349406;6113.419225173601;6117.510599151969;6125.785597504066;5560;5758.510526605118;5777;5784.739686714192;5786.016377215799;5736.512396446349;5752.798652047159;5769.711514424346;5810.070388737781;5811.099279611667;5643.88712225745;5668.319801623831;5671.489565939085;5677.205191273142;5682.687452190169;5523.033469142803;5667.149927510906;5671.546276297969;5672.43275672446;5726.942730572641;5627.015272327409;5627.409122042291;5634.380218176079;5637.238972738628;5662.094064949753;5719.628224165416;5738.196652468574;5769.538436924952;5786;5790.131480277992;5471.589630777628;5645.802396916089;5673.234113394639;5679.062954612443;5689.032864413142 09:02:48 INFO - PROCESS | 1065 | |1;ext.html;603.8671492271699;653.3270731146918;663.5355251324073;671.9987219043624;689.4691087862349;34871.82564087179;36211.63788362119;36276.81861590689;36326.09184770382;36394.8180259099;36103.819480902624;36180.81909590448;36235.81882090592;36296.81851590745;36510.8174459128;8366.581670916461;8514.87227691582;8527.74416767498;8539.615717292705;8545.529995850226;8371.246587807096;8649.567521623925;8660.480371177719;8734.825303493926;8762.430442021248;8732.170443807829;8810.38327317088;8811.559422028873;8812.471251724884;8831.558422078902;8711.433756805787;8765.737027889205;8771.03518612952;8780.69267575635;8787.209151176361;8596.398252122353;8648.524331161783;8673.349498787553;8673.826523469495;8703.564821758886;31375.21561960969;35409.29181416383;36091.63908360909;36137.09657258563;36173.638263617555;3299.2411745298477;3436.398630239698;3543.94684079739;3560.359135355635;3572.1248294167835;29943.251418714488;29969.550456743167;30232.546511802342;30394.54408183879;31024.0692779217;4303.897257300818;4329.653627709776;4338.8047537860875;4378.781060946972;4390.034192477649;289467;299033;301522;301615;302366;36253.81873090671;37300.62699373026;61280.38719612747;61447.38552614506;61707.38292617106;36197;36233.45649815255;36342.818285908405;36381.63618363835;36481;12856.100072994988;13037.674058148432;13150.408231629599;13157.802632960513;13161.078724489194;10495.422751748574;10541.209409294333;10583.417912014758;10602.363858168535;10617.73455663599;8624.223819856117;8677.696280630274;8700.608472618747;8706.43408178479;8709.608067636971;3348.68187522185;3453.3956557602824;3461.1174150591437;3482.930341393158;3483.1988642611836;1013.2046343620223;1027.2039169643585;1030.2736570717625;1042.223543460127;1199.4482538032603;31106.377872442423;32054.679453205637;32263.838680806915;32462.350752984807;32985.505217421756;1072.8176210044155;1094.075506197262;1100.9559617615366;1124.4939777100337;1197.1679682620495;16524.760642951827;16791.496255112364;16840.578985525215;17298.82701172972;17484.5628859277;447700;455541;455632;459520;460504;55431.722841385534;56202.718986404805;56299.43700562942;56887.71556142275;56911.71544142253;1319.531566293971;1339.4441306857739;1347.6091933339221;1360.3742278551977;1371.9382627781774;30266.394672106875;30559;30580.694193057785;31470.685293146777;31549.684503154676;50320.49679503305;50553;50654;50949.23576146286;51085.23372149347;394444;396041;396379;397045;398005;28510.714892850807;28590.714092858805;29195.85402072976;29356.55965160567;29456.263593410335;47074.76462617665;47400.7629961848;47785.28322075241;48338.51661483481;48365.823537940174;39823;40689.38965915454;40818.97952551091;41144.17711645691;42350.788246058575;40210.597894021856;40526.392104119055;40532.3920141204;41400.58599413967;41934.580654193065;41313.79343103385;41356;42043.94890127649;42058;42416;30561.388772223985;34024;34416;34675.47986780251;34729.479057813645;27735.44529109366;27738.306542336602;28291;28294.292642684097;28318.85840570784 09:02:48 INFO - PROCESS | 1065 | |2;jquery.html;390.65622252417876;397.26307699217966;403.147343368775;405.8843229679542;412.6471866554096;13597;17187.656246875056;17403.73894391582;18014.819851801494;18040.368587099456;13314.93342533286;16168.35326586938;16854.747178792328;16965.660686786257;16974.066426346577;5251.711155886424;5323.733813309338;5353.5984801139875;5414.485623865746;5460.372057213412;5383.838484845461;5439.93921185369;5443.020256353855;5444.482774136451;5471.699056551888;5261.1056120459425;5522.530584900268;5524.723763811813;5541.889162216753;5547.278853749007;5277.525022747971;5432.972835135819;5457.263269458612;5467.45325467454;5517.282753242073;4901.583365413944;4935;4942.9258561121615;4963.3299504566785;4976.4277108132665;20701.68947465789;20996.790032099638;21415.464613384633;21755;21891.452713682287;2350.1304517328526;2360.2329242995925;2360.386299562109;2383.654370116341;2441.4506735984437;13731.862681373159;13787.310634468236;13926.094803837717;14075.366608502642;14311.570652880326;1881.9341323053627;1938.2282593086006;1952.9023548822645;1975.170428420067;2005.6991451282279;74030;75331.62334188294;75387.62306188543;75629.24370756332;75678.62160689161;9886.159676427584;10038;10295.639652612123;10377.221708371902;10392.844107338396;14015.50945716895;14129.717405652034;14210.360533776005;14213.43146274158;14244.786328205086;6354.364563543609;6844.965775171092;7252.238514955854;7252.347288744038;7408.9629551851895;6704.396604305636;6766.18805743314;6778.559393639496;6810.5913645181445;6906.689198986058;6141.201643786279;6218.81343559694;6262.467690246289;6345.777897773556;6367.172267605181;1921.6733155363622;1929.4790406590141;1944.6275543836498;1956.6282406343034;1965.1156979359346;977.7213494154132;985.6895078050392;1016.7356487313203;1022.7903279827766;1104.4036220440871;17947.461576152735;18143.27426902909;18767.624647507248;18806.811931880507;19060.809391905903;1077.186724023373;1078.4984981983416;1082.4317233452343;1097.7859317433183;1158.1198289300191;10619.575216991389;10644.148468122687;10683.198760093024;10763.677089687166;10790.73023174427;525636;537121;538884;552886;562136;77095;82933.17066829254;83194.58402707947;83356.58321708352;84185.15814841895;1025.9487025648689;1039.5374058544026;1040.079529616295;1044.8641676582147;1076.155218153761;16173.67652646964;16305.226861154617;16523;16695.582610434838;16810.159492025596;35133.82433087818;35432;35626.8218658905;36449;36592.63407365892;46324;48319.275210871165;48722.5127748718;50117.74941125271;50480.49519504905;8303.750887473385;8379.245867871921;8449.619767110371;8470.49177049379;8532.23209911111;12285.140040197459;12528.624141275777;12878.93560532229;12977.416016279101;13072.150310229805;10113.69658910234;10893.782124357627;10949.288296260718;11317.773644527228;11907.880921190677;11121.888781112086;11333.829992549954;11432.657020289405;11453.370064646524;11484.712882178012;7470.439717021354;7519.624018799148;11592.478338474957;11699.122565807429;11844.526218951145;8069.556174410463;8098.352131829557;8160.877586836321;8174.468659537111;8525.275351595184;10769.730756731144;10925.344479331265;11214;11217.495212715285;11254.549818007516 09:02:48 INFO - PROCESS | 1065 | |3;mootools.html;1507.8039854818874;1529.6175956010998;1652.9421470248535;1786.553361659585;1815.7367181758636;7187.0297509836155;8131.349492040637;8202.30280426163;8387.664493420263;8440.071592124868;8293.087760346358;8296.502209867413;8363.080061193265;8377.204165604258;8388.748337549869;2304.7349554801203;2304.7695230476984;2319.8028167605776;2335.0776443304885;2337.403961989699;2285.382946604416;2289.6794448777187;2353.4587044979667;2358.6815779869758;2367.3844800351944;2329.755375685554;2337.123578658003;2338.5790557699606;2344.6717459555675;2361.9409514762183;2266.2068276103396;2274.1812947339026;2278.715160604924;2282.7032485776826;2296.7473577906417;2230.988845055764;2244.5286489837154;2248.05581655705;2261.366817291161;2285.874276914769;8515.829683406359;8539.188777066169;8584.22741953221;8597.828043439096;8608.655653773842;5049.722265275408;5235.790568377261;5243.528082472558;5273.235380869753;5277.841664750025;3169.8098114113227;3240.238543942172;3264.39608672394;3308.3714094322004;3310.9834450827593;1022.8874823769379;1023.8771347438355;1031.0514326819343;1031.4224034540607;1036.6838114375112;11681.70795730105;11739.647810565697;11790.174687771774;11808.822867656992;11828.822567661491;4480.820767169277;4524.796384162721;4665.743384113906;4668.533146685372;4747.7626118693925;9834.360766550151;9844.556994935101;9866.062724041205;9867.210623150275;9899.505024748734;5151.845444636667;5164.8192313268855;5170.793168273302;5200.141976573898;5203.9219411708855;4156.625903668684;4587.747673877902;4696.553827386393;4712.31671407644;4719.009008108335;3809.733318667722;3811.542614886176;3854.5952674969285;3945.2109578084496;3975.045988962628;1262.1669697999275;1268.3341245846004;1274.928241607388;1276.1386064406488;1294.6375014995817;965.6282331302499;984.5372674842812;990.0693348252763;999.4403134244847;1002.7142264454595;5854.531637468992;5917.497012753965;6028.4272994065495;6032.366601506867;6113.57204995655;421.7448443691584;425.62119713455047;427.77755567105555;428.90135268887707;435.64930231163584;3953.466282051944;4160.479940007499;4161.9595101224695;4172.395002724588;4202.558731333166;9995.100440960348;10316.1747060235;10405.687829365132;10418.947905260577;10586.629467968583;10438.21713371485;10486.108680762221;10501.684949451528;10536.157107431387;10565.366078035342;7802.843943121105;7809.687612495437;7895.249951254622;7903.68385264583;7923.247291507182;5806.1000544915605;5866.413358664099;5913.970430147821;5931.1399847021075;5935.643861368331;9541.856872147062;9583.664571739955;9634.084761947604;9655.131038206595;9742.220622350336;9523.571439285388;9626.855597165908;9870.950645246729;9893.554790034323;9914.256430767577;6566.606003639797;7260.346568808833;7345.118585769528;7495.775126746206;7586.355159811478;8105.067917189599;8136.0643525995265;8141.674333026613;8146.959265203636;8166.42835001568;7066.328698773608;7295.452841037049;7314.08573928259;7381.483296169216;7408.666610002455;6926.341997510229;7012.088428504262;7240.96379518099;7356.485046046725;7478.5138965967035;6780.69486873082;6786.049953006484;6843.863122737418;6847.48643851723;6859.691313890987;4748.952510474851;4912.631552633638;4947.529984651453;4971;4987.80048798044;4914.041761856403;4931.3589233399425;4936.136176169084;4992.950070499249;5027.195648696191 09:02:48 INFO - PROCESS | 1065 | |4;prototype.html;333.56636372715474;342.0968642783053;342.7652058340037;353.625157333227;354.30202501072876;5996.760129594816;6040.8489787755325;6052.788152414666;6107.114468402085;6149.354317796634;5983.850403739909;5997.340292567814;5999.130126131719;5999.400059993998;5999.400059993998;4158.272302347093;4550.408446901898;4561.452625684922;4576.199165146103;4605.654575906804;4533.682642215046;4557.111363284161;4559.270516717326;4572.451305843303;4575.428071491064;4541.954580454203;4555.453345598533;4573.885652858688;4584.266517357223;4590.816367345302;4252.170826688797;4497.955020449786;4498.145352383037;4514;4514.480834703985;3867.7679339239453;3891.9805400972814;3904.863329783444;3915.393114067324;3915.725899187058;5630.211770352154;5710.857228569277;5722.113072473773;5741.167530708066;5748.5688573357165;5049.974750126263;5249.238860365225;5249.396319423277;5269.6311258211945;5281.207818827168;6289;6305.779297724557;6307.842303942392;6320.523711958451;6322.810315690491;4129.69027322952;4304.698671093025;4352.477702675699;4374.147041326943;4387.846425375096;6569.704363303663;6586.967065164644;6601.339866013408;6605.86788264232;6635.435987940982;4454.665900057508;4458.732476051382;4459.353393757887;4463.196624607537;4476.888077798016;4327.6105150536605;4509.751963641966;4525.185466615975;4533.591976722111;4544.840930567414;5265.789368425297;5281.339832520935;5293.364796224478;5296.1261391870685;5298.947010529922;6338.176037115146;6352.841178970562;6374.916264235091;6394.1687580614225;6444.838879027968;1538.8845836562302;1572.858442740136;1576.6373734041235;1579.6919600677988;1581.1777875504672;972.7665360313615;994.5922171909627;1020.1175982774995;1024.7489365105596;1032.5921261101823;6099.512039036955;6104.969475152596;6112.480439162632;6138.14066030756;6149.815505534841;6409.743610255631;6435.710393032325;6442.967785161044;6467.288598254282;6514.478841692748;6118.418750218722;6150.969245153746;6159.137720719103;6159.907601385983;6177.505799536027;3474.6872781449792;3496.615372309044;3504.789712617251;3507.5790905091044;3509.2630547585295;6647;6760.695768690421;6766.391024807791;6774.593524388552;6812.318768123148;6621.900671489835;6637.4026337628875;6697.866042679119;6703.765368212089;6717.630530320879;6588.769393071219;6705.178048512301;6728.529002969745;6738.191417029988;6769.72921083161;6426.293107758236;6474.482041436768;6487.708053137526;6488.610683359014;6490.578112422678;6275.184226050585;6392.328805475544;6393.488520918222;6399.264084630141;6433.839154021187;6676.365745254193;6718.496112791462;6729.73081076771;6757.358050985148;6782.220044694924;4439.977800110979;4443.266860967904;4457.465104187519;4466.731996080116;4484.68607197493;6198.969005154945;6446.454450052546;6480.319566445455;6481.319461456667;6502.154719886385;6282.1519094921605;6311.842203944938;6317.020861766434;6349.6507692077375;6360.363963603602;6079.908801368071;6215.285242197205;6264.749410023548;6272.153259309935;6281.811545653638;6015.01504503504;6114.357992410911;6190.7523699051535;6198.783042593487;6250.593711408744;6357.682115894279;6358.841028974312;6382.489400847828;6395.136656551492;6419.2938776735455;6102.633841969496;6234.563580549318;6236;6295.18162638854;6305.653189074645 09:02:48 INFO - PROCESS | 1065 | |5;yui.html;711.3882061427172;735.3969744809257;757.2049348184405;769.2000319667546;806.8749343851705;13894.096883702552;14154.858451415495;14234.928825355859;14236.217008064577;14296.928515357435;13833.515826946059;14479.276036198175;15012.174330411823;15024.699506009872;15089.924550377233;781.7967328494603;797.3860127701666;811.7767613906178;815.8286759780453;817.382875928673;813.9674413023472;817.1297568089994;818.1613845808035;819.7335865843595;822.56404105824;839.5424493650975;845.5983407881268;846.6909578004046;849.2314455417826;850.1923172985688;838.5555655502593;840.2857571064608;840.7225615546886;845.213951025546;845.7166849105557;607.6141650052249;612.2194202391942;614.6127939398151;619.1764952613058;619.1981384107592;13927.303634818218;13933.442662293495;13956.441742330295;13964.930175349058;13969.301534923214;13790.241536715477;13973.79039314411;14011.719765604732;14012.369443375073;14047.859521404758;10548.419836908966;10885.18361122919;10948.726281842937;11049.944750276198;11070.557177712883;3712.962870371289;3741.27045226181;3755.5493340799007;3779.622037796226;3915.2756740002906;52551.73724131393;52843.73578132085;53115.468845311436;53306.466935330536;53380.73309633505;10557.366558006544;10591.258611897094;10678.572857085785;10696.41169735672;10787.514561844735;17697.115144242736;17845.821541784415;17888.463346099637;17975.101244937963;18380.356687515872;7819.257170568787;7967.880481792778;8122.959385203154;8123;8505.23452889243;4683.320918466871;4715.717056976592;4788.11419887322;4875.804967801319;4886;3185.8725650974166;3233.2401885556874;3271.820049897231;3298.703116719507;3303.7687361884437;588.5644622978965;594.8483136800088;601.4797200421691;604.5163868904858;612.9080637904261;639.338284875152;650.3301599352675;677.3057615943599;685.2085840853822;707.8407358344434;8795.428297160664;8888.73333799987;8961.372703910663;9111.088891110836;9143.908560914439;581.2676028204409;665.1884700665181;680.6392611915594;692.51869950384;699.4159876503076;4070.776107314126;4094.201630682048;4095.7542547447247;4107.54816970133;4144.834206631761;59330;59472.40527594755;61098;61236;61239.69380153071;53008;53237;53809.73095134577;54120.72939635276;54666.72666636721;49907.750461248186;50139;51100.488995109576;51193;51299.717507061876;7926.286634202949;7949.3243074339325;8129.9187008129165;8252.504849709037;8288.33693304522;32754;32785.67214327922;32799.508007380384;33047;33401;41301.38047929344;44051;44228.33657495076;44456.33315500335;44568.33147502855;11332.943335283271;11364.715882103013;11392.487338069972;11498.655040348804;11681.766364672829;11560.537578497102;11607.071434285406;11694.532218711496;11724.179307448398;12161.209521381083;11663.475143618727;11712.70718232051;11755.764884702086;12129.575464858688;12231.633051008484;11588.6523404298;11608.187426880037;11640.185187036826;11838.526458941546;11851.70370740704;10708.785824283626;10734.248602597743;11158.49786759614;11185;11230.55077796879;8993.655120083456;9043.329299689558;9213.861792073258;9332.346735728705;9371.906280937103;9583.233341332816;9727.562259698188;10041.548130334006;10085.092341689284;10089.705126221246 09:02:48 INFO - PROCESS | 1065 | __end_tp_report 09:02:48 INFO - PROCESS | 1065 | __start_cc_report 09:02:48 INFO - PROCESS | 1065 | _x_x_mozilla_cycle_collect,347 09:02:48 INFO - PROCESS | 1065 | __end_cc_report 09:02:48 INFO - PROCESS | 1065 | __startTimestamp1461168168620__endTimestamp 09:02:48 INFO - PROCESS | 1065 | 09:02:48 INFO - PROCESS | 1065 | ------- Summary: start ------- 09:02:48 INFO - PROCESS | 1065 | Number of tests: 6 09:02:48 INFO - PROCESS | 1065 | 09:02:48 INFO - PROCESS | 1065 | [#0] dojo.html Cycles:165 Average:5399.47 Median:5667.15 stddev:721.38 (12.7%) stddev-sans-first:701.86 09:02:48 INFO - PROCESS | 1065 | Values: 3159.6 3203.5 3213.6 3226.1 3245.2 5420.7 5429.9 5450.4 5483.8 5504.2 5336.5 5411.2 5419.0 5473.1 5491.9 4853.1 4918.3 4958.3 4978.5 5010.0 889.9 4807.9 4841.7 4855.3 4956.3 4935.6 4951.5 4963.6 4963.6 4988.0 4965.2 4969.8 4988.3 4999.2 5018.1 4819.4 4868.2 4877.0 4890.2 4912.3 5366.8 5371.2 5433.9 5438.1 5454.3 5684.0 5755.5 5906.6 5915.9 5937.1 5803.9 5809.3 5900.4 5910.9 5919.9 5484.0 5496.1 5502.9 5504.3 5512.8 5832.5 5965.6 5969.6 5991.2 5999.6 5772.0 5813.9 5819.0 5823.2 5823.3 5812.9 5816.0 5839.6 5843.6 5849.0 5787.1 5850.0 5869.6 5896.7 5937.1 5759.7 5796.7 5826.7 5839.6 5843.5 4291.8 4363.5 4377.7 4392.0 4434.0 3829.8 3896.7 3970.5 3979.8 4003.0 5462.9 5463.1 5552.4 5571.4 5687.5 5905.0 5936.9 5937.9 5952.6 5957.3 5425.9 5581.6 5631.2 5657.8 5671.1 4990.9 5000.1 5000.5 5025.4 5029.1 6098.6 6111.1 6113.1 6116.4 6125.4 5759.2 5864.0 5913.9 5917.5 5973.0 6042.5 6106.5 6113.4 6117.5 6125.8 5560.0 5758.5 5777.0 5784.7 5786.0 5736.5 5752.8 5769.7 5810.1 5811.1 5643.9 5668.3 5671.5 5677.2 5682.7 5523.0 5667.1 5671.5 5672.4 5726.9 5627.0 5627.4 5634.4 5637.2 5662.1 5719.6 5738.2 5769.5 5786.0 5790.1 5471.6 5645.8 5673.2 5679.1 5689.0 09:02:48 INFO - PROCESS | 1065 | 09:02:48 INFO - PROCESS | 1065 | [#1] ext.html Cycles:180 Average:53251.79 Median:36334.46 stddev:103019.84 (283.5%) stddev-sans-first:103233.01 09:02:48 INFO - PROCESS | 1065 | Values: 603.9 653.3 663.5 672.0 689.5 34871.8 36211.6 36276.8 36326.1 36394.8 36103.8 36180.8 36235.8 36296.8 36510.8 8366.6 8514.9 8527.7 8539.6 8545.5 8371.2 8649.6 8660.5 8734.8 8762.4 8732.2 8810.4 8811.6 8812.5 8831.6 8711.4 8765.7 8771.0 8780.7 8787.2 8596.4 8648.5 8673.3 8673.8 8703.6 31375.2 35409.3 36091.6 36137.1 36173.6 3299.2 3436.4 3543.9 3560.4 3572.1 29943.3 29969.6 30232.5 30394.5 31024.1 4303.9 4329.7 4338.8 4378.8 4390.0 289467.0 299033.0 301522.0 301615.0 302366.0 36253.8 37300.6 61280.4 61447.4 61707.4 36197.0 36233.5 36342.8 36381.6 36481.0 12856.1 13037.7 13150.4 13157.8 13161.1 10495.4 10541.2 10583.4 10602.4 10617.7 8624.2 8677.7 8700.6 8706.4 8709.6 3348.7 3453.4 3461.1 3482.9 3483.2 1013.2 1027.2 1030.3 1042.2 1199.4 31106.4 32054.7 32263.8 32462.4 32985.5 1072.8 1094.1 1101.0 1124.5 1197.2 16524.8 16791.5 16840.6 17298.8 17484.6 447700.0 455541.0 455632.0 459520.0 460504.0 55431.7 56202.7 56299.4 56887.7 56911.7 1319.5 1339.4 1347.6 1360.4 1371.9 30266.4 30559.0 30580.7 31470.7 31549.7 50320.5 50553.0 50654.0 50949.2 51085.2 394444.0 396041.0 396379.0 397045.0 398005.0 28510.7 28590.7 29195.9 29356.6 29456.3 47074.8 47400.8 47785.3 48338.5 48365.8 39823.0 40689.4 40819.0 41144.2 42350.8 40210.6 40526.4 40532.4 41400.6 41934.6 41313.8 41356.0 42043.9 42058.0 42416.0 30561.4 34024.0 34416.0 34675.5 34729.5 27735.4 27738.3 28291.0 28294.3 28318.9 09:02:48 INFO - PROCESS | 1065 | 09:02:48 INFO - PROCESS | 1065 | [#2] jquery.html Cycles:180 Average:29253.52 Median:2355.18 stddev:89059.94 (3781.4%) stddev-sans-first:89283.41 09:02:48 INFO - PROCESS | 1065 | Values: 390.7 397.3 403.1 405.9 412.6 13597.0 17187.7 17403.7 18014.8 18040.4 13314.9 16168.4 16854.7 16965.7 16974.1 5251.7 5323.7 5353.6 5414.5 5460.4 5383.8 5439.9 5443.0 5444.5 5471.7 5261.1 5522.5 5524.7 5541.9 5547.3 5277.5 5433.0 5457.3 5467.5 5517.3 4901.6 4935.0 4942.9 4963.3 4976.4 20701.7 20996.8 21415.5 21755.0 21891.5 2350.1 2360.2 2360.4 2383.7 2441.5 13731.9 13787.3 13926.1 14075.4 14311.6 1881.9 1938.2 1952.9 1975.2 2005.7 74030.0 75331.6 75387.6 75629.2 75678.6 9886.2 10038.0 10295.6 10377.2 10392.8 14015.5 14129.7 14210.4 14213.4 14244.8 6354.4 6845.0 7252.2 7252.3 7409.0 6704.4 6766.2 6778.6 6810.6 6906.7 6141.2 6218.8 6262.5 6345.8 6367.2 1921.7 1929.5 1944.6 1956.6 1965.1 977.7 985.7 1016.7 1022.8 1104.4 17947.5 18143.3 18767.6 18806.8 19060.8 1077.2 1078.5 1082.4 1097.8 1158.1 10619.6 10644.1 10683.2 10763.7 10790.7 525636.0 537121.0 538884.0 552886.0 562136.0 77095.0 82933.2 83194.6 83356.6 84185.2 1025.9 1039.5 1040.1 1044.9 1076.2 16173.7 16305.2 16523.0 16695.6 16810.2 35133.8 35432.0 35626.8 36449.0 36592.6 46324.0 48319.3 48722.5 50117.7 50480.5 8303.8 8379.2 8449.6 8470.5 8532.2 12285.1 12528.6 12878.9 12977.4 13072.2 10113.7 10893.8 10949.3 11317.8 11907.9 11121.9 11333.8 11432.7 11453.4 11484.7 7470.4 7519.6 11592.5 11699.1 11844.5 8069.6 8098.4 8160.9 8174.5 8525.3 10769.7 10925.3 11214.0 11217.5 11254.5 09:02:48 INFO - PROCESS | 1065 | 09:02:48 INFO - PROCESS | 1065 | [#3] mootools.html Cycles:180 Average:5582.05 Median:4959.26 stddev:3136.41 (63.2%) stddev-sans-first:3130.27 09:02:48 INFO - PROCESS | 1065 | Values: 1507.8 1529.6 1652.9 1786.6 1815.7 7187.0 8131.3 8202.3 8387.7 8440.1 8293.1 8296.5 8363.1 8377.2 8388.7 2304.7 2304.8 2319.8 2335.1 2337.4 2285.4 2289.7 2353.5 2358.7 2367.4 2329.8 2337.1 2338.6 2344.7 2361.9 2266.2 2274.2 2278.7 2282.7 2296.7 2231.0 2244.5 2248.1 2261.4 2285.9 8515.8 8539.2 8584.2 8597.8 8608.7 5049.7 5235.8 5243.5 5273.2 5277.8 3169.8 3240.2 3264.4 3308.4 3311.0 1022.9 1023.9 1031.1 1031.4 1036.7 11681.7 11739.6 11790.2 11808.8 11828.8 4480.8 4524.8 4665.7 4668.5 4747.8 9834.4 9844.6 9866.1 9867.2 9899.5 5151.8 5164.8 5170.8 5200.1 5203.9 4156.6 4587.7 4696.6 4712.3 4719.0 3809.7 3811.5 3854.6 3945.2 3975.0 1262.2 1268.3 1274.9 1276.1 1294.6 965.6 984.5 990.1 999.4 1002.7 5854.5 5917.5 6028.4 6032.4 6113.6 421.7 425.6 427.8 428.9 435.6 3953.5 4160.5 4162.0 4172.4 4202.6 9995.1 10316.2 10405.7 10418.9 10586.6 10438.2 10486.1 10501.7 10536.2 10565.4 7802.8 7809.7 7895.2 7903.7 7923.2 5806.1 5866.4 5914.0 5931.1 5935.6 9541.9 9583.7 9634.1 9655.1 9742.2 9523.6 9626.9 9871.0 9893.6 9914.3 6566.6 7260.3 7345.1 7495.8 7586.4 8105.1 8136.1 8141.7 8147.0 8166.4 7066.3 7295.5 7314.1 7381.5 7408.7 6926.3 7012.1 7241.0 7356.5 7478.5 6780.7 6786.0 6843.9 6847.5 6859.7 4749.0 4912.6 4947.5 4971.0 4987.8 4914.0 4931.4 4936.1 4993.0 5027.2 09:02:48 INFO - PROCESS | 1065 | 09:02:48 INFO - PROCESS | 1065 | [#4] prototype.html Cycles:180 Average:5274.33 Median:6106.04 stddev:1603.47 (26.3%) stddev-sans-first:1564.50 09:02:48 INFO - PROCESS | 1065 | Values: 333.6 342.1 342.8 353.6 354.3 5996.8 6040.8 6052.8 6107.1 6149.4 5983.9 5997.3 5999.1 5999.4 5999.4 4158.3 4550.4 4561.5 4576.2 4605.7 4533.7 4557.1 4559.3 4572.5 4575.4 4542.0 4555.5 4573.9 4584.3 4590.8 4252.2 4498.0 4498.1 4514.0 4514.5 3867.8 3892.0 3904.9 3915.4 3915.7 5630.2 5710.9 5722.1 5741.2 5748.6 5050.0 5249.2 5249.4 5269.6 5281.2 6289.0 6305.8 6307.8 6320.5 6322.8 4129.7 4304.7 4352.5 4374.1 4387.8 6569.7 6587.0 6601.3 6605.9 6635.4 4454.7 4458.7 4459.4 4463.2 4476.9 4327.6 4509.8 4525.2 4533.6 4544.8 5265.8 5281.3 5293.4 5296.1 5298.9 6338.2 6352.8 6374.9 6394.2 6444.8 1538.9 1572.9 1576.6 1579.7 1581.2 972.8 994.6 1020.1 1024.7 1032.6 6099.5 6105.0 6112.5 6138.1 6149.8 6409.7 6435.7 6443.0 6467.3 6514.5 6118.4 6151.0 6159.1 6159.9 6177.5 3474.7 3496.6 3504.8 3507.6 3509.3 6647.0 6760.7 6766.4 6774.6 6812.3 6621.9 6637.4 6697.9 6703.8 6717.6 6588.8 6705.2 6728.5 6738.2 6769.7 6426.3 6474.5 6487.7 6488.6 6490.6 6275.2 6392.3 6393.5 6399.3 6433.8 6676.4 6718.5 6729.7 6757.4 6782.2 4440.0 4443.3 4457.5 4466.7 4484.7 6199.0 6446.5 6480.3 6481.3 6502.2 6282.2 6311.8 6317.0 6349.7 6360.4 6079.9 6215.3 6264.7 6272.2 6281.8 6015.0 6114.4 6190.8 6198.8 6250.6 6357.7 6358.8 6382.5 6395.1 6419.3 6102.6 6234.6 6236.0 6295.2 6305.7 09:02:48 INFO - PROCESS | 1065 | 09:02:48 INFO - PROCESS | 1065 | [#5] yui.html Cycles:180 Average:14323.16 Median:4831.96 stddev:16750.86 (346.7%) stddev-sans-first:16766.66 09:02:48 INFO - PROCESS | 1065 | Values: 711.4 735.4 757.2 769.2 806.9 13894.1 14154.9 14234.9 14236.2 14296.9 13833.5 14479.3 15012.2 15024.7 15089.9 781.8 797.4 811.8 815.8 817.4 814.0 817.1 818.2 819.7 822.6 839.5 845.6 846.7 849.2 850.2 838.6 840.3 840.7 845.2 845.7 607.6 612.2 614.6 619.2 619.2 13927.3 13933.4 13956.4 13964.9 13969.3 13790.2 13973.8 14011.7 14012.4 14047.9 10548.4 10885.2 10948.7 11049.9 11070.6 3713.0 3741.3 3755.5 3779.6 3915.3 52551.7 52843.7 53115.5 53306.5 53380.7 10557.4 10591.3 10678.6 10696.4 10787.5 17697.1 17845.8 17888.5 17975.1 18380.4 7819.3 7967.9 8123.0 8123.0 8505.2 4683.3 4715.7 4788.1 4875.8 4886.0 3185.9 3233.2 3271.8 3298.7 3303.8 588.6 594.8 601.5 604.5 612.9 639.3 650.3 677.3 685.2 707.8 8795.4 8888.7 8961.4 9111.1 9143.9 581.3 665.2 680.6 692.5 699.4 4070.8 4094.2 4095.8 4107.5 4144.8 59330.0 59472.4 61098.0 61236.0 61239.7 53008.0 53237.0 53809.7 54120.7 54666.7 49907.8 50139.0 51100.5 51193.0 51299.7 7926.3 7949.3 8129.9 8252.5 8288.3 32754.0 32785.7 32799.5 33047.0 33401.0 41301.4 44051.0 44228.3 44456.3 44568.3 11332.9 11364.7 11392.5 11498.7 11681.8 11560.5 11607.1 11694.5 11724.2 12161.2 11663.5 11712.7 11755.8 12129.6 12231.6 11588.7 11608.2 11640.2 11838.5 11851.7 10708.8 10734.2 11158.5 11185.0 11230.6 8993.7 9043.3 9213.9 9332.3 9371.9 9583.2 9727.6 10041.5 10085.1 10089.7 09:02:48 INFO - PROCESS | 1065 | -------- Summary: end -------- 09:02:48 INFO - PROCESS | 1065 | 09:02:49 INFO - TEST-INFO | 1065: exit 0 09:02:49 INFO - TEST-OK | dromaeo_css | took 1110030ms 09:02:49 INFO - TEST-START | kraken 09:02:49 INFO - operating with platform_type : linux_ 09:02:49 INFO - Initialising browser for kraken test... 09:02:49 INFO - TEST-INFO | started process 1377 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXDSvC2/profile http://localhost:34698/getInfo.html) 09:02:52 INFO - PROCESS | 1377 | 09:02:52 INFO - PROCESS | 1377 | (process:1446): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:02:53 INFO - PROCESS | 1377 | __metrics Screen width/height:1600/1200 09:02:53 INFO - PROCESS | 1377 | colorDepth:24 09:02:53 INFO - PROCESS | 1377 | Browser inner width/height: 1024/697 09:02:53 INFO - PROCESS | 1377 | __metrics 09:02:54 ERROR - PROCESS | 1377 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 09:02:55 INFO - TEST-INFO | 1377: exit 0 09:02:55 INFO - Browser initialized. 09:02:55 INFO - Running cycle 1/1 for kraken test... 09:02:55 INFO - TEST-INFO | started process 1498 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXDSvC2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:02:56 INFO - PROCESS | 1498 | 09:02:56 INFO - PROCESS | 1498 | (process:1558): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:03:06 INFO - PROCESS | 1498 | RSS: Main: 163467264 09:03:06 INFO - PROCESS | 1498 | 09:03:09 INFO - PROCESS | 1498 | Cycle 1(1): loaded http://localhost:34698/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34698/tests/kraken/driver.html?testName=audio-beat-detection) 09:03:10 INFO - PROCESS | 1498 | RSS: Main: 168042496 09:03:10 INFO - PROCESS | 1498 | 09:03:12 INFO - PROCESS | 1498 | Cycle 1(1): loaded http://localhost:34698/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34698/tests/kraken/driver.html?testName=audio-dft) 09:03:13 INFO - PROCESS | 1498 | RSS: Main: 171167744 09:03:13 INFO - PROCESS | 1498 | 09:03:16 INFO - PROCESS | 1498 | Cycle 1(1): loaded http://localhost:34698/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34698/tests/kraken/driver.html?testName=audio-fft) 09:03:17 INFO - PROCESS | 1498 | RSS: Main: 161939456 09:03:17 INFO - PROCESS | 1498 | 09:03:19 INFO - PROCESS | 1498 | Cycle 1(1): loaded http://localhost:34698/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34698/tests/kraken/driver.html?testName=audio-oscillator) 09:03:19 INFO - PROCESS | 1498 | RSS: Main: 161693696 09:03:19 INFO - PROCESS | 1498 | 09:03:22 INFO - PROCESS | 1498 | Cycle 1(1): loaded http://localhost:34698/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34698/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:03:22 INFO - PROCESS | 1498 | RSS: Main: 163074048 09:03:22 INFO - PROCESS | 1498 | 09:03:25 INFO - PROCESS | 1498 | Cycle 1(1): loaded http://localhost:34698/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34698/tests/kraken/driver.html?testName=imaging-darkroom) 09:03:26 INFO - PROCESS | 1498 | RSS: Main: 163627008 09:03:26 INFO - PROCESS | 1498 | 09:03:29 INFO - PROCESS | 1498 | Cycle 1(1): loaded http://localhost:34698/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34698/tests/kraken/driver.html?testName=imaging-desaturate) 09:03:30 INFO - PROCESS | 1498 | RSS: Main: 163459072 09:03:30 INFO - PROCESS | 1498 | 09:03:33 INFO - PROCESS | 1498 | Cycle 1(1): loaded http://localhost:34698/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34698/tests/kraken/driver.html?testName=json-parse-financial) 09:03:33 INFO - PROCESS | 1498 | RSS: Main: 164597760 09:03:33 INFO - PROCESS | 1498 | 09:03:35 INFO - PROCESS | 1498 | Cycle 1(1): loaded http://localhost:34698/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34698/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:03:36 INFO - PROCESS | 1498 | RSS: Main: 164343808 09:03:36 INFO - PROCESS | 1498 | 09:03:37 INFO - PROCESS | 1498 | Cycle 1(1): loaded http://localhost:34698/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34698/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:03:38 INFO - PROCESS | 1498 | RSS: Main: 164167680 09:03:38 INFO - PROCESS | 1498 | 09:03:40 INFO - PROCESS | 1498 | Cycle 1(1): loaded http://localhost:34698/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34698/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:03:41 INFO - PROCESS | 1498 | RSS: Main: 164532224 09:03:41 INFO - PROCESS | 1498 | 09:03:43 INFO - PROCESS | 1498 | Cycle 1(1): loaded http://localhost:34698/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34698/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:03:44 INFO - PROCESS | 1498 | RSS: Main: 165146624 09:03:44 INFO - PROCESS | 1498 | 09:03:47 INFO - PROCESS | 1498 | Cycle 1(1): loaded http://localhost:34698/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34698/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:03:48 INFO - PROCESS | 1498 | RSS: Main: 165208064 09:03:48 INFO - PROCESS | 1498 | 09:03:49 INFO - PROCESS | 1498 | Cycle 1(1): loaded http://localhost:34698/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34698/tests/kraken/driver.html?testName=ai-astar) 09:03:49 INFO - PROCESS | 1498 | RSS: Main: 166629376 09:03:49 INFO - PROCESS | 1498 | 09:03:49 INFO - PROCESS | 1498 | __start_tp_report 09:03:49 INFO - PROCESS | 1498 | _x_x_mozilla_page_load 09:03:49 INFO - PROCESS | 1498 | _x_x_mozilla_page_load_details 09:03:49 INFO - PROCESS | 1498 | |i|pagename|runs| 09:03:49 INFO - PROCESS | 1498 | |0;ai-astar;113;107;113;111;113;124;115;112;114;113 09:03:49 INFO - PROCESS | 1498 | |1;audio-beat-detection;155;129;156;182;131;154;153;130;194;128 09:03:49 INFO - PROCESS | 1498 | |2;audio-dft;162;162;162;163;162;164;166;168;166;163 09:03:49 INFO - PROCESS | 1498 | |3;audio-fft;73;75;77;152;78;73;73;77;163;77 09:03:49 INFO - PROCESS | 1498 | |4;audio-oscillator;93;93;158;93;95;93;155;93;93;141 09:03:49 INFO - PROCESS | 1498 | |5;imaging-gaussian-blur;118;118;117;117;117;118;118;119;118;120 09:03:49 INFO - PROCESS | 1498 | |6;imaging-darkroom;147;147;146;146;147;147;146;147;147;148 09:03:49 INFO - PROCESS | 1498 | |7;imaging-desaturate;96;96;95;96;95;95;95;95;95;95 09:03:49 INFO - PROCESS | 1498 | |8;json-parse-financial;60;60;61;62;60;59;60;76;60;57 09:03:49 INFO - PROCESS | 1498 | |9;json-stringify-tinderbox;62;62;62;61;63;62;61;63;62;62 09:03:49 INFO - PROCESS | 1498 | |10;stanford-crypto-aes;78;76;76;77;78;80;77;80;78;80 09:03:49 INFO - PROCESS | 1498 | |11;stanford-crypto-ccm;128;134;127;131;125;128;136;135;162;135 09:03:49 INFO - PROCESS | 1498 | |12;stanford-crypto-pbkdf2;168;166;169;170;179;169;169;174;168;168 09:03:49 INFO - PROCESS | 1498 | |13;stanford-crypto-sha256-iterative;71;69;68;68;70;69;80;69;67;67 09:03:49 INFO - PROCESS | 1498 | __end_tp_report 09:03:49 INFO - PROCESS | 1498 | __start_cc_report 09:03:49 INFO - PROCESS | 1498 | _x_x_mozilla_cycle_collect,875 09:03:49 INFO - PROCESS | 1498 | __end_cc_report 09:03:49 INFO - PROCESS | 1498 | __startTimestamp1461168229971__endTimestamp 09:03:49 INFO - PROCESS | 1498 | 09:03:49 INFO - PROCESS | 1498 | ------- Summary: start ------- 09:03:49 INFO - PROCESS | 1498 | Number of tests: 14 09:03:49 INFO - PROCESS | 1498 | 09:03:49 INFO - PROCESS | 1498 | [#0] ai-astar Cycles:10 Average:113.50 Median:113.00 stddev:4.28 (3.8%) stddev-sans-first:4.53 09:03:49 INFO - PROCESS | 1498 | Values: 113.0 107.0 113.0 111.0 113.0 124.0 115.0 112.0 114.0 113.0 09:03:49 INFO - PROCESS | 1498 | 09:03:49 INFO - PROCESS | 1498 | [#1] audio-beat-detection Cycles:10 Average:151.20 Median:154.50 stddev:22.89 (14.8%) stddev-sans-first:24.24 09:03:49 INFO - PROCESS | 1498 | Values: 155.0 129.0 156.0 182.0 131.0 154.0 153.0 130.0 194.0 128.0 09:03:49 INFO - PROCESS | 1498 | 09:03:49 INFO - PROCESS | 1498 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.50 stddev:2.15 (1.3%) stddev-sans-first:2.18 09:03:49 INFO - PROCESS | 1498 | Values: 162.0 162.0 162.0 163.0 162.0 164.0 166.0 168.0 166.0 163.0 09:03:49 INFO - PROCESS | 1498 | 09:03:49 INFO - PROCESS | 1498 | [#3] audio-fft Cycles:10 Average:91.80 Median:76.00 stddev:34.77 (45.8%) stddev-sans-first:36.21 09:03:49 INFO - PROCESS | 1498 | Values: 73.0 75.0 77.0 152.0 78.0 73.0 73.0 77.0 163.0 77.0 09:03:49 INFO - PROCESS | 1498 | 09:03:49 INFO - PROCESS | 1498 | [#4] audio-oscillator Cycles:10 Average:110.70 Median:93.00 stddev:28.37 (30.5%) stddev-sans-first:29.36 09:03:49 INFO - PROCESS | 1498 | Values: 93.0 93.0 158.0 93.0 95.0 93.0 155.0 93.0 93.0 141.0 09:03:49 INFO - PROCESS | 1498 | 09:03:49 INFO - PROCESS | 1498 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.94 (0.8%) stddev-sans-first:1.00 09:03:49 INFO - PROCESS | 1498 | Values: 118.0 118.0 117.0 117.0 117.0 118.0 118.0 119.0 118.0 120.0 09:03:49 INFO - PROCESS | 1498 | 09:03:49 INFO - PROCESS | 1498 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 09:03:49 INFO - PROCESS | 1498 | Values: 147.0 147.0 146.0 146.0 147.0 147.0 146.0 147.0 147.0 148.0 09:03:49 INFO - PROCESS | 1498 | 09:03:49 INFO - PROCESS | 1498 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 09:03:49 INFO - PROCESS | 1498 | Values: 96.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 09:03:49 INFO - PROCESS | 1498 | 09:03:49 INFO - PROCESS | 1498 | [#8] json-parse-financial Cycles:10 Average:61.50 Median:60.00 stddev:5.25 (8.8%) stddev-sans-first:5.55 09:03:49 INFO - PROCESS | 1498 | Values: 60.0 60.0 61.0 62.0 60.0 59.0 60.0 76.0 60.0 57.0 09:03:49 INFO - PROCESS | 1498 | 09:03:49 INFO - PROCESS | 1498 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 09:03:49 INFO - PROCESS | 1498 | Values: 62.0 62.0 62.0 61.0 63.0 62.0 61.0 63.0 62.0 62.0 09:03:49 INFO - PROCESS | 1498 | 09:03:49 INFO - PROCESS | 1498 | [#10] stanford-crypto-aes Cycles:10 Average:78.00 Median:78.00 stddev:1.56 (2.0%) stddev-sans-first:1.66 09:03:49 INFO - PROCESS | 1498 | Values: 78.0 76.0 76.0 77.0 78.0 80.0 77.0 80.0 78.0 80.0 09:03:49 INFO - PROCESS | 1498 | 09:03:49 INFO - PROCESS | 1498 | [#11] stanford-crypto-ccm Cycles:10 Average:134.10 Median:134.50 stddev:10.55 (7.8%) stddev-sans-first:10.95 09:03:49 INFO - PROCESS | 1498 | Values: 128.0 134.0 127.0 131.0 125.0 128.0 136.0 135.0 162.0 135.0 09:03:49 INFO - PROCESS | 1498 | 09:03:49 INFO - PROCESS | 1498 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.00 Median:169.00 stddev:3.77 (2.2%) stddev-sans-first:3.93 09:03:49 INFO - PROCESS | 1498 | Values: 168.0 166.0 169.0 170.0 179.0 169.0 169.0 174.0 168.0 168.0 09:03:49 INFO - PROCESS | 1498 | 09:03:49 INFO - PROCESS | 1498 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:69.00 stddev:3.79 (5.5%) stddev-sans-first:4.00 09:03:49 INFO - PROCESS | 1498 | Values: 71.0 69.0 68.0 68.0 70.0 69.0 80.0 69.0 67.0 67.0 09:03:49 INFO - PROCESS | 1498 | -------- Summary: end -------- 09:03:49 INFO - PROCESS | 1498 | 09:03:50 INFO - TEST-INFO | 1498: exit 0 09:03:50 INFO - TEST-OK | kraken | took 61629ms 09:03:50 INFO - SUITE-END | took 1171s 09:03:51 INFO - Completed test suite (00:19:31) 09:03:51 INFO - javascript benchmark 09:03:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3159.573457583226, 3203.4874420092783, 3213.6464988851235, 3226.1289451848, 3245.17248101734, 5420.674759514432, 5429.891402171954, 5450.373207081187, 5483.7532311046, 5504.17437384392, 5336.466353364662, 5411.188321751739, 5418.972905135469, 5473.124300111983, 5491.945080549193, 4853.0779151961015, 4918.336024636664, 4958.305837182797, 4978.452370239271, 5009.9729555441045, 889.8713943752306, 4807.927881081787, 4841.709497430148, 4855.32025516428, 4956.330895329139, 4935.629827762932, 4951.480094590071, 4963.553280204781, 4963.578095861856, 4988.0, 4965.180745177077, 4969.82605608802, 4988.251762235657, 4999.150144475411, 5018.071656743514, 4819.397575303087, 4868.196747536652, 4877.0489754497885, 4890.1931181355385, 4912.336834527365, 5366.758495867695, 5371.221172929942, 5433.891322173574, 5438.129899216146, 5454.290942177491, 5683.971580142114, 5755.453231943001, 5906.616069955482, 5915.940840591582, 5937.050071988461, 5803.941960580382, 5809.2738407699035, 5900.350961394243, 5910.852228694274, 5919.940800591982, 5484.0, 5496.148097045005, 5502.944970550283, 5504.311961004874, 5512.779488820443, 5832.504237139806, 5965.582409231312, 5969.641821490724, 5991.191189189403, 5999.550033747487, 5772.04761214395, 5813.88372232553, 5818.970905145447, 5823.2429784128635, 5823.30120385548, 5812.941870581325, 5816.0, 5839.649621022752, 5843.561732870052, 5848.9707551462825, 5787.131930210502, 5850.0, 5869.618474799125, 5896.705164741746, 5937.139114828412, 5759.65442073477, 5796.710164491758, 5826.708664566755, 5839.562032847553, 5843.503302219359, 4291.849785257501, 4363.47638283408, 4377.737335759864, 4392.0, 4434.046679963823, 3829.8468061277795, 3896.7077469189926, 3970.463987361727, 3979.820908059144, 4003.01926028125, 5462.863428414242, 5463.07127788269, 5552.41699621542, 5571.4150014248735, 5687.4596913294, 5905.0, 5936.881262374728, 5937.910931336033, 5952.613080149777, 5957.285125784933, 5425.945740542544, 5581.553475721932, 5631.211630371751, 5657.773689052392, 5671.120976248688, 4990.875228119254, 5000.124978128885, 5000.499950004971, 5025.422076461181, 5029.145045342228, 6098.595953128913, 6111.105587097722, 6113.137324171455, 6116.424137124188, 6125.449118208436, 5759.1937128802, 5864.0, 5913.911291330547, 5917.526597872074, 5973.0, 6042.456178943916, 6106.542009349406, 6113.419225173601, 6117.510599151969, 6125.785597504066, 5560.0, 5758.510526605118, 5777.0, 5784.739686714192, 5786.016377215799, 5736.512396446349, 5752.798652047159, 5769.711514424346, 5810.070388737781, 5811.099279611667, 5643.88712225745, 5668.319801623831, 5671.489565939085, 5677.205191273142, 5682.687452190169, 5523.033469142803, 5667.149927510906, 5671.546276297969, 5672.43275672446, 5726.942730572641, 5627.015272327409, 5627.409122042291, 5634.380218176079, 5637.238972738628, 5662.094064949753, 5719.628224165416, 5738.196652468574, 5769.538436924952, 5786.0, 5790.131480277992, 5471.589630777628, 5645.802396916089, 5673.234113394639, 5679.062954612443, 5689.032864413142], "value": 5351.46064645191, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.8671492271699, 653.3270731146918, 663.5355251324073, 671.9987219043624, 689.4691087862349, 34871.82564087179, 36211.63788362119, 36276.81861590689, 36326.09184770382, 36394.8180259099, 36103.819480902624, 36180.81909590448, 36235.81882090592, 36296.81851590745, 36510.8174459128, 8366.581670916461, 8514.87227691582, 8527.74416767498, 8539.615717292705, 8545.529995850226, 8371.246587807096, 8649.567521623925, 8660.480371177719, 8734.825303493926, 8762.430442021248, 8732.170443807829, 8810.38327317088, 8811.559422028873, 8812.471251724884, 8831.558422078902, 8711.433756805787, 8765.737027889205, 8771.03518612952, 8780.69267575635, 8787.209151176361, 8596.398252122353, 8648.524331161783, 8673.349498787553, 8673.826523469495, 8703.564821758886, 31375.21561960969, 35409.29181416383, 36091.63908360909, 36137.09657258563, 36173.638263617555, 3299.2411745298477, 3436.398630239698, 3543.94684079739, 3560.359135355635, 3572.1248294167835, 29943.251418714488, 29969.550456743167, 30232.546511802342, 30394.54408183879, 31024.0692779217, 4303.897257300818, 4329.653627709776, 4338.8047537860875, 4378.781060946972, 4390.034192477649, 289467.0, 299033.0, 301522.0, 301615.0, 302366.0, 36253.81873090671, 37300.62699373026, 61280.38719612747, 61447.38552614506, 61707.38292617106, 36197.0, 36233.45649815255, 36342.818285908405, 36381.63618363835, 36481.0, 12856.100072994988, 13037.674058148432, 13150.408231629599, 13157.802632960513, 13161.078724489194, 10495.422751748574, 10541.209409294333, 10583.417912014758, 10602.363858168535, 10617.73455663599, 8624.223819856117, 8677.696280630274, 8700.608472618747, 8706.43408178479, 8709.608067636971, 3348.68187522185, 3453.3956557602824, 3461.1174150591437, 3482.930341393158, 3483.1988642611836, 1013.2046343620223, 1027.2039169643585, 1030.2736570717625, 1042.223543460127, 1199.4482538032603, 31106.377872442423, 32054.679453205637, 32263.838680806915, 32462.350752984807, 32985.505217421756, 1072.8176210044155, 1094.075506197262, 1100.9559617615366, 1124.4939777100337, 1197.1679682620495, 16524.760642951827, 16791.496255112364, 16840.578985525215, 17298.82701172972, 17484.5628859277, 447700.0, 455541.0, 455632.0, 459520.0, 460504.0, 55431.722841385534, 56202.718986404805, 56299.43700562942, 56887.71556142275, 56911.71544142253, 1319.531566293971, 1339.4441306857739, 1347.6091933339221, 1360.3742278551977, 1371.9382627781774, 30266.394672106875, 30559.0, 30580.694193057785, 31470.685293146777, 31549.684503154676, 50320.49679503305, 50553.0, 50654.0, 50949.23576146286, 51085.23372149347, 394444.0, 396041.0, 396379.0, 397045.0, 398005.0, 28510.714892850807, 28590.714092858805, 29195.85402072976, 29356.55965160567, 29456.263593410335, 47074.76462617665, 47400.7629961848, 47785.28322075241, 48338.51661483481, 48365.823537940174, 39823.0, 40689.38965915454, 40818.97952551091, 41144.17711645691, 42350.788246058575, 40210.597894021856, 40526.392104119055, 40532.3920141204, 41400.58599413967, 41934.580654193065, 41313.79343103385, 41356.0, 42043.94890127649, 42058.0, 42416.0, 30561.388772223985, 34024.0, 34416.0, 34675.47986780251, 34729.479057813645, 27735.44529109366, 27738.306542336602, 28291.0, 28294.292642684097, 28318.85840570784], "value": 18132.658411036486, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.65622252417876, 397.26307699217966, 403.147343368775, 405.8843229679542, 412.6471866554096, 13597.0, 17187.656246875056, 17403.73894391582, 18014.819851801494, 18040.368587099456, 13314.93342533286, 16168.35326586938, 16854.747178792328, 16965.660686786257, 16974.066426346577, 5251.711155886424, 5323.733813309338, 5353.5984801139875, 5414.485623865746, 5460.372057213412, 5383.838484845461, 5439.93921185369, 5443.020256353855, 5444.482774136451, 5471.699056551888, 5261.1056120459425, 5522.530584900268, 5524.723763811813, 5541.889162216753, 5547.278853749007, 5277.525022747971, 5432.972835135819, 5457.263269458612, 5467.45325467454, 5517.282753242073, 4901.583365413944, 4935.0, 4942.9258561121615, 4963.3299504566785, 4976.4277108132665, 20701.68947465789, 20996.790032099638, 21415.464613384633, 21755.0, 21891.452713682287, 2350.1304517328526, 2360.2329242995925, 2360.386299562109, 2383.654370116341, 2441.4506735984437, 13731.862681373159, 13787.310634468236, 13926.094803837717, 14075.366608502642, 14311.570652880326, 1881.9341323053627, 1938.2282593086006, 1952.9023548822645, 1975.170428420067, 2005.6991451282279, 74030.0, 75331.62334188294, 75387.62306188543, 75629.24370756332, 75678.62160689161, 9886.159676427584, 10038.0, 10295.639652612123, 10377.221708371902, 10392.844107338396, 14015.50945716895, 14129.717405652034, 14210.360533776005, 14213.43146274158, 14244.786328205086, 6354.364563543609, 6844.965775171092, 7252.238514955854, 7252.347288744038, 7408.9629551851895, 6704.396604305636, 6766.18805743314, 6778.559393639496, 6810.5913645181445, 6906.689198986058, 6141.201643786279, 6218.81343559694, 6262.467690246289, 6345.777897773556, 6367.172267605181, 1921.6733155363622, 1929.4790406590141, 1944.6275543836498, 1956.6282406343034, 1965.1156979359346, 977.7213494154132, 985.6895078050392, 1016.7356487313203, 1022.7903279827766, 1104.4036220440871, 17947.461576152735, 18143.27426902909, 18767.624647507248, 18806.811931880507, 19060.809391905903, 1077.186724023373, 1078.4984981983416, 1082.4317233452343, 1097.7859317433183, 1158.1198289300191, 10619.575216991389, 10644.148468122687, 10683.198760093024, 10763.677089687166, 10790.73023174427, 525636.0, 537121.0, 538884.0, 552886.0, 562136.0, 77095.0, 82933.17066829254, 83194.58402707947, 83356.58321708352, 84185.15814841895, 1025.9487025648689, 1039.5374058544026, 1040.079529616295, 1044.8641676582147, 1076.155218153761, 16173.67652646964, 16305.226861154617, 16523.0, 16695.582610434838, 16810.159492025596, 35133.82433087818, 35432.0, 35626.8218658905, 36449.0, 36592.63407365892, 46324.0, 48319.275210871165, 48722.5127748718, 50117.74941125271, 50480.49519504905, 8303.750887473385, 8379.245867871921, 8449.619767110371, 8470.49177049379, 8532.23209911111, 12285.140040197459, 12528.624141275777, 12878.93560532229, 12977.416016279101, 13072.150310229805, 10113.69658910234, 10893.782124357627, 10949.288296260718, 11317.773644527228, 11907.880921190677, 11121.888781112086, 11333.829992549954, 11432.657020289405, 11453.370064646524, 11484.712882178012, 7470.439717021354, 7519.624018799148, 11592.478338474957, 11699.122565807429, 11844.526218951145, 8069.556174410463, 8098.352131829557, 8160.877586836321, 8174.468659537111, 8525.275351595184, 10769.730756731144, 10925.344479331265, 11214.0, 11217.495212715285, 11254.549818007516], "value": 8900.229314951837, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1507.8039854818874, 1529.6175956010998, 1652.9421470248535, 1786.553361659585, 1815.7367181758636, 7187.0297509836155, 8131.349492040637, 8202.30280426163, 8387.664493420263, 8440.071592124868, 8293.087760346358, 8296.502209867413, 8363.080061193265, 8377.204165604258, 8388.748337549869, 2304.7349554801203, 2304.7695230476984, 2319.8028167605776, 2335.0776443304885, 2337.403961989699, 2285.382946604416, 2289.6794448777187, 2353.4587044979667, 2358.6815779869758, 2367.3844800351944, 2329.755375685554, 2337.123578658003, 2338.5790557699606, 2344.6717459555675, 2361.9409514762183, 2266.2068276103396, 2274.1812947339026, 2278.715160604924, 2282.7032485776826, 2296.7473577906417, 2230.988845055764, 2244.5286489837154, 2248.05581655705, 2261.366817291161, 2285.874276914769, 8515.829683406359, 8539.188777066169, 8584.22741953221, 8597.828043439096, 8608.655653773842, 5049.722265275408, 5235.790568377261, 5243.528082472558, 5273.235380869753, 5277.841664750025, 3169.8098114113227, 3240.238543942172, 3264.39608672394, 3308.3714094322004, 3310.9834450827593, 1022.8874823769379, 1023.8771347438355, 1031.0514326819343, 1031.4224034540607, 1036.6838114375112, 11681.70795730105, 11739.647810565697, 11790.174687771774, 11808.822867656992, 11828.822567661491, 4480.820767169277, 4524.796384162721, 4665.743384113906, 4668.533146685372, 4747.7626118693925, 9834.360766550151, 9844.556994935101, 9866.062724041205, 9867.210623150275, 9899.505024748734, 5151.845444636667, 5164.8192313268855, 5170.793168273302, 5200.141976573898, 5203.9219411708855, 4156.625903668684, 4587.747673877902, 4696.553827386393, 4712.31671407644, 4719.009008108335, 3809.733318667722, 3811.542614886176, 3854.5952674969285, 3945.2109578084496, 3975.045988962628, 1262.1669697999275, 1268.3341245846004, 1274.928241607388, 1276.1386064406488, 1294.6375014995817, 965.6282331302499, 984.5372674842812, 990.0693348252763, 999.4403134244847, 1002.7142264454595, 5854.531637468992, 5917.497012753965, 6028.4272994065495, 6032.366601506867, 6113.57204995655, 421.7448443691584, 425.62119713455047, 427.77755567105555, 428.90135268887707, 435.64930231163584, 3953.466282051944, 4160.479940007499, 4161.9595101224695, 4172.395002724588, 4202.558731333166, 9995.100440960348, 10316.1747060235, 10405.687829365132, 10418.947905260577, 10586.629467968583, 10438.21713371485, 10486.108680762221, 10501.684949451528, 10536.157107431387, 10565.366078035342, 7802.843943121105, 7809.687612495437, 7895.249951254622, 7903.68385264583, 7923.247291507182, 5806.1000544915605, 5866.413358664099, 5913.970430147821, 5931.1399847021075, 5935.643861368331, 9541.856872147062, 9583.664571739955, 9634.084761947604, 9655.131038206595, 9742.220622350336, 9523.571439285388, 9626.855597165908, 9870.950645246729, 9893.554790034323, 9914.256430767577, 6566.606003639797, 7260.346568808833, 7345.118585769528, 7495.775126746206, 7586.355159811478, 8105.067917189599, 8136.0643525995265, 8141.674333026613, 8146.959265203636, 8166.42835001568, 7066.328698773608, 7295.452841037049, 7314.08573928259, 7381.483296169216, 7408.666610002455, 6926.341997510229, 7012.088428504262, 7240.96379518099, 7356.485046046725, 7478.5138965967035, 6780.69486873082, 6786.049953006484, 6843.863122737418, 6847.48643851723, 6859.691313890987, 4748.952510474851, 4912.631552633638, 4947.529984651453, 4971.0, 4987.80048798044, 4914.041761856403, 4931.3589233399425, 4936.136176169084, 4992.950070499249, 5027.195648696191], "value": 4422.650685034679, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.56636372715474, 342.0968642783053, 342.7652058340037, 353.625157333227, 354.30202501072876, 5996.760129594816, 6040.8489787755325, 6052.788152414666, 6107.114468402085, 6149.354317796634, 5983.850403739909, 5997.340292567814, 5999.130126131719, 5999.400059993998, 5999.400059993998, 4158.272302347093, 4550.408446901898, 4561.452625684922, 4576.199165146103, 4605.654575906804, 4533.682642215046, 4557.111363284161, 4559.270516717326, 4572.451305843303, 4575.428071491064, 4541.954580454203, 4555.453345598533, 4573.885652858688, 4584.266517357223, 4590.816367345302, 4252.170826688797, 4497.955020449786, 4498.145352383037, 4514.0, 4514.480834703985, 3867.7679339239453, 3891.9805400972814, 3904.863329783444, 3915.393114067324, 3915.725899187058, 5630.211770352154, 5710.857228569277, 5722.113072473773, 5741.167530708066, 5748.5688573357165, 5049.974750126263, 5249.238860365225, 5249.396319423277, 5269.6311258211945, 5281.207818827168, 6289.0, 6305.779297724557, 6307.842303942392, 6320.523711958451, 6322.810315690491, 4129.69027322952, 4304.698671093025, 4352.477702675699, 4374.147041326943, 4387.846425375096, 6569.704363303663, 6586.967065164644, 6601.339866013408, 6605.86788264232, 6635.435987940982, 4454.665900057508, 4458.732476051382, 4459.353393757887, 4463.196624607537, 4476.888077798016, 4327.6105150536605, 4509.751963641966, 4525.185466615975, 4533.591976722111, 4544.840930567414, 5265.789368425297, 5281.339832520935, 5293.364796224478, 5296.1261391870685, 5298.947010529922, 6338.176037115146, 6352.841178970562, 6374.916264235091, 6394.1687580614225, 6444.838879027968, 1538.8845836562302, 1572.858442740136, 1576.6373734041235, 1579.6919600677988, 1581.1777875504672, 972.7665360313615, 994.5922171909627, 1020.1175982774995, 1024.7489365105596, 1032.5921261101823, 6099.512039036955, 6104.969475152596, 6112.480439162632, 6138.14066030756, 6149.815505534841, 6409.743610255631, 6435.710393032325, 6442.967785161044, 6467.288598254282, 6514.478841692748, 6118.418750218722, 6150.969245153746, 6159.137720719103, 6159.907601385983, 6177.505799536027, 3474.6872781449792, 3496.615372309044, 3504.789712617251, 3507.5790905091044, 3509.2630547585295, 6647.0, 6760.695768690421, 6766.391024807791, 6774.593524388552, 6812.318768123148, 6621.900671489835, 6637.4026337628875, 6697.866042679119, 6703.765368212089, 6717.630530320879, 6588.769393071219, 6705.178048512301, 6728.529002969745, 6738.191417029988, 6769.72921083161, 6426.293107758236, 6474.482041436768, 6487.708053137526, 6488.610683359014, 6490.578112422678, 6275.184226050585, 6392.328805475544, 6393.488520918222, 6399.264084630141, 6433.839154021187, 6676.365745254193, 6718.496112791462, 6729.73081076771, 6757.358050985148, 6782.220044694924, 4439.977800110979, 4443.266860967904, 4457.465104187519, 4466.731996080116, 4484.68607197493, 6198.969005154945, 6446.454450052546, 6480.319566445455, 6481.319461456667, 6502.154719886385, 6282.1519094921605, 6311.842203944938, 6317.020861766434, 6349.6507692077375, 6360.363963603602, 6079.908801368071, 6215.285242197205, 6264.749410023548, 6272.153259309935, 6281.811545653638, 6015.01504503504, 6114.357992410911, 6190.7523699051535, 6198.783042593487, 6250.593711408744, 6357.682115894279, 6358.841028974312, 6382.489400847828, 6395.136656551492, 6419.2938776735455, 6102.633841969496, 6234.563580549318, 6236.0, 6295.18162638854, 6305.653189074645], "value": 4750.950737121092, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.3882061427172, 735.3969744809257, 757.2049348184405, 769.2000319667546, 806.8749343851705, 13894.096883702552, 14154.858451415495, 14234.928825355859, 14236.217008064577, 14296.928515357435, 13833.515826946059, 14479.276036198175, 15012.174330411823, 15024.699506009872, 15089.924550377233, 781.7967328494603, 797.3860127701666, 811.7767613906178, 815.8286759780453, 817.382875928673, 813.9674413023472, 817.1297568089994, 818.1613845808035, 819.7335865843595, 822.56404105824, 839.5424493650975, 845.5983407881268, 846.6909578004046, 849.2314455417826, 850.1923172985688, 838.5555655502593, 840.2857571064608, 840.7225615546886, 845.213951025546, 845.7166849105557, 607.6141650052249, 612.2194202391942, 614.6127939398151, 619.1764952613058, 619.1981384107592, 13927.303634818218, 13933.442662293495, 13956.441742330295, 13964.930175349058, 13969.301534923214, 13790.241536715477, 13973.79039314411, 14011.719765604732, 14012.369443375073, 14047.859521404758, 10548.419836908966, 10885.18361122919, 10948.726281842937, 11049.944750276198, 11070.557177712883, 3712.962870371289, 3741.27045226181, 3755.5493340799007, 3779.622037796226, 3915.2756740002906, 52551.73724131393, 52843.73578132085, 53115.468845311436, 53306.466935330536, 53380.73309633505, 10557.366558006544, 10591.258611897094, 10678.572857085785, 10696.41169735672, 10787.514561844735, 17697.115144242736, 17845.821541784415, 17888.463346099637, 17975.101244937963, 18380.356687515872, 7819.257170568787, 7967.880481792778, 8122.959385203154, 8123.0, 8505.23452889243, 4683.320918466871, 4715.717056976592, 4788.11419887322, 4875.804967801319, 4886.0, 3185.8725650974166, 3233.2401885556874, 3271.820049897231, 3298.703116719507, 3303.7687361884437, 588.5644622978965, 594.8483136800088, 601.4797200421691, 604.5163868904858, 612.9080637904261, 639.338284875152, 650.3301599352675, 677.3057615943599, 685.2085840853822, 707.8407358344434, 8795.428297160664, 8888.73333799987, 8961.372703910663, 9111.088891110836, 9143.908560914439, 581.2676028204409, 665.1884700665181, 680.6392611915594, 692.51869950384, 699.4159876503076, 4070.776107314126, 4094.201630682048, 4095.7542547447247, 4107.54816970133, 4144.834206631761, 59330.0, 59472.40527594755, 61098.0, 61236.0, 61239.69380153071, 53008.0, 53237.0, 53809.73095134577, 54120.72939635276, 54666.72666636721, 49907.750461248186, 50139.0, 51100.488995109576, 51193.0, 51299.717507061876, 7926.286634202949, 7949.3243074339325, 8129.9187008129165, 8252.504849709037, 8288.33693304522, 32754.0, 32785.67214327922, 32799.508007380384, 33047.0, 33401.0, 41301.38047929344, 44051.0, 44228.33657495076, 44456.33315500335, 44568.33147502855, 11332.943335283271, 11364.715882103013, 11392.487338069972, 11498.655040348804, 11681.766364672829, 11560.537578497102, 11607.071434285406, 11694.532218711496, 11724.179307448398, 12161.209521381083, 11663.475143618727, 11712.70718232051, 11755.764884702086, 12129.575464858688, 12231.633051008484, 11588.6523404298, 11608.187426880037, 11640.185187036826, 11838.526458941546, 11851.70370740704, 10708.785824283626, 10734.248602597743, 11158.49786759614, 11185.0, 11230.55077796879, 8993.655120083456, 9043.329299689558, 9213.861792073258, 9332.346735728705, 9371.906280937103, 9583.233341332816, 9727.562259698188, 10041.548130334006, 10085.092341689284, 10089.705126221246], "value": 6484.436782745861, "unit": "score"}], "name": "dromaeo_css", "value": 7000.323550805984, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 107.0, 113.0, 111.0, 113.0, 124.0, 115.0, 112.0, 114.0, 113.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 129.0, 156.0, 182.0, 131.0, 154.0, 153.0, 130.0, 194.0, 128.0], "value": 151.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 163.0, 162.0, 164.0, 166.0, 168.0, 166.0, 163.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 77.0, 152.0, 78.0, 73.0, 73.0, 77.0, 163.0, 77.0], "value": 91.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 158.0, 93.0, 95.0, 93.0, 155.0, 93.0, 93.0, 141.0], "value": 110.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 119.0, 118.0, 120.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 147.0, 148.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 61.0, 62.0, 60.0, 59.0, 60.0, 76.0, 60.0, 57.0], "value": 61.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 61.0, 63.0, 62.0, 61.0, 63.0, 62.0, 62.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 76.0, 77.0, 78.0, 80.0, 77.0, 80.0, 78.0, 80.0], "value": 78.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 134.0, 127.0, 131.0, 125.0, 128.0, 136.0, 135.0, 162.0, 135.0], "value": 134.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 166.0, 169.0, 170.0, 179.0, 169.0, 169.0, 174.0, 168.0, 168.0], "value": 170.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 68.0, 68.0, 70.0, 69.0, 80.0, 69.0, 67.0, 67.0], "value": 69.8, "unit": "score"}], "name": "kraken", "value": 1566.4999999999998, "alertThreshold": 2.0}]} 09:03:51 INFO - Return code: 0 09:03:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:03:51 ERROR - # TBPL SUCCESS # 09:03:51 INFO - Running post-action listener: _resource_record_post_action 09:03:51 INFO - Running post-run listener: _resource_record_post_run 09:03:52 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8192; Write bytes: 536219648; Read time: 164; Write time: 515376 09:03:52 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 244490240; Read time: 152; Write time: 303364 09:03:52 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291729408; Read time: 12; Write time: 212012 09:03:52 INFO - Running post-run listener: _upload_blobber_files 09:03:52 INFO - Blob upload gear active. 09:03:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:03:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:03:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:03:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:03:52 INFO - (blobuploader) - INFO - Open directory for files ... 09:03:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:03:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:03:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:53 INFO - (blobuploader) - INFO - Done attempting. 09:03:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:03:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:03:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:54 INFO - (blobuploader) - INFO - Done attempting. 09:03:54 INFO - (blobuploader) - INFO - Iteration through files over. 09:03:54 INFO - Return code: 0 09:03:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:03:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:03:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ff1bdaa0520a6509f419d62dc7a1a781f537a998517f8bc0c5876005d82ecf6ff91743b0d3d7ceafe71fb3c5b5800ec016300327f1a4bbea305044296856b17", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/47b9a23e39d2b5dca3f375a4023cecf8bd97077ca71dfc3968165260a1b1602b8021be198064ec6845b1e17b1aedc77adcc7eef1f86303498430f0ba2057b5b8"} 09:03:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:03:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:03:54 INFO - Contents: 09:03:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ff1bdaa0520a6509f419d62dc7a1a781f537a998517f8bc0c5876005d82ecf6ff91743b0d3d7ceafe71fb3c5b5800ec016300327f1a4bbea305044296856b17", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/47b9a23e39d2b5dca3f375a4023cecf8bd97077ca71dfc3968165260a1b1602b8021be198064ec6845b1e17b1aedc77adcc7eef1f86303498430f0ba2057b5b8"} 09:03:54 INFO - Running post-run listener: copy_logs_to_upload_dir 09:03:54 INFO - Copying logs to upload dir... 09:03:54 INFO - mkdir: /builds/slave/test/build/upload/logs 09:03:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.260846 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-20 09:03:53.494427) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 09:03:53.498592) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1461166458.290806-512207186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ff1bdaa0520a6509f419d62dc7a1a781f537a998517f8bc0c5876005d82ecf6ff91743b0d3d7ceafe71fb3c5b5800ec016300327f1a4bbea305044296856b17", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/47b9a23e39d2b5dca3f375a4023cecf8bd97077ca71dfc3968165260a1b1602b8021be198064ec6845b1e17b1aedc77adcc7eef1f86303498430f0ba2057b5b8"} build_url:https://queue.taskcluster.net/v1/task/WjJUxYJcQBCFoLQqe3PNyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011136 build_url: 'https://queue.taskcluster.net/v1/task/WjJUxYJcQBCFoLQqe3PNyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ff1bdaa0520a6509f419d62dc7a1a781f537a998517f8bc0c5876005d82ecf6ff91743b0d3d7ceafe71fb3c5b5800ec016300327f1a4bbea305044296856b17", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/47b9a23e39d2b5dca3f375a4023cecf8bd97077ca71dfc3968165260a1b1602b8021be198064ec6845b1e17b1aedc77adcc7eef1f86303498430f0ba2057b5b8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 09:03:53.523626) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 09:03:53.523987) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1461166458.290806-512207186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004369 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 09:03:53.609145) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 09:03:53.609465) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 09:03:53.609765) ========= ========= Total master_lag: 0.16 =========