builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-048 starttime: 1462484692.3 results: success (0) buildid: 20160505133104 builduid: 222fb43eeaa54145a29993f9babb5a0a revision: 5fe67c44f537155ac01049024e1c9548ece1a012 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 14:44:52.296705) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 14:44:52.297161) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 14:44:52.297441) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 14:44:52.313984) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 14:44:52.314338) ========= 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=fa44defc139c4ba8574fe040000001db-1462484693.63716-1933703558 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-05 14:44:53-- 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% 46.0M=0s 2016-05-05 14:44:53 (46.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.089209 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 14:44:52.416969) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 14:44:52.417299) ========= 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=fa44defc139c4ba8574fe040000001db-1462484693.63716-1933703558 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020423 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 14:44:52.467227) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 14:44:52.467599) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5fe67c44f537155ac01049024e1c9548ece1a012 --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 5fe67c44f537155ac01049024e1c9548ece1a012 --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=fa44defc139c4ba8574fe040000001db-1462484693.63716-1933703558 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-05 14:44:54,060 truncating revision to first 12 chars 2016-05-05 14:44:54,060 Setting DEBUG logging. 2016-05-05 14:44:54,060 attempt 1/10 2016-05-05 14:44:54,060 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5fe67c44f537?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-05 14:44:54,335 unpacking tar archive at: fx-team-5fe67c44f537/testing/mozharness/ program finished with exit code 0 elapsedTime=0.565485 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 14:44:53.046573) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 14:44:53.046926) ========= script_repo_revision: 5fe67c44f537155ac01049024e1c9548ece1a012 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 14:44:53.047403) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 14:44:53.047724) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 14:44:53.058316) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-05 14:44:53.058694) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=fa44defc139c4ba8574fe040000001db-1462484693.63716-1933703558 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:44:54 INFO - MultiFileLogger online at 20160505 14:44:54 in /builds/slave/test 14:44:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 14:44:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:44:54 INFO - {'append_to_log': False, 14:44:54 INFO - 'base_work_dir': '/builds/slave/test', 14:44:54 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:44:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:44:54 INFO - 'branch': 'Fx-Team-Non-PGO', 14:44:54 INFO - 'buildbot_json_path': 'buildprops.json', 14:44:54 INFO - 'config_files': ('talos/linux_config.py',), 14:44:54 INFO - 'default_actions': ('clobber', 14:44:54 INFO - 'read-buildbot-config', 14:44:54 INFO - 'download-and-extract', 14:44:54 INFO - 'populate-webroot', 14:44:54 INFO - 'create-virtualenv', 14:44:54 INFO - 'install', 14:44:54 INFO - 'run-tests'), 14:44:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:44:54 INFO - 'download_minidump_stackwalk': True, 14:44:54 INFO - 'download_symbols': 'ondemand', 14:44:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:44:54 INFO - 'tooltool.py': '/tools/tooltool.py', 14:44:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:44:54 INFO - '/tools/misc-python/virtualenv.py')}, 14:44:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:44:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:44:54 INFO - 'installer_path': 'installer.exe', 14:44:54 INFO - 'log_level': 'info', 14:44:54 INFO - 'log_name': 'talos', 14:44:54 INFO - 'log_to_console': True, 14:44:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:44:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:44:54 INFO - 'opt_config_files': (), 14:44:54 INFO - 'pip_index': False, 14:44:54 INFO - 'sps_profile': False, 14:44:54 INFO - 'sps_profile_interval': 0, 14:44:54 INFO - 'suite': 'dromaeojs-e10s', 14:44:54 INFO - 'system_bits': '32', 14:44:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:44:54 INFO - 'title': 'talos-linux64-ix-048', 14:44:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:44:54 INFO - 'use_talos_json': True, 14:44:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:44:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:44:54 INFO - 'work_dir': 'build'} 14:44:54 INFO - ##### 14:44:54 INFO - ##### Running clobber step. 14:44:54 INFO - ##### 14:44:54 INFO - Running pre-action listener: _resource_record_pre_action 14:44:54 INFO - Running main action method: clobber 14:44:54 INFO - rmtree: /builds/slave/test/build 14:44:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:44:55 INFO - Running post-action listener: _resource_record_post_action 14:44:55 INFO - ##### 14:44:55 INFO - ##### Running read-buildbot-config step. 14:44:55 INFO - ##### 14:44:55 INFO - Running pre-action listener: _resource_record_pre_action 14:44:55 INFO - Running main action method: read_buildbot_config 14:44:55 INFO - Using buildbot properties: 14:44:55 INFO - { 14:44:55 INFO - "project": "", 14:44:55 INFO - "product": "firefox", 14:44:55 INFO - "script_repo_revision": "production", 14:44:55 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:44:55 INFO - "repository": "", 14:44:55 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 14:44:55 INFO - "buildid": "20160505133104", 14:44:55 INFO - "pgo_build": "False", 14:44:55 INFO - "basedir": "/builds/slave/test", 14:44:55 INFO - "buildnumber": 1480, 14:44:55 INFO - "slavename": "talos-linux64-ix-048", 14:44:55 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:44:55 INFO - "platform": "ubuntu64_hw", 14:44:55 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:44:55 INFO - "branch": "fx-team", 14:44:55 INFO - "repo_path": "integration/fx-team", 14:44:55 INFO - "revision": "5fe67c44f537155ac01049024e1c9548ece1a012", 14:44:55 INFO - "stage_platform": "linux64", 14:44:55 INFO - "builduid": "222fb43eeaa54145a29993f9babb5a0a", 14:44:55 INFO - "slavebuilddir": "test" 14:44:55 INFO - } 14:44:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/GkvPTsqkRDqMgMTGHc7o6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 14:44:55 INFO - Running post-action listener: _resource_record_post_action 14:44:55 INFO - ##### 14:44:55 INFO - ##### Running download-and-extract step. 14:44:55 INFO - ##### 14:44:55 INFO - Running pre-action listener: _resource_record_pre_action 14:44:55 INFO - Running main action method: download_and_extract 14:44:55 INFO - mkdir: /builds/slave/test/build/tests 14:44: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')]} 14:44:55 INFO - https://queue.taskcluster.net/v1/task/GkvPTsqkRDqMgMTGHc7o6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:44:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GkvPTsqkRDqMgMTGHc7o6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:44:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GkvPTsqkRDqMgMTGHc7o6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:44:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GkvPTsqkRDqMgMTGHc7o6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:44:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GkvPTsqkRDqMgMTGHc7o6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:44:55 INFO - Downloaded 1361 bytes. 14:44:55 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:44:55 INFO - Using the following test package requirements: 14:44:55 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:44:55 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:44:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:44:55 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:44:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:44:55 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:44:55 INFO - u'jsshell-linux-x86_64.zip'], 14:44:55 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:44:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:44:55 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:44:55 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:44:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:44:55 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:44:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:44:55 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:44:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:44:55 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:44:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:44:55 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:44: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')]} 14:44:55 INFO - https://queue.taskcluster.net/v1/task/GkvPTsqkRDqMgMTGHc7o6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:44:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GkvPTsqkRDqMgMTGHc7o6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:44:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GkvPTsqkRDqMgMTGHc7o6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:44:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GkvPTsqkRDqMgMTGHc7o6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:44:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GkvPTsqkRDqMgMTGHc7o6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:44:56 INFO - Downloaded 22321318 bytes. 14:44:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:44:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:44:58 INFO - Return code: 0 14:44:58 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:44: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')]} 14:44:58 INFO - https://queue.taskcluster.net/v1/task/GkvPTsqkRDqMgMTGHc7o6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:44:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GkvPTsqkRDqMgMTGHc7o6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:44:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GkvPTsqkRDqMgMTGHc7o6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:44:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GkvPTsqkRDqMgMTGHc7o6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:44:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GkvPTsqkRDqMgMTGHc7o6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:44:59 INFO - Downloaded 22321318 bytes. 14:44:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:44:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:45:00 INFO - Return code: 0 14:45:00 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')]} 14:45:00 INFO - https://queue.taskcluster.net/v1/task/GkvPTsqkRDqMgMTGHc7o6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:45:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GkvPTsqkRDqMgMTGHc7o6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:45:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GkvPTsqkRDqMgMTGHc7o6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:45:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GkvPTsqkRDqMgMTGHc7o6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:45:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GkvPTsqkRDqMgMTGHc7o6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:45:01 INFO - Downloaded 10840152 bytes. 14:45:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:45:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:45:02 INFO - Return code: 0 14:45:02 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')]} 14:45:02 INFO - https://queue.taskcluster.net/v1/task/GkvPTsqkRDqMgMTGHc7o6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:45:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GkvPTsqkRDqMgMTGHc7o6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:45:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GkvPTsqkRDqMgMTGHc7o6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:45:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GkvPTsqkRDqMgMTGHc7o6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:45:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GkvPTsqkRDqMgMTGHc7o6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:45:03 INFO - Downloaded 54834867 bytes. 14:45:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GkvPTsqkRDqMgMTGHc7o6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:45:03 INFO - mkdir: /builds/slave/test/properties 14:45:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:45:03 INFO - Writing to file /builds/slave/test/properties/build_url 14:45:03 INFO - Contents: 14:45:03 INFO - build_url:https://queue.taskcluster.net/v1/task/GkvPTsqkRDqMgMTGHc7o6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:45:04 INFO - Running post-action listener: _resource_record_post_action 14:45:04 INFO - Running post-action listener: set_extra_try_arguments 14:45:04 INFO - ##### 14:45:04 INFO - ##### Running populate-webroot step. 14:45:04 INFO - ##### 14:45:04 INFO - Running pre-action listener: _resource_record_pre_action 14:45:04 INFO - Running main action method: populate_webroot 14:45:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:45:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:45:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:45:04 INFO - '--tppagecycles', 14:45:04 INFO - '7'], 14:45:04 INFO - 'tests': ['tsvgm']}}, 14:45:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:45:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:45:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:45:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:45:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:45:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:45:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:45:04 INFO - 'talos_options': ['--disable-e10s'], 14:45:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:45:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:45:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:45:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:45:04 INFO - 'talos_options': ['--disable-e10s'], 14:45:04 INFO - 'tests': ['damp', 'tps']}, 14:45:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:45:04 INFO - 'tests': ['damp', 'tps']}, 14:45:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:45:04 INFO - 'tests': ['dromaeo_dom']}, 14:45:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:45:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:45:04 INFO - 'tests': ['a11yr', 14:45:04 INFO - 'ts_paint', 14:45:04 INFO - 'tpaint', 14:45:04 INFO - 'sessionrestore', 14:45:04 INFO - 'sessionrestore_no_auto_restore', 14:45:04 INFO - 'tabpaint']}, 14:45:04 INFO - 'other-e10s': {'tests': ['a11yr', 14:45:04 INFO - 'ts_paint', 14:45:04 INFO - 'tpaint', 14:45:04 INFO - 'sessionrestore', 14:45:04 INFO - 'sessionrestore_no_auto_restore', 14:45:04 INFO - 'tabpaint']}, 14:45:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:45:04 INFO - 'ts_paint', 14:45:04 INFO - 'tpaint', 14:45:04 INFO - 'sessionrestore', 14:45:04 INFO - 'sessionrestore_no_auto_restore', 14:45:04 INFO - 'tabpaint']}, 14:45:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:45:04 INFO - 'ts_paint', 14:45:04 INFO - 'tpaint', 14:45:04 INFO - 'sessionrestore', 14:45:04 INFO - 'sessionrestore_no_auto_restore', 14:45:04 INFO - 'tabpaint']}, 14:45:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:45:04 INFO - 'tests': ['a11yr', 14:45:04 INFO - 'ts_paint', 14:45:04 INFO - 'tpaint', 14:45:04 INFO - 'sessionrestore', 14:45:04 INFO - 'sessionrestore_no_auto_restore', 14:45:04 INFO - 'tabpaint']}, 14:45:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:45:04 INFO - 'tests': ['a11yr', 14:45:04 INFO - 'ts_paint', 14:45:04 INFO - 'tpaint', 14:45:04 INFO - 'sessionrestore', 14:45:04 INFO - 'sessionrestore_no_auto_restore', 14:45:04 INFO - 'tabpaint']}, 14:45:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:45:04 INFO - 'tests': ['tsvgx', 14:45:04 INFO - 'tsvgr_opacity', 14:45:04 INFO - 'tart', 14:45:04 INFO - 'tscrollx', 14:45:04 INFO - 'cart']}, 14:45:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:45:04 INFO - 'tsvgr_opacity', 14:45:04 INFO - 'tart', 14:45:04 INFO - 'tscrollx', 14:45:04 INFO - 'cart']}, 14:45:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:45:04 INFO - 'talos_options': ['--disable-e10s'], 14:45:04 INFO - 'tests': ['tp5o']}, 14:45:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:45:04 INFO - 'tests': ['tp5o']}, 14:45:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:45:04 INFO - 'talos_options': ['--disable-e10s', 14:45:04 INFO - '--xperf_path', 14:45:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:45:04 INFO - 'tests': ['tp5n']}, 14:45:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:45:04 INFO - 'talos_options': ['--xperf_path', 14:45:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:45:04 INFO - 'tests': ['tp5n']}}, 14:45:04 INFO - 'talos.zip': {'path': '', 14:45:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:45:04 INFO - Running post-action listener: _resource_record_post_action 14:45:04 INFO - ##### 14:45:04 INFO - ##### Running create-virtualenv step. 14:45:04 INFO - ##### 14:45:04 INFO - Running pre-action listener: _resource_record_pre_action 14:45:04 INFO - Running main action method: create_virtualenv 14:45:04 INFO - Creating virtualenv /builds/slave/test/build/venv 14:45:04 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 14:45:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:45:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:45:04 INFO - Using real prefix '/usr' 14:45:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:45:05 INFO - Installing distribute.............................................................................................................................................................................................done. 14:45:07 INFO - Installing pip.................done. 14:45:07 INFO - Return code: 0 14:45:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:45:07 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')]} 14:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:07 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')]} 14:45:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:07 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 0x7f5800262f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26dd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276c410>, '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 0x276d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276d7a0>, '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': 'fa44defc139c4ba8574fe040000001db-1462484693.63716-1933703558', '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 14:45:07 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 14:45:07 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 14:45:07 INFO - Using env: {'DISPLAY': ':0', 14:45:07 INFO - 'HOME': '/home/cltbld', 14:45:07 INFO - 'LANG': 'en_US.UTF-8', 14:45:07 INFO - 'LANGUAGE': 'en_US:en', 14:45:07 INFO - 'LOGNAME': 'cltbld', 14:45:07 INFO - 'MAIL': '/var/mail/cltbld', 14:45:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:07 INFO - 'MOZ_NO_REMOTE': '1', 14:45:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:45:07 INFO - 'NO_EM_RESTART': '1', 14:45:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:45:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:45:07 INFO - 'PWD': '/builds/slave/test', 14:45:07 INFO - 'SHELL': '/bin/bash', 14:45:07 INFO - 'SHLVL': '1', 14:45:07 INFO - 'TERM': 'linux', 14:45:07 INFO - 'TMOUT': '86400', 14:45:07 INFO - 'USER': 'cltbld', 14:45:07 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1462484693.63716-1933703558', 14:45:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:07 INFO - '_': '/tools/buildbot/bin/python'} 14:45:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:07 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 14:45:07 INFO - Cleaning up... 14:45:07 INFO - Return code: 0 14:45:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:45:07 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')]} 14:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:07 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')]} 14:45:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:07 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 0x7f5800262f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26dd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276c410>, '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 0x276d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276d7a0>, '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': 'fa44defc139c4ba8574fe040000001db-1462484693.63716-1933703558', '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 14:45:07 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 14:45:07 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 14:45:07 INFO - Using env: {'DISPLAY': ':0', 14:45:07 INFO - 'HOME': '/home/cltbld', 14:45:07 INFO - 'LANG': 'en_US.UTF-8', 14:45:07 INFO - 'LANGUAGE': 'en_US:en', 14:45:07 INFO - 'LOGNAME': 'cltbld', 14:45:07 INFO - 'MAIL': '/var/mail/cltbld', 14:45:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:07 INFO - 'MOZ_NO_REMOTE': '1', 14:45:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:45:07 INFO - 'NO_EM_RESTART': '1', 14:45:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:45:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:45:07 INFO - 'PWD': '/builds/slave/test', 14:45:07 INFO - 'SHELL': '/bin/bash', 14:45:07 INFO - 'SHLVL': '1', 14:45:07 INFO - 'TERM': 'linux', 14:45:07 INFO - 'TMOUT': '86400', 14:45:07 INFO - 'USER': 'cltbld', 14:45:07 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1462484693.63716-1933703558', 14:45:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:07 INFO - '_': '/tools/buildbot/bin/python'} 14:45:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:07 INFO - Downloading/unpacking psutil>=0.7.1 14:45:07 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 14:45:07 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 14:45:07 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 14:45:07 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 14:45:07 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 14:45:07 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 14:45:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:45:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:45:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:45:09 INFO - Installing collected packages: psutil 14:45:09 INFO - Running setup.py install for psutil 14:45:09 INFO - building 'psutil._psutil_linux' extension 14:45:09 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 14:45:09 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 14:45:09 INFO - building 'psutil._psutil_posix' extension 14:45:09 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 14:45:09 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 14:45:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:45:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:45:09 INFO - Successfully installed psutil 14:45:09 INFO - Cleaning up... 14:45:10 INFO - Return code: 0 14:45:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:45:10 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')]} 14:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:10 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')]} 14:45:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:10 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 0x7f5800262f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26dd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276c410>, '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 0x276d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276d7a0>, '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': 'fa44defc139c4ba8574fe040000001db-1462484693.63716-1933703558', '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 14:45:10 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 14:45:10 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 14:45:10 INFO - Using env: {'DISPLAY': ':0', 14:45:10 INFO - 'HOME': '/home/cltbld', 14:45:10 INFO - 'LANG': 'en_US.UTF-8', 14:45:10 INFO - 'LANGUAGE': 'en_US:en', 14:45:10 INFO - 'LOGNAME': 'cltbld', 14:45:10 INFO - 'MAIL': '/var/mail/cltbld', 14:45:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:10 INFO - 'MOZ_NO_REMOTE': '1', 14:45:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:45:10 INFO - 'NO_EM_RESTART': '1', 14:45:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:45:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:45:10 INFO - 'PWD': '/builds/slave/test', 14:45:10 INFO - 'SHELL': '/bin/bash', 14:45:10 INFO - 'SHLVL': '1', 14:45:10 INFO - 'TERM': 'linux', 14:45:10 INFO - 'TMOUT': '86400', 14:45:10 INFO - 'USER': 'cltbld', 14:45:10 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1462484693.63716-1933703558', 14:45:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:10 INFO - '_': '/tools/buildbot/bin/python'} 14:45:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:45:10 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 14:45:10 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 14:45:10 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 14:45:10 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 14:45:10 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 14:45:10 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 14:45:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:45:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:45:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:45:12 INFO - Installing collected packages: mozsystemmonitor 14:45:12 INFO - Running setup.py install for mozsystemmonitor 14:45:12 INFO - Successfully installed mozsystemmonitor 14:45:12 INFO - Cleaning up... 14:45:12 INFO - Return code: 0 14:45:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:45:12 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')]} 14:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:12 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')]} 14:45:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:12 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 0x7f5800262f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26dd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276c410>, '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 0x276d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276d7a0>, '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': 'fa44defc139c4ba8574fe040000001db-1462484693.63716-1933703558', '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 14:45:12 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 14:45:12 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 14:45:12 INFO - Using env: {'DISPLAY': ':0', 14:45:12 INFO - 'HOME': '/home/cltbld', 14:45:12 INFO - 'LANG': 'en_US.UTF-8', 14:45:12 INFO - 'LANGUAGE': 'en_US:en', 14:45:12 INFO - 'LOGNAME': 'cltbld', 14:45:12 INFO - 'MAIL': '/var/mail/cltbld', 14:45:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:12 INFO - 'MOZ_NO_REMOTE': '1', 14:45:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:45:12 INFO - 'NO_EM_RESTART': '1', 14:45:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:45:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:45:12 INFO - 'PWD': '/builds/slave/test', 14:45:12 INFO - 'SHELL': '/bin/bash', 14:45:12 INFO - 'SHLVL': '1', 14:45:12 INFO - 'TERM': 'linux', 14:45:12 INFO - 'TMOUT': '86400', 14:45:12 INFO - 'USER': 'cltbld', 14:45:12 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1462484693.63716-1933703558', 14:45:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:12 INFO - '_': '/tools/buildbot/bin/python'} 14:45:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:12 INFO - Downloading/unpacking blobuploader==1.2.4 14:45:12 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 14:45:12 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 14:45:12 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 14:45:12 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 14:45:12 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 14:45:12 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 14:45:14 INFO - Downloading blobuploader-1.2.4.tar.gz 14:45:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:45:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:45:14 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 14:45:14 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 14:45:14 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 14:45:14 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 14:45:14 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 14:45:14 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 14:45:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:45:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:45:14 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 14:45:14 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 14:45:14 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 14:45:14 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 14:45:14 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 14:45:14 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 14:45:15 INFO - Downloading docopt-0.6.1.tar.gz 14:45:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:45:15 INFO - Installing collected packages: blobuploader, requests, docopt 14:45:15 INFO - Running setup.py install for blobuploader 14:45:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:45:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:45:15 INFO - Running setup.py install for requests 14:45:15 INFO - Running setup.py install for docopt 14:45:15 INFO - Successfully installed blobuploader requests docopt 14:45:15 INFO - Cleaning up... 14:45:15 INFO - Return code: 0 14:45:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:45:15 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')]} 14:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:15 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')]} 14:45:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:15 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 0x7f5800262f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26dd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276c410>, '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 0x276d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276d7a0>, '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': 'fa44defc139c4ba8574fe040000001db-1462484693.63716-1933703558', '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 14:45:15 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 14:45:15 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 14:45:15 INFO - Using env: {'DISPLAY': ':0', 14:45:15 INFO - 'HOME': '/home/cltbld', 14:45:15 INFO - 'LANG': 'en_US.UTF-8', 14:45:15 INFO - 'LANGUAGE': 'en_US:en', 14:45:15 INFO - 'LOGNAME': 'cltbld', 14:45:15 INFO - 'MAIL': '/var/mail/cltbld', 14:45:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:15 INFO - 'MOZ_NO_REMOTE': '1', 14:45:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:45:15 INFO - 'NO_EM_RESTART': '1', 14:45:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:45:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:45:15 INFO - 'PWD': '/builds/slave/test', 14:45:15 INFO - 'SHELL': '/bin/bash', 14:45:15 INFO - 'SHLVL': '1', 14:45:15 INFO - 'TERM': 'linux', 14:45:15 INFO - 'TMOUT': '86400', 14:45:15 INFO - 'USER': 'cltbld', 14:45:15 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1462484693.63716-1933703558', 14:45:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:15 INFO - '_': '/tools/buildbot/bin/python'} 14:45:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:45:15 INFO - Running setup.py (path:/tmp/pip-bWjmOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:45:16 INFO - Running setup.py (path:/tmp/pip-wBOo91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:45:16 INFO - Running setup.py (path:/tmp/pip-o_JPIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:45:16 INFO - Running setup.py (path:/tmp/pip-O8slK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:45:16 INFO - Running setup.py (path:/tmp/pip-l7zg4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:45:16 INFO - Running setup.py (path:/tmp/pip-Ue8CdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:45:16 INFO - Running setup.py (path:/tmp/pip-vMEJ5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:45:16 INFO - Running setup.py (path:/tmp/pip-gydVCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:45:16 INFO - Running setup.py (path:/tmp/pip-_FpBtW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:45:16 INFO - Running setup.py (path:/tmp/pip-iuaNLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:45:16 INFO - Running setup.py (path:/tmp/pip-SY0VD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:45:16 INFO - Running setup.py (path:/tmp/pip-0hMSh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:45:16 INFO - Running setup.py (path:/tmp/pip-Ch1BPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:45:16 INFO - Running setup.py (path:/tmp/pip-HeG4Yp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:45:16 INFO - Running setup.py (path:/tmp/pip-Meivnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:45:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:45:17 INFO - Running setup.py (path:/tmp/pip-4PpGp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:45:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:45:17 INFO - Running setup.py (path:/tmp/pip-FXCtPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:45:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:45:17 INFO - Running setup.py install for manifestparser 14:45:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:45:17 INFO - Running setup.py install for mozcrash 14:45:17 INFO - Running setup.py install for mozdebug 14:45:17 INFO - Running setup.py install for mozdevice 14:45:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:45:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:45:17 INFO - Running setup.py install for mozfile 14:45:17 INFO - Running setup.py install for mozhttpd 14:45:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:45:17 INFO - Running setup.py install for mozinfo 14:45:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:45:17 INFO - Running setup.py install for mozInstall 14:45:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:45:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:45:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:45:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:45:17 INFO - Running setup.py install for mozleak 14:45:18 INFO - Running setup.py install for mozlog 14:45:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:45:18 INFO - Running setup.py install for moznetwork 14:45:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:45:18 INFO - Running setup.py install for mozprocess 14:45:18 INFO - Running setup.py install for mozprofile 14:45:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:45:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:45:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:45:18 INFO - Running setup.py install for mozrunner 14:45:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:45:18 INFO - Running setup.py install for mozscreenshot 14:45:18 INFO - Running setup.py install for moztest 14:45:18 INFO - Running setup.py install for mozversion 14:45:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:45:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:45:18 INFO - Cleaning up... 14:45:18 INFO - Return code: 0 14:45:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:45: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')]} 14:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45: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')]} 14:45:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:18 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 0x7f5800262f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26dd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276c410>, '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 0x276d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276d7a0>, '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': 'fa44defc139c4ba8574fe040000001db-1462484693.63716-1933703558', '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 14:45:18 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 14:45:18 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 14:45:18 INFO - Using env: {'DISPLAY': ':0', 14:45:18 INFO - 'HOME': '/home/cltbld', 14:45:18 INFO - 'LANG': 'en_US.UTF-8', 14:45:18 INFO - 'LANGUAGE': 'en_US:en', 14:45:18 INFO - 'LOGNAME': 'cltbld', 14:45:18 INFO - 'MAIL': '/var/mail/cltbld', 14:45:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:18 INFO - 'MOZ_NO_REMOTE': '1', 14:45:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:45:18 INFO - 'NO_EM_RESTART': '1', 14:45:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:45:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:45:18 INFO - 'PWD': '/builds/slave/test', 14:45:18 INFO - 'SHELL': '/bin/bash', 14:45:18 INFO - 'SHLVL': '1', 14:45:18 INFO - 'TERM': 'linux', 14:45:18 INFO - 'TMOUT': '86400', 14:45:18 INFO - 'USER': 'cltbld', 14:45:18 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1462484693.63716-1933703558', 14:45:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:18 INFO - '_': '/tools/buildbot/bin/python'} 14:45:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:45:19 INFO - Running setup.py (path:/tmp/pip-cRTkvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:45:19 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)) 14:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:45:19 INFO - Running setup.py (path:/tmp/pip-Ct0wg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:45:19 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)) 14:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:45:19 INFO - Running setup.py (path:/tmp/pip-vDWfqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:45:19 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)) 14:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:45:19 INFO - Running setup.py (path:/tmp/pip-7CeFDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:45:19 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)) 14:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:45:19 INFO - Running setup.py (path:/tmp/pip-u8wag3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:45:19 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)) 14:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:45:19 INFO - Running setup.py (path:/tmp/pip-bWAANB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:45:19 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)) 14:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:45:19 INFO - Running setup.py (path:/tmp/pip-sTQ7Nn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:45:19 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)) 14:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:45:19 INFO - Running setup.py (path:/tmp/pip-tivohd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:45:19 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)) 14:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:45:19 INFO - Running setup.py (path:/tmp/pip-f2Kcnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:45:19 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)) 14:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:45:19 INFO - Running setup.py (path:/tmp/pip-7SxWSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:45:19 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)) 14:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:45:19 INFO - Running setup.py (path:/tmp/pip-VTwJPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:45:19 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)) 14:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:45:19 INFO - Running setup.py (path:/tmp/pip-VV9o3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:45:20 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)) 14:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:45:20 INFO - Running setup.py (path:/tmp/pip-0eBty6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:45:20 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)) 14:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:45:20 INFO - Running setup.py (path:/tmp/pip-bJTL74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:45:20 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)) 14:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:45:20 INFO - Running setup.py (path:/tmp/pip-g1M0EN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:45:20 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)) 14:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:45:20 INFO - Running setup.py (path:/tmp/pip-x04HYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:45:20 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)) 14:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:45:20 INFO - Running setup.py (path:/tmp/pip-n5swrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:45:20 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)) 14:45:20 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)) 14:45:20 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)) 14:45:20 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)) 14:45:20 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)) 14:45:20 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)) 14:45:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:45:20 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 14:45:20 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 14:45:20 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 14:45:20 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 14:45:20 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 14:45:20 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 14:45:22 INFO - Downloading blessings-1.6.tar.gz 14:45:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:45:22 INFO - Installing collected packages: blessings 14:45:22 INFO - Running setup.py install for blessings 14:45:22 INFO - Successfully installed blessings 14:45:22 INFO - Cleaning up... 14:45:22 INFO - Return code: 0 14:45:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:45:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:45:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:45:22 INFO - Reading from file tmpfile_stdout 14:45:22 INFO - Current package versions: 14:45:22 INFO - argparse == 1.2.1 14:45:22 INFO - blessings == 1.6 14:45:22 INFO - blobuploader == 1.2.4 14:45:22 INFO - docopt == 0.6.1 14:45:22 INFO - manifestparser == 1.1 14:45:22 INFO - mozInstall == 1.12 14:45:22 INFO - mozcrash == 0.17 14:45:22 INFO - mozdebug == 0.1 14:45:22 INFO - mozdevice == 0.48 14:45:22 INFO - mozfile == 1.2 14:45:22 INFO - mozhttpd == 0.7 14:45:22 INFO - mozinfo == 0.9 14:45:22 INFO - mozleak == 0.1 14:45:22 INFO - mozlog == 3.1 14:45:22 INFO - moznetwork == 0.27 14:45:22 INFO - mozprocess == 0.22 14:45:22 INFO - mozprofile == 0.28 14:45:22 INFO - mozrunner == 6.11 14:45:22 INFO - mozscreenshot == 0.1 14:45:22 INFO - mozsystemmonitor == 0.0 14:45:22 INFO - moztest == 0.7 14:45:22 INFO - mozversion == 1.4 14:45:22 INFO - psutil == 3.1.1 14:45:22 INFO - requests == 1.2.3 14:45:22 INFO - wsgiref == 0.1.2 14:45:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:45:22 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')]} 14:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:22 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')]} 14:45:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:22 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 0x7f5800262f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26dd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276c410>, '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 0x276d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276d7a0>, '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': 'fa44defc139c4ba8574fe040000001db-1462484693.63716-1933703558', '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 14:45:22 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 14:45:22 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 14:45:22 INFO - Using env: {'DISPLAY': ':0', 14:45:22 INFO - 'HOME': '/home/cltbld', 14:45:22 INFO - 'LANG': 'en_US.UTF-8', 14:45:22 INFO - 'LANGUAGE': 'en_US:en', 14:45:22 INFO - 'LOGNAME': 'cltbld', 14:45:22 INFO - 'MAIL': '/var/mail/cltbld', 14:45:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:22 INFO - 'MOZ_NO_REMOTE': '1', 14:45:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:45:22 INFO - 'NO_EM_RESTART': '1', 14:45:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:45:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:45:22 INFO - 'PWD': '/builds/slave/test', 14:45:22 INFO - 'SHELL': '/bin/bash', 14:45:22 INFO - 'SHLVL': '1', 14:45:22 INFO - 'TERM': 'linux', 14:45:22 INFO - 'TMOUT': '86400', 14:45:22 INFO - 'USER': 'cltbld', 14:45:22 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1462484693.63716-1933703558', 14:45:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:22 INFO - '_': '/tools/buildbot/bin/python'} 14:45:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:22 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)) 14:45:22 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)) 14:45:22 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)) 14:45:22 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)) 14:45:22 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)) 14:45:22 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)) 14:45:22 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)) 14:45:22 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)) 14:45:22 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)) 14:45:22 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)) 14:45:22 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)) 14:45:22 INFO - Cleaning up... 14:45:22 INFO - Return code: 0 14:45:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:45:22 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')]} 14:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:22 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')]} 14:45:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:22 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 0x7f5800262f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26dd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276c410>, '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 0x276d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276d7a0>, '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': 'fa44defc139c4ba8574fe040000001db-1462484693.63716-1933703558', '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 14:45:22 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 14:45:22 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 14:45:22 INFO - Using env: {'DISPLAY': ':0', 14:45:22 INFO - 'HOME': '/home/cltbld', 14:45:22 INFO - 'LANG': 'en_US.UTF-8', 14:45:22 INFO - 'LANGUAGE': 'en_US:en', 14:45:22 INFO - 'LOGNAME': 'cltbld', 14:45:22 INFO - 'MAIL': '/var/mail/cltbld', 14:45:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:22 INFO - 'MOZ_NO_REMOTE': '1', 14:45:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:45:22 INFO - 'NO_EM_RESTART': '1', 14:45:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:45:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:45:22 INFO - 'PWD': '/builds/slave/test', 14:45:22 INFO - 'SHELL': '/bin/bash', 14:45:22 INFO - 'SHLVL': '1', 14:45:22 INFO - 'TERM': 'linux', 14:45:22 INFO - 'TMOUT': '86400', 14:45:22 INFO - 'USER': 'cltbld', 14:45:22 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1462484693.63716-1933703558', 14:45:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:22 INFO - '_': '/tools/buildbot/bin/python'} 14:45:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:23 INFO - Downloading/unpacking jsonschema 14:45:23 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 14:45:23 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 14:45:23 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 14:45:23 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 14:45:23 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 14:45:23 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 14:45:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:45:25 INFO - Downloading/unpacking functools32 (from jsonschema) 14:45:25 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 14:45:25 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 14:45:25 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 14:45:25 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 14:45:25 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 14:45:25 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 14:45:25 INFO - Downloading functools32-3.2.3-2.tar.gz 14:45:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:45:25 INFO - warning: no files found matching '*.txt' 14:45:25 INFO - no previously-included directories found matching 'build' 14:45:25 INFO - no previously-included directories found matching 'dist' 14:45:25 INFO - no previously-included directories found matching '.git*' 14:45:25 INFO - Installing collected packages: jsonschema, functools32 14:45:25 INFO - Running setup.py install for functools32 14:45:25 INFO - warning: no files found matching '*.txt' 14:45:25 INFO - no previously-included directories found matching 'build' 14:45:25 INFO - no previously-included directories found matching 'dist' 14:45:25 INFO - no previously-included directories found matching '.git*' 14:45:25 INFO - Successfully installed jsonschema functools32 14:45:25 INFO - Cleaning up... 14:45:25 INFO - Return code: 0 14:45:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:45: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')]} 14:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45: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')]} 14:45:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:25 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 0x7f5800262f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26dd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276c410>, '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 0x276d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276d7a0>, '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': 'fa44defc139c4ba8574fe040000001db-1462484693.63716-1933703558', '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 14:45:25 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 14:45:25 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 14:45:25 INFO - Using env: {'DISPLAY': ':0', 14:45:25 INFO - 'HOME': '/home/cltbld', 14:45:25 INFO - 'LANG': 'en_US.UTF-8', 14:45:25 INFO - 'LANGUAGE': 'en_US:en', 14:45:25 INFO - 'LOGNAME': 'cltbld', 14:45:25 INFO - 'MAIL': '/var/mail/cltbld', 14:45:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:25 INFO - 'MOZ_NO_REMOTE': '1', 14:45:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:45:25 INFO - 'NO_EM_RESTART': '1', 14:45:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:45:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:45:25 INFO - 'PWD': '/builds/slave/test', 14:45:25 INFO - 'SHELL': '/bin/bash', 14:45:25 INFO - 'SHLVL': '1', 14:45:25 INFO - 'TERM': 'linux', 14:45:25 INFO - 'TMOUT': '86400', 14:45:25 INFO - 'USER': 'cltbld', 14:45:25 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1462484693.63716-1933703558', 14:45:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:25 INFO - '_': '/tools/buildbot/bin/python'} 14:45:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:25 INFO - Downloading/unpacking flake8 14:45:25 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 14:45:25 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 14:45:25 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 14:45:25 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 14:45:25 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 14:45:25 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 14:45:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:45:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:45:27 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 14:45:27 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 14:45:27 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 14:45:27 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 14:45:27 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 14:45:27 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 14:45:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:45:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:45:27 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 14:45:27 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 14:45:27 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 14:45:27 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 14:45:27 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 14:45:27 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 14:45:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:45:28 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 14:45:28 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 14:45:28 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 14:45:28 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 14:45:28 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 14:45:28 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 14:45:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:45:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:45:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:45:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:45:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:45:28 INFO - no previously-included directories found matching 'docs/_build' 14:45:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:45:28 INFO - Running setup.py install for pep8 14:45:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:45:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:45:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:45:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:45:28 INFO - no previously-included directories found matching 'docs/_build' 14:45:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:45:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:45:28 INFO - Cleaning up... 14:45:28 INFO - Return code: 0 14:45:28 INFO - Running post-action listener: _resource_record_post_action 14:45:28 INFO - Running post-action listener: _start_resource_monitoring 14:45:28 INFO - Starting resource monitoring. 14:45:28 INFO - ##### 14:45:28 INFO - ##### Running install step. 14:45:28 INFO - ##### 14:45:28 INFO - Running pre-action listener: _resource_record_pre_action 14:45:28 INFO - Running main action method: install 14:45:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:45:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:45:28 INFO - Reading from file tmpfile_stdout 14:45:28 INFO - Detecting whether we're running mozinstall >=1.0... 14:45:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:45:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:45:28 INFO - Reading from file tmpfile_stdout 14:45:28 INFO - Output received: 14:45:28 INFO - Usage: mozinstall [options] installer 14:45:28 INFO - Options: 14:45:28 INFO - -h, --help show this help message and exit 14:45:28 INFO - -d DEST, --destination=DEST 14:45:28 INFO - Directory to install application into. [default: 14:45:28 INFO - "/builds/slave/test"] 14:45:28 INFO - --app=APP Application being installed. [default: firefox] 14:45:28 INFO - mkdir: /builds/slave/test/build/application 14:45:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:45:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:45:44 INFO - Reading from file tmpfile_stdout 14:45:44 INFO - Output received: 14:45:44 INFO - /builds/slave/test/build/application/firefox/firefox 14:45:44 INFO - Running post-action listener: _resource_record_post_action 14:45:44 INFO - ##### 14:45:44 INFO - ##### Running run-tests step. 14:45:44 INFO - ##### 14:45:44 INFO - Running pre-action listener: _resource_record_pre_action 14:45:44 INFO - Running main action method: run_tests 14:45:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:45:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:45:44 INFO - Python 2.7.3 14:45:44 INFO - Return code: 0 14:45:44 INFO - grabbing minidump binary from tooltool 14:45: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')]} 14:45:44 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 0x276c410>, '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 0x276d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276d7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:45:44 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 14:45:44 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 14:45:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:45:45 INFO - Return code: 0 14:45:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:45:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:45:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:45:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:45:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:45:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:45:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:45:45 INFO - Return code: 0 14:45:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GkvPTsqkRDqMgMTGHc7o6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 14:45:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GkvPTsqkRDqMgMTGHc7o6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 14:45:45 INFO - Using env: {'DISPLAY': ':0', 14:45:45 INFO - 'HOME': '/home/cltbld', 14:45:45 INFO - 'LANG': 'en_US.UTF-8', 14:45:45 INFO - 'LANGUAGE': 'en_US:en', 14:45:45 INFO - 'LOGNAME': 'cltbld', 14:45:45 INFO - 'MAIL': '/var/mail/cltbld', 14:45:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:45:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:45:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:45 INFO - 'MOZ_NO_REMOTE': '1', 14:45:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:45:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:45:45 INFO - 'NO_EM_RESTART': '1', 14:45:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:45:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:45:45 INFO - 'PWD': '/builds/slave/test', 14:45:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:45:45 INFO - 'SHELL': '/bin/bash', 14:45:45 INFO - 'SHLVL': '1', 14:45:45 INFO - 'TERM': 'linux', 14:45:45 INFO - 'TMOUT': '86400', 14:45:45 INFO - 'USER': 'cltbld', 14:45:45 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1462484693.63716-1933703558', 14:45:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:45 INFO - '_': '/tools/buildbot/bin/python'} 14:45:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GkvPTsqkRDqMgMTGHc7o6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 14:45:46 INFO - mozversion application_buildid: 20160505133104 14:45:46 INFO - mozversion application_changeset: 5fe67c44f537155ac01049024e1c9548ece1a012 14:45:46 INFO - mozversion application_display_name: Nightly 14:45:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:45:46 INFO - mozversion application_name: Firefox 14:45:46 INFO - mozversion application_remotingname: firefox 14:45:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:45:46 INFO - mozversion application_vendor: Mozilla 14:45:46 INFO - mozversion application_version: 49.0a1 14:45:46 INFO - mozversion platform_buildid: 20160505133104 14:45:46 INFO - mozversion platform_changeset: 5fe67c44f537155ac01049024e1c9548ece1a012 14:45:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:45:46 INFO - mozversion platform_version: 49.0a1 14:45:46 INFO - using testdate: 1462484746 14:45:46 INFO - actual date: 1462484746 14:45:46 INFO - starting webserver on 'localhost:49337' 14:45:46 INFO - SUITE-START | Running 2 tests 14:45:46 INFO - TEST-START | dromaeo_css 14:45:46 INFO - operating with platform_type : linux_ 14:45:46 INFO - Initialising browser for dromaeo_css test... 14:45:46 INFO - TEST-INFO | started process 11732 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx4kRxz/profile http://localhost:49337/getInfo.html) 14:45:50 INFO - PROCESS | 11732 | 14:45:50 INFO - PROCESS | 11732 | (process:11798): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:45:51 INFO - PROCESS | 11732 | __metrics Screen width/height:1600/1200 14:45:51 INFO - PROCESS | 11732 | colorDepth:24 14:45:51 INFO - PROCESS | 11732 | Browser inner width/height: 1024/697 14:45:51 INFO - PROCESS | 11732 | __metrics 14:45:51 ERROR - PROCESS | 11732 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2945: TypeError: this.tabs is undefined 14:45:52 INFO - TEST-INFO | 11732: exit 0 14:45:52 INFO - Browser initialized. 14:45:52 INFO - Running cycle 1/1 for dromaeo_css test... 14:45:52 INFO - TEST-INFO | started process 11850 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx4kRxz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:45:54 INFO - PROCESS | 11850 | 14:45:54 INFO - PROCESS | 11850 | (process:11910): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:46:04 INFO - PROCESS | 11850 | RSS: Main: 164552704 14:46:04 INFO - PROCESS | 11850 | 14:46:54 INFO - PROCESS | 11850 | 1462484814508 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] 14:49:06 INFO - PROCESS | 11850 | Cycle 1(1): loaded http://localhost:49337/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49337/tests/dromaeo/cssquery-ext.html) 14:49:07 INFO - PROCESS | 11850 | RSS: Main: 167448576 14:49:07 INFO - PROCESS | 11850 | 14:52:09 INFO - PROCESS | 11850 | Cycle 1(1): loaded http://localhost:49337/tests/dromaeo/cssquery-ext.html (next: http://localhost:49337/tests/dromaeo/cssquery-jquery.html) 14:52:10 INFO - PROCESS | 11850 | RSS: Main: 166621184 14:52:10 INFO - PROCESS | 11850 | 14:55:12 INFO - PROCESS | 11850 | Cycle 1(1): loaded http://localhost:49337/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49337/tests/dromaeo/cssquery-mootools.html) 14:55:13 INFO - PROCESS | 11850 | RSS: Main: 167886848 14:55:13 INFO - PROCESS | 11850 | 14:58:15 INFO - PROCESS | 11850 | Cycle 1(1): loaded http://localhost:49337/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49337/tests/dromaeo/cssquery-prototype.html) 14:58:15 INFO - PROCESS | 11850 | RSS: Main: 165474304 14:58:15 INFO - PROCESS | 11850 | 15:01:18 INFO - PROCESS | 11850 | Cycle 1(1): loaded http://localhost:49337/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49337/tests/dromaeo/cssquery-yui.html) 15:01:18 INFO - PROCESS | 11850 | RSS: Main: 166273024 15:01:18 INFO - PROCESS | 11850 | 15:04:21 INFO - PROCESS | 11850 | Cycle 1(1): loaded http://localhost:49337/tests/dromaeo/cssquery-yui.html (next: http://localhost:49337/tests/dromaeo/cssquery-dojo.html) 15:04:21 INFO - PROCESS | 11850 | RSS: Main: 168341504 15:04:21 INFO - PROCESS | 11850 | 15:04:21 INFO - PROCESS | 11850 | __start_tp_report 15:04:21 INFO - PROCESS | 11850 | _x_x_mozilla_page_load 15:04:21 INFO - PROCESS | 11850 | _x_x_mozilla_page_load_details 15:04:21 INFO - PROCESS | 11850 | |i|pagename|runs| 15:04:21 INFO - PROCESS | 11850 | |0;dojo.html;2702.5405681034226;2745.3273947882767;2746.7527922486984;2752.1330780804033;2763.69599344072;4778.952210477894;4785.210440277355;4809.350737650416;4882.8779280518;4958.330625365575;4757.524247575249;4818.590419814312;4834.854954351366;4874.049560335736;4874.902501949959;4410.911781764363;4446.421965144526;4450.154470650582;4491.887702807423;4500.874781304674;4476.440444944382;4501.5273396293405;4535.795889184995;4540.525413649569;4589.173948689235;4416.977915110404;4473.619742321906;4477.149341625113;4493;4569.246074397737;4475.172093162775;4481;4503.0768692418305;4512.345709872083;4533.54664533544;4463.531329210418;4478;4478.529754375776;4516.23224051912;4550;4593.311003349524;4606.332081848113;4645.512221216791;4686.133065382881;4730.574248317668;5045.823396181116;5060.2156665716875;5063.518965698289;5078.5937125029905;5158.277841102249;5123.257127716498;5140.665856719339;5141.15170996785;5154.355705536808;5154.53609175176;4810.6151507879285;4887.486813884527;4916.827911023169;4926.408830940239;4929.112759703216;5369.6509726867625;5385;5387.299651045339;5388.164834450667;5388.326459192601;4972.8508144755715;5021.447640759514;5185.429602743695;5186.792528298901;5192.818251361185;5094.1849304111165;5094.465081166498;5137.691738495702;5138.203578445347;5191.5846732261325;5070.138076527;5082.720450375191;5094.1849304111165;5105.5149760772665;5148.304978827885;5009.799608015638;5036.143855544567;5065.670731402521;5082.872928176826;5099.209622508517;4376.124775045004;4396.538363471854;4421.53573874745;4422.181896349186;4423.159599676115;3820.0449887528116;3823.330917089498;3855.9228815423535;3862.1503269280715;3862.613738626115;4365.80353884076;4456.220161471794;4460.130274596422;4466.173757854807;4517.6160026397465;5122.103631864484;5149.304843846107;5149.639525233272;5149.897002059938;5153.201253805666;4440.4671439427475;4452.755098469615;4467.843625473158;4476.194285028661;4496.775161241925;4630.536946305342;4681.227597446451;4702.177119004161;4724.622030237572;4740.14677358072;4942.258661200777;4977.800887964441;5002.324686167321;5022.673526220784;5065.974670126626;5304.628675992643;5326.142758170347;5356.062689029326;5359.973200133974;5407.297051383295;4760.500147484464;4868.513148685103;4894.119058569491;5005.149124648891;5030.924536131888;5077.111505486451;5093.4651861555485;5125.7693403796175;5128.410232823273;5182.948170518246;5227.817026404057;5234.345706786652;5245.527902488641;5249.448807875118;5277.709725965109;4937.284093806306;4960.355153829979;5074.035933172685;5092.108880945893;5102.2346648003095;4985.227289769947;4996.575291100297;5017.3226614406585;5022.271770593316;5044.772985215747;4980.103581355391;4997.200447928314;5000.12497812874;5011.548960593418;5040.243963405372;5039.496050394931;5076.568491678101;5080.187170052774;5112.9744351278005;5124.205748109049;4980.825671101494;5037.622178336713;5042.773075211551;5048.116579598629;5082.745862706776 15:04:21 INFO - PROCESS | 11850 | |1;ext.html;560.9831705048847;600.6576251536625;608.1516284782725;622.2408661433055;626.8338890194098;38942;40241.195176096495;40295.39556906649;40295.59704402955;40355.39466907995;39784.80107599458;40309.39535906957;40611.59388406115;40720.59279407205;40745;8053.114157442691;8148.6333115009675;8177;8180.754577362689;8184.140665230155;7942.761717148466;8091.231333023354;8099.51402915824;8130.227628375294;8169.550674712888;8138;8184.2224988625985;8194.713185038525;8207.917920820804;8234.752957411287;8141.959290203541;8152.6331315090665;8153;8155.918440815575;8170.42807003507;7957.482763620404;8088.433809633328;8090.555019473926;8096.352291816641;8098.987626546682;37733.81133094344;37893.43159852605;38058;38129.23741525154;38136.42795358072;3277.737780977516;3503.439449688063;3834.386498160281;3847.172857835551;3965.5836137205465;27727.890884364602;30246.99669374492;30566.84716576425;30759.38481230385;30854.537181942287;3190.1546090286092;3254.08885512057;3360.915977100592;3419.145213696576;3461.8442170102408;267205;268552;269935;270056;270461;53762;59887;60359.69820150871;61883;62066.37933620696;62613.68693156505;63104;63207.36792632015;63299.36700633027;63518.682406588596;14740.410383584536;14817.185054822088;14850.960432769818;14881.33034013472;14891.106533608017;11318.490667919963;11362.602308919148;11399.544018239343;11428.428578571038;11434.199606027498;19680.311189108314;19887.801121988883;20184.293549725688;20201.090950907244;20340.186392544427;6999.510034297652;7246.855062898712;7312.451566132561;7326.377257933029;7440.55356678601;899.6626265150569;924.3621900888365;967.6129548180643;985.5466485416789;1008.5310330696115;28590.857045714638;29596;29911.252218694706;30214.395712085636;30358.392832143232;960.951952402391;1020.9285350025427;1022.1873610479687;1040.958361665525;1060.3531845574194;15045.247737613076;15165;15423.151726655142;15537.611559711098;15655.530334089995;352789;357086;359213;359229;361200;53489.73255133777;54084;54331.72834135804;54620.45379546233;54637;1281.6988007818156;1316.1116246533552;1323.7617228898698;1331.1347624044256;1336.3652265173964;27173.728262717912;27697.169084927486;28333.433331332846;28475.572866406605;28872.566911496764;45296.32055519236;45594.77202613965;45782.31326530038;45834.77082614566;45876.77061614671;244431;249463;249534;249784;250712;26499.337516562242;26873.193804185907;27028.45943081167;27140.45719085647;27159.321016974733;44712.77643611761;45800.77099614614;46062.539374607164;46449.30326045045;46752;38213.61786382212;38548.42177367398;38621.6137838618;38931.805340973115;39081.80459097686;37912.24175516419;38216.80891595635;38427.23145537129;38494.230115398095;39432.21135577215;33730;34813.47779783356;38560.42159367668;38680.2263954725;39102.4134637975;33851;34592.48111278282;34823;35158.29683406369;35182.29635407329;26713.732862671903;26945.191644250703;27018.189454315616;27164.456710865277;27200.319992000357 15:04:21 INFO - PROCESS | 11850 | |2;jquery.html;373.1306056887453;373.85606541481536;376.42219193537926;385.3295266236747;392.01017430986735;16029.519114426572;16702.496775290223;17191.023032351284;17480.562985925357;17554.561135971606;10131.493425328741;10491.42297173655;10503;10526.42104684242;10541.78916421671;4587.15137699525;4774.856754297377;4791.928121078186;5157.948420515803;5185.196294574328;5075.543201111899;5101.617378696613;5106.285120083191;5153.742312884359;5156.123459011977;4932.778024988884;5086.084504789136;5102.515261050195;5305.549028332577;5306.071437498442;5271.736413179326;5301.125314323171;5310.203469479589;5313.548348390392;5325.4142044375085;4490.730556166641;4633.559811817872;4665.510121437234;4669.112868554964;4782.234842425195;12004.279743215435;12411.503539858395;12435.813462798065;12448.439820208112;12612.054095942749;1934.1006432009042;1938.9612207755765;1941.9513462730108;2023.3828682251908;2201.2955854126685;8959.059298773665;9021.639134434614;9032.141946515136;9100.499472529009;9108.772280692969;1774.6539424812167;1790.7492950986873;1805.1876655504943;1815.0833828916313;1893.1480833624923;49524.25713614262;60163.39836601622;61144;68317.3168268316;71730.64134679294;9725.708228753148;9746.366486178376;10186;10222.182225421948;10233.92543782907;13921;13995.090319129224;14046.71906561863;14057.01600887928;14102.71794564103;7348.559086454829;7506.099268087864;7544.698212071456;7708;7771.288103244111;7250.4199664026755;7285.380742636935;7380.298871607189;7553.433492487976;7574.394048476219;4282.143571285756;4371.404437380397;4450.599446049871;4459.643228541709;4507.481639611421;1803.2967142814314;1818.6362727454562;1827.570520927581;1831.102759647763;1878.4928069421453;835.4820011592851;929.8744669469535;991.7619771254991;992.1120597065731;995.8207522645848;16768.496945091665;17024.953445065177;17503.29986800514;17704.822951770577;17785;904.4618452021037;909.4043401571981;940.7507010642186;948.8576713492894;984.2372161574837;9337.813243735087;9813.803723925625;9821.459819709842;9942.105210531086;10043.548040338203;386306;404022;405494;405918;407715;74355.25644743591;75603.62198189084;75715.62142189364;77521;78972.26166430033;939.5865819039601;942.9905700942903;964.0600414595713;975.3026585990908;986.2159583131428;15136.394544218108;15159.696806064037;15192.240387980335;15288.388464461297;15704.371825126867;34109.82945085259;34423.65576344305;34488.13779655529;34541;35803.641963580034;47887.281690775366;48175.5182448171;48530.5146948526;48545.27182092342;48710;7359.521631093961;7474.813129671802;7582.54504729718;7802.804929876572;7838.294553490213;9827.656032038843;10563.524641391003;11424.143189260672;11547.364894930859;11754.588589399329;9437.150656440954;9794.706158815246;9874.308798384043;9945;9985.800283994426;9685.273604479833;9845.901540984498;9902.405855648683;9937.453440060866;10020.298579099393;9756.170725488413;9937.155341796028;10168.28821982454;10214;10401.42792146409;7658.502197357154;7703.191164927826;7772.883406749016;7778.533288002738;7790.1041380241995;9114.680986165718;9801;9923.851142232728;10004.849927251242;10539.525721342712 15:04:21 INFO - PROCESS | 11850 | |3;mootools.html;1536.4391996921124;1539.9999999999995;1717.4246627379828;1811.5471132216946;1828.6342731453703;6661.10075139856;7168.462365322602;7305.342519173273;7672.53964762114;7676.50102743322;7520;7724.2661947115075;7781.572013539253;7791.259830316125;7807.5315481071175;2146.914123435061;2187.9671804922937;2191.298784388996;2191.485001024758;2200.4058904095887;2161.027537608075;2192.3861318830754;2200.867947923122;2207.2054060538194;2207.94480137997;2167.6423390140685;2168.29530402619;2178.8474806763534;2187.103287652063;2200.526886719355;2131.435169680036;2133.1893880325533;2138.8395870309787;2139.2833400810746;2142.967855482161;2127.0428307261795;2136.8717876927435;2140.914363425461;2141.0900367343816;2168.8481806273567;7727.574983375912;7766.57283849388;7766.961165194138;7772.7668169954995;7791.8441631167625;4460.553944605546;4559.703619264737;4562.041971186055;4562.406887104688;4594.885127871797;2775.8473283969374;2791.8185317954267;2945.955810662842;2946.3959888223076;2955.674875763664;920.6501529418845;944.8346539355585;954.9809003819954;961.8845738511353;970.1365784451843;9704.12662860339;9994.500274986221;10010.49947502622;10181.592736290539;10268.43523606194;3814.771113733185;3861.3821788514265;3892.591277915778;3924.077841707254;3933.272344616255;8052;8062.234087761653;8070.192980702001;8072.636731347104;8090.797730056795;4348.108637729258;4360.324149756792;4442.800073996678;4497.820087196541;4506.324051392252;3490.3019396120876;4114.238865809834;4126.504819421629;4132.070284186094;4246.087091275391;3375.9831200843837;3438.6561343865915;3488.302339532104;3512.929741405209;3527.0476971217627;1014.5535964175739;1029.7191720339483;1040.4693606260862;1043.7286305560458;1050.3855244681947;865.2126564825978;882.6248844241172;886.2998231397253;910.6858133943779;922.7554698005034;5327.227552004938;5341.946580534222;5395.7841686332895;5532.114861622121;5648.181013752983;414.2874256279195;420.2100051902404;434.48296527133243;435.075464637645;435.78646463232786;3579.6062433132333;3605.2428989911887;3657.524521812147;3692.095436618046;3718.1076541630355;9157.130072643089;9434.622615095457;9440.858387124199;9485.051494850597;9519.619215231452;9266.490343031199;9376.156145946761;9413.76465588352;9441.055894410503;9441.90558094424;7175.677094530759;7204.207537170907;7273.127224733066;7320.853582928312;7394.889076663854;5289.836236028068;5314.256004159343;5349.732513374393;5440.483154100354;5575.526080283222;8662.653493860174;8718.128187181232;8778.03441621434;8788.16512431318;8824.911750882666;8295.668173273001;8664.263537599123;8754.91245087541;8882.955585222033;8929.374943753875;6094.2077529920825;6503.837404064936;6689.832754181184;6739.157605299338;6805.795826125224;7477.775666730006;7506.361959233526;7508.474406791473;7540.924590754242;7576.621168941641;6712.093867327848;6862.279460656559;6864.7940561783225;6950.339717726808;6985.511014228955;6720.865582688417;6776.559523630948;6782.491313151435;6812.693428795816;6828.351306625863;6409.070684750778;6419.903701444388;6486;6500.414962653384;6529.967350163219;4652.278896771006;4711.905761884812;4736.8578942631775;4737.786799594095;4776.785044672929;4694.366260554782;4758.976205118952;4803.013811646834;4820;4857.708537487762 15:04:21 INFO - PROCESS | 11850 | |4;prototype.html;301.3701364148929;304.162033597439;305.76608894195937;310.4210647143076;311.3321924472006;4986.152354099802;4995.125852975724;5023.974880125595;5024.547790698836;5076.796928122875;4953.108440480712;4970.8318545141865;4979.302897594331;4994.375703037121;5033.068882256776;3683.668469837714;3795.405929509599;3857.9807100964454;3870.3550990828926;3897.512810898638;3866.2654095721723;3888.727789054767;3890.280298144838;3890.961090389088;3896.376579747241;3814.389697648377;3833.5783063862955;3835.657519868038;3838.7312888097704;3844;3787.223619158066;3824.3880979043497;3863.864764733235;3871.1676989447406;3905.7265991380614;3407.9659203407896;3425.6745609167087;3447.7414193935556;3450.913727156816;3453.6028356739043;4757.167495688241;4783.258594917758;4790.712557246577;4792.185328494164;4806.855794326176;4451.354553589711;4473.926257698162;4481.0955343979;4486.371907932892;4498.257787465064;4935.321990523239;5279.155335146358;5296.390915044781;5302.522772950414;5310.858165494437;3667.6699097081123;3692.298463291966;3692.7968961707097;3696.2792255510185;3703.6481684185346;5412.4587541245955;5416.864578385533;5442.265294185274;5465.234867118646;5490.91763623542;3656.8902932912056;3746.7189960753053;3764.981175094107;3771.5097037384962;3775.7923314217983;3792.7345085844277;3820.140468394589;3822.522184726909;3824.1395685970433;3828.712846536521;4395.604395604411;4399.296112622029;4418.5802348776815;4433.049458238364;4440.845380201106;5033.521815427529;5180.948190518122;5195.636305458657;5220.295260139908;5292.894142117136;1284.4862055177816;1312.9540466083831;1316.9473221071241;1319.1030099532218;1319.9538016169388;817.8323443694028;852.0244320253399;887.60057973912;891.3760367742606;896.6013019689306;4551.795169217393;4617.284320930261;4626.745528995937;4647.488776234612;4650.093231819763;5393.973030134903;5417.485338892799;5448.346198456132;5458.426865179178;5490.231367608538;4419.381286619876;4602.723836569817;4612.192866248393;4620.768961551909;4659.324397962277;2829.7877659175233;2862.141357592714;2873.5689646553183;2882.5820256062752;2904.9854750726113;4977.253411988231;5070.225421102585;5074.695518268915;5091.592672586185;5105.285260063594;5251.4485978972425;5402.839338986737;5413.404525502192;5421.74695182895;5520.420355862657;5116.590672746172;5125.256837758504;5138.584865113391;5154.768035438415;5182.507661772125;5497.312835895513;5508.504234618904;5521.337439507285;5547;5555.055730494295;5210.817621383233;5352.785888564414;5386.48828361305;5410.3778065522965;5417.431169727122;5172.818951336685;5180.792768289226;5181.145111056633;5186.844394668166;5202.843914682566;3792.5259342582176;3795.1840354323954;3805.828737706865;3813.8283777229535;3829.5978922212767;5327.653702509325;5436.374816896107;5458.7444887675265;5465.836024919259;5483.424240454695;5216.295800066942;5275.182346736262;5282.81510147143;5289.492494639009;5303.814366497154;5215.243789650403;5220;5260.185236093542;5268.710220937885;5272.340957380327;4990.675606085593;5133.486651334837;5196.558292545176;5222.616006758288;5231;5104.897902041864;5175.353080864892;5323.361196656426;5345.599080069088;5353.54494867925;5151.819686311111;5159.845204643867;5166.509181627739;5198.714070726146;5211.921821172761 15:04:21 INFO - PROCESS | 11850 | |5;yui.html;689.6586189836032;711.2602892991287;750.264740554257;791.4024911192051;793.8690116130836;11981.580644677439;12500.687482812935;12680.556180533684;12698.80951785724;12707.491700331975;13080.803787943189;13562.050656454052;13563.728725425486;14120.929395353034;14164.858351416482;876.412803421709;876.7063033883657;877.6928075173702;880.5509190312954;882.2985726347537;685.468761709674;856.5802756649259;859.7678626770768;860.7675927499571;861.8319427711599;924.0990034716165;925.9212966897788;926.3839546701436;927.8469052606312;930.0931591698074;918.4902379179553;918.6555041859302;918.7794929217007;919.4483310014004;921.3642586615281;669.0666520204288;671.0772687554612;672.3209558346057;672.7174586673609;673.0140344395435;12388.566400176041;12400.56598019065;12411.503539858395;12441.688957776038;12451.066170037284;12501.3749312534;12546.874531254753;12615.116941814076;12877.935610321982;13049.478020879153;10007.249456290807;10015.549300281506;10422.062014418738;10481.213908956859;10884.727881802939;3221.1463962050075;3259.5110733389943;3292.27569934614;3356.110630682871;3410.6418826023405;39928.800355998326;40122.79938600318;40208;43779.78110109429;45933.54066459326;9632.373895696757;9733.464659443798;9763.902360976299;9952.80094398108;10052.346597471287;17274.309027638752;17276.827231727522;17296.654066918592;17300.22149003298;17305.13474326304;6837.1111755471475;6843.520953533205;6916.100906882073;6967.372936435745;7036.6481675916;3610.332088563624;3651.744377893522;3739.1132224861117;3739.775613463201;3780.6219378061974;2751.8073734838767;2849.7435230829324;2861.9427611448073;2876.0796545105363;2893.5225687761704;513.1584201908872;519.2574618295873;520.6199474383722;523.7538356972217;529.5049129064337;582.6300299309969;636.7583212735185;648.0214875537972;656.3764423797317;661.9635920024349;7678.769636910902;7922.564258965812;7956.283934445928;8007.759767206993;8024.398170137147;601.1493736363085;608.1353001674385;608.2214765100679;622.791364892757;649.4674367018999;3666.7983260920905;3751.718621103428;3808.3716186829415;3838.4626152338697;3887.7084218683144;44605.10789784186;46589.76705116453;46862.76568617203;51114.74442627763;51958.480415195365;45139.54860451419;45694.771526142154;45968.3104753429;46092;47069.52930470651;43102.784486077995;43650.56349436465;43724.344134838;44064.339034914505;44102.55897441049;7901.525908445512;8052.83894322122;8233;8349.499030058216;8624.09447008055;29691.109266722033;29996.70003299939;30215.546766798077;30305.090847274616;30960.380792384476;37730.8113459431;37750.2449951005;37930.81034594809;38070.61929380671;38342.42486362651;10553.577856885639;10601.787964240826;10893.782124357627;10905.618303359344;11056.723581910517;10939.671809845717;11243.66269011931;11598.47806848677;12017.158798883995;12163.209391389531;10692.14462842955;10795.19036072282;10972.286801357886;11082.778344432905;11375.772484550098;11225.494852731483;11245.71885702864;11395.373254471084;11795.882041179479;11863.110266729856;10869.891301086887;10958.780824383628;11008.614698485515;11216.93439123282;11222.607208747655;8643.438176518506;8670.13298670128;8739.300855931637;8764.91235087641;8819.514926679094;8738.563071846509;9186.816263674555;9205.447673139633;9301.395409298373;9395.154436100784 15:04:21 INFO - PROCESS | 11850 | __end_tp_report 15:04:21 INFO - PROCESS | 11850 | __start_cc_report 15:04:21 INFO - PROCESS | 11850 | _x_x_mozilla_cycle_collect,390 15:04:21 INFO - PROCESS | 11850 | __end_cc_report 15:04:21 INFO - PROCESS | 11850 | __startTimestamp1462485861662__endTimestamp 15:04:21 INFO - PROCESS | 11850 | 15:04:21 INFO - PROCESS | 11850 | ------- Summary: start ------- 15:04:21 INFO - PROCESS | 11850 | Number of tests: 6 15:04:21 INFO - PROCESS | 11850 | 15:04:21 INFO - PROCESS | 11850 | [#0] dojo.html Cycles:165 Average:4796.07 Median:4977.80 stddev:495.87 (10.0%) stddev-sans-first:469.41 15:04:21 INFO - PROCESS | 11850 | Values: 2702.5 2745.3 2746.8 2752.1 2763.7 4779.0 4785.2 4809.4 4882.9 4958.3 4757.5 4818.6 4834.9 4874.0 4874.9 4410.9 4446.4 4450.2 4491.9 4500.9 4476.4 4501.5 4535.8 4540.5 4589.2 4417.0 4473.6 4477.1 4493.0 4569.2 4475.2 4481.0 4503.1 4512.3 4533.5 4463.5 4478.0 4478.5 4516.2 4550.0 4593.3 4606.3 4645.5 4686.1 4730.6 5045.8 5060.2 5063.5 5078.6 5158.3 5123.3 5140.7 5141.2 5154.4 5154.5 4810.6 4887.5 4916.8 4926.4 4929.1 5369.7 5385.0 5387.3 5388.2 5388.3 4972.9 5021.4 5185.4 5186.8 5192.8 5094.2 5094.5 5137.7 5138.2 5191.6 5070.1 5082.7 5094.2 5105.5 5148.3 5009.8 5036.1 5065.7 5082.9 5099.2 4376.1 4396.5 4421.5 4422.2 4423.2 3820.0 3823.3 3855.9 3862.2 3862.6 4365.8 4456.2 4460.1 4466.2 4517.6 5122.1 5149.3 5149.6 5149.9 5153.2 4440.5 4452.8 4467.8 4476.2 4496.8 4630.5 4681.2 4702.2 4724.6 4740.1 4942.3 4977.8 5002.3 5022.7 5066.0 5304.6 5326.1 5356.1 5360.0 5407.3 4760.5 4868.5 4894.1 5005.1 5030.9 5077.1 5093.5 5125.8 5128.4 5182.9 5227.8 5234.3 5245.5 5249.4 5277.7 4937.3 4960.4 5074.0 5092.1 5102.2 4985.2 4996.6 5017.3 5022.3 5044.8 4980.1 4997.2 5000.1 5011.5 5040.2 5039.5 5076.6 5080.2 5113.0 5124.2 4980.8 5037.6 5042.8 5048.1 5082.7 15:04:21 INFO - PROCESS | 11850 | 15:04:21 INFO - PROCESS | 11850 | [#1] ext.html Cycles:180 Average:46504.72 Median:38215.21 stddev:77495.28 (202.8%) stddev-sans-first:77635.89 15:04:21 INFO - PROCESS | 11850 | Values: 561.0 600.7 608.2 622.2 626.8 38942.0 40241.2 40295.4 40295.6 40355.4 39784.8 40309.4 40611.6 40720.6 40745.0 8053.1 8148.6 8177.0 8180.8 8184.1 7942.8 8091.2 8099.5 8130.2 8169.6 8138.0 8184.2 8194.7 8207.9 8234.8 8142.0 8152.6 8153.0 8155.9 8170.4 7957.5 8088.4 8090.6 8096.4 8099.0 37733.8 37893.4 38058.0 38129.2 38136.4 3277.7 3503.4 3834.4 3847.2 3965.6 27727.9 30247.0 30566.8 30759.4 30854.5 3190.2 3254.1 3360.9 3419.1 3461.8 267205.0 268552.0 269935.0 270056.0 270461.0 53762.0 59887.0 60359.7 61883.0 62066.4 62613.7 63104.0 63207.4 63299.4 63518.7 14740.4 14817.2 14851.0 14881.3 14891.1 11318.5 11362.6 11399.5 11428.4 11434.2 19680.3 19887.8 20184.3 20201.1 20340.2 6999.5 7246.9 7312.5 7326.4 7440.6 899.7 924.4 967.6 985.5 1008.5 28590.9 29596.0 29911.3 30214.4 30358.4 961.0 1020.9 1022.2 1041.0 1060.4 15045.2 15165.0 15423.2 15537.6 15655.5 352789.0 357086.0 359213.0 359229.0 361200.0 53489.7 54084.0 54331.7 54620.5 54637.0 1281.7 1316.1 1323.8 1331.1 1336.4 27173.7 27697.2 28333.4 28475.6 28872.6 45296.3 45594.8 45782.3 45834.8 45876.8 244431.0 249463.0 249534.0 249784.0 250712.0 26499.3 26873.2 27028.5 27140.5 27159.3 44712.8 45800.8 46062.5 46449.3 46752.0 38213.6 38548.4 38621.6 38931.8 39081.8 37912.2 38216.8 38427.2 38494.2 39432.2 33730.0 34813.5 38560.4 38680.2 39102.4 33851.0 34592.5 34823.0 35158.3 35182.3 26713.7 26945.2 27018.2 27164.5 27200.3 15:04:21 INFO - PROCESS | 11850 | 15:04:21 INFO - PROCESS | 11850 | [#2] jquery.html Cycles:180 Average:23842.41 Median:48627.64 stddev:66200.29 (136.1%) stddev-sans-first:66362.55 15:04:21 INFO - PROCESS | 11850 | Values: 373.1 373.9 376.4 385.3 392.0 16029.5 16702.5 17191.0 17480.6 17554.6 10131.5 10491.4 10503.0 10526.4 10541.8 4587.2 4774.9 4791.9 5157.9 5185.2 5075.5 5101.6 5106.3 5153.7 5156.1 4932.8 5086.1 5102.5 5305.5 5306.1 5271.7 5301.1 5310.2 5313.5 5325.4 4490.7 4633.6 4665.5 4669.1 4782.2 12004.3 12411.5 12435.8 12448.4 12612.1 1934.1 1939.0 1942.0 2023.4 2201.3 8959.1 9021.6 9032.1 9100.5 9108.8 1774.7 1790.7 1805.2 1815.1 1893.1 49524.3 60163.4 61144.0 68317.3 71730.6 9725.7 9746.4 10186.0 10222.2 10233.9 13921.0 13995.1 14046.7 14057.0 14102.7 7348.6 7506.1 7544.7 7708.0 7771.3 7250.4 7285.4 7380.3 7553.4 7574.4 4282.1 4371.4 4450.6 4459.6 4507.5 1803.3 1818.6 1827.6 1831.1 1878.5 835.5 929.9 991.8 992.1 995.8 16768.5 17025.0 17503.3 17704.8 17785.0 904.5 909.4 940.8 948.9 984.2 9337.8 9813.8 9821.5 9942.1 10043.5 386306.0 404022.0 405494.0 405918.0 407715.0 74355.3 75603.6 75715.6 77521.0 78972.3 939.6 943.0 964.1 975.3 986.2 15136.4 15159.7 15192.2 15288.4 15704.4 34109.8 34423.7 34488.1 34541.0 35803.6 47887.3 48175.5 48530.5 48545.3 48710.0 7359.5 7474.8 7582.5 7802.8 7838.3 9827.7 10563.5 11424.1 11547.4 11754.6 9437.2 9794.7 9874.3 9945.0 9985.8 9685.3 9845.9 9902.4 9937.5 10020.3 9756.2 9937.2 10168.3 10214.0 10401.4 7658.5 7703.2 7772.9 7778.5 7790.1 9114.7 9801.0 9923.9 10004.8 10539.5 15:04:21 INFO - PROCESS | 11850 | 15:04:21 INFO - PROCESS | 11850 | [#3] mootools.html Cycles:180 Average:5047.44 Median:5334.59 stddev:2785.00 (52.2%) stddev-sans-first:2780.32 15:04:21 INFO - PROCESS | 11850 | Values: 1536.4 1540.0 1717.4 1811.5 1828.6 6661.1 7168.5 7305.3 7672.5 7676.5 7520.0 7724.3 7781.6 7791.3 7807.5 2146.9 2188.0 2191.3 2191.5 2200.4 2161.0 2192.4 2200.9 2207.2 2207.9 2167.6 2168.3 2178.8 2187.1 2200.5 2131.4 2133.2 2138.8 2139.3 2143.0 2127.0 2136.9 2140.9 2141.1 2168.8 7727.6 7766.6 7767.0 7772.8 7791.8 4460.6 4559.7 4562.0 4562.4 4594.9 2775.8 2791.8 2946.0 2946.4 2955.7 920.7 944.8 955.0 961.9 970.1 9704.1 9994.5 10010.5 10181.6 10268.4 3814.8 3861.4 3892.6 3924.1 3933.3 8052.0 8062.2 8070.2 8072.6 8090.8 4348.1 4360.3 4442.8 4497.8 4506.3 3490.3 4114.2 4126.5 4132.1 4246.1 3376.0 3438.7 3488.3 3512.9 3527.0 1014.6 1029.7 1040.5 1043.7 1050.4 865.2 882.6 886.3 910.7 922.8 5327.2 5341.9 5395.8 5532.1 5648.2 414.3 420.2 434.5 435.1 435.8 3579.6 3605.2 3657.5 3692.1 3718.1 9157.1 9434.6 9440.9 9485.1 9519.6 9266.5 9376.2 9413.8 9441.1 9441.9 7175.7 7204.2 7273.1 7320.9 7394.9 5289.8 5314.3 5349.7 5440.5 5575.5 8662.7 8718.1 8778.0 8788.2 8824.9 8295.7 8664.3 8754.9 8883.0 8929.4 6094.2 6503.8 6689.8 6739.2 6805.8 7477.8 7506.4 7508.5 7540.9 7576.6 6712.1 6862.3 6864.8 6950.3 6985.5 6720.9 6776.6 6782.5 6812.7 6828.4 6409.1 6419.9 6486.0 6500.4 6530.0 4652.3 4711.9 4736.9 4737.8 4776.8 4694.4 4759.0 4803.0 4820.0 4857.7 15:04:21 INFO - PROCESS | 11850 | 15:04:21 INFO - PROCESS | 11850 | [#4] prototype.html Cycles:180 Average:4351.55 Median:4988.41 stddev:1279.29 (25.6%) stddev-sans-first:1246.24 15:04:21 INFO - PROCESS | 11850 | Values: 301.4 304.2 305.8 310.4 311.3 4986.2 4995.1 5024.0 5024.5 5076.8 4953.1 4970.8 4979.3 4994.4 5033.1 3683.7 3795.4 3858.0 3870.4 3897.5 3866.3 3888.7 3890.3 3891.0 3896.4 3814.4 3833.6 3835.7 3838.7 3844.0 3787.2 3824.4 3863.9 3871.2 3905.7 3408.0 3425.7 3447.7 3450.9 3453.6 4757.2 4783.3 4790.7 4792.2 4806.9 4451.4 4473.9 4481.1 4486.4 4498.3 4935.3 5279.2 5296.4 5302.5 5310.9 3667.7 3692.3 3692.8 3696.3 3703.6 5412.5 5416.9 5442.3 5465.2 5490.9 3656.9 3746.7 3765.0 3771.5 3775.8 3792.7 3820.1 3822.5 3824.1 3828.7 4395.6 4399.3 4418.6 4433.0 4440.8 5033.5 5180.9 5195.6 5220.3 5292.9 1284.5 1313.0 1316.9 1319.1 1320.0 817.8 852.0 887.6 891.4 896.6 4551.8 4617.3 4626.7 4647.5 4650.1 5394.0 5417.5 5448.3 5458.4 5490.2 4419.4 4602.7 4612.2 4620.8 4659.3 2829.8 2862.1 2873.6 2882.6 2905.0 4977.3 5070.2 5074.7 5091.6 5105.3 5251.4 5402.8 5413.4 5421.7 5520.4 5116.6 5125.3 5138.6 5154.8 5182.5 5497.3 5508.5 5521.3 5547.0 5555.1 5210.8 5352.8 5386.5 5410.4 5417.4 5172.8 5180.8 5181.1 5186.8 5202.8 3792.5 3795.2 3805.8 3813.8 3829.6 5327.7 5436.4 5458.7 5465.8 5483.4 5216.3 5275.2 5282.8 5289.5 5303.8 5215.2 5220.0 5260.2 5268.7 5272.3 4990.7 5133.5 5196.6 5222.6 5231.0 5104.9 5175.4 5323.4 5345.6 5353.5 5151.8 5159.8 5166.5 5198.7 5211.9 15:04:21 INFO - PROCESS | 11850 | 15:04:21 INFO - PROCESS | 11850 | [#5] yui.html Cycles:180 Average:12618.52 Median:43687.45 stddev:13919.24 (31.9%) stddev-sans-first:13929.46 15:04:21 INFO - PROCESS | 11850 | Values: 689.7 711.3 750.3 791.4 793.9 11981.6 12500.7 12680.6 12698.8 12707.5 13080.8 13562.1 13563.7 14120.9 14164.9 876.4 876.7 877.7 880.6 882.3 685.5 856.6 859.8 860.8 861.8 924.1 925.9 926.4 927.8 930.1 918.5 918.7 918.8 919.4 921.4 669.1 671.1 672.3 672.7 673.0 12388.6 12400.6 12411.5 12441.7 12451.1 12501.4 12546.9 12615.1 12877.9 13049.5 10007.2 10015.5 10422.1 10481.2 10884.7 3221.1 3259.5 3292.3 3356.1 3410.6 39928.8 40122.8 40208.0 43779.8 45933.5 9632.4 9733.5 9763.9 9952.8 10052.3 17274.3 17276.8 17296.7 17300.2 17305.1 6837.1 6843.5 6916.1 6967.4 7036.6 3610.3 3651.7 3739.1 3739.8 3780.6 2751.8 2849.7 2861.9 2876.1 2893.5 513.2 519.3 520.6 523.8 529.5 582.6 636.8 648.0 656.4 662.0 7678.8 7922.6 7956.3 8007.8 8024.4 601.1 608.1 608.2 622.8 649.5 3666.8 3751.7 3808.4 3838.5 3887.7 44605.1 46589.8 46862.8 51114.7 51958.5 45139.5 45694.8 45968.3 46092.0 47069.5 43102.8 43650.6 43724.3 44064.3 44102.6 7901.5 8052.8 8233.0 8349.5 8624.1 29691.1 29996.7 30215.5 30305.1 30960.4 37730.8 37750.2 37930.8 38070.6 38342.4 10553.6 10601.8 10893.8 10905.6 11056.7 10939.7 11243.7 11598.5 12017.2 12163.2 10692.1 10795.2 10972.3 11082.8 11375.8 11225.5 11245.7 11395.4 11795.9 11863.1 10869.9 10958.8 11008.6 11216.9 11222.6 8643.4 8670.1 8739.3 8764.9 8819.5 8738.6 9186.8 9205.4 9301.4 9395.2 15:04:21 INFO - PROCESS | 11850 | -------- Summary: end -------- 15:04:21 INFO - PROCESS | 11850 | 15:04:22 INFO - TEST-INFO | 11850: exit 0 15:04:22 INFO - TEST-OK | dromaeo_css | took 1116258ms 15:04:22 INFO - TEST-START | kraken 15:04:22 INFO - operating with platform_type : linux_ 15:04:22 INFO - Initialising browser for kraken test... 15:04:22 INFO - TEST-INFO | started process 12085 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnMqM9w/profile http://localhost:49337/getInfo.html) 15:04:26 INFO - PROCESS | 12085 | 15:04:26 INFO - PROCESS | 12085 | (process:12154): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:04:27 INFO - PROCESS | 12085 | __metrics Screen width/height:1600/1200 15:04:27 INFO - PROCESS | 12085 | colorDepth:24 15:04:27 INFO - PROCESS | 12085 | Browser inner width/height: 1024/697 15:04:27 INFO - PROCESS | 12085 | __metrics 15:04:28 ERROR - PROCESS | 12085 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2945: TypeError: this.tabs is undefined 15:04:29 INFO - TEST-INFO | 12085: exit 0 15:04:29 INFO - Browser initialized. 15:04:29 INFO - Running cycle 1/1 for kraken test... 15:04:29 INFO - TEST-INFO | started process 12205 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnMqM9w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:04:31 INFO - PROCESS | 12205 | 15:04:31 INFO - PROCESS | 12205 | (process:12264): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:04:41 INFO - PROCESS | 12205 | RSS: Main: 164319232 15:04:41 INFO - PROCESS | 12205 | 15:04:43 INFO - PROCESS | 12205 | Cycle 1(1): loaded http://localhost:49337/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49337/tests/kraken/driver.html?testName=audio-beat-detection) 15:04:44 INFO - PROCESS | 12205 | RSS: Main: 168648704 15:04:44 INFO - PROCESS | 12205 | 15:04:47 INFO - PROCESS | 12205 | Cycle 1(1): loaded http://localhost:49337/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49337/tests/kraken/driver.html?testName=audio-dft) 15:04:48 INFO - PROCESS | 12205 | RSS: Main: 168484864 15:04:48 INFO - PROCESS | 12205 | 15:04:51 INFO - PROCESS | 12205 | Cycle 1(1): loaded http://localhost:49337/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49337/tests/kraken/driver.html?testName=audio-fft) 15:04:51 INFO - PROCESS | 12205 | RSS: Main: 164429824 15:04:51 INFO - PROCESS | 12205 | 15:04:53 INFO - PROCESS | 12205 | Cycle 1(1): loaded http://localhost:49337/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49337/tests/kraken/driver.html?testName=audio-oscillator) 15:04:54 INFO - PROCESS | 12205 | RSS: Main: 164147200 15:04:54 INFO - PROCESS | 12205 | 15:04:56 INFO - PROCESS | 12205 | Cycle 1(1): loaded http://localhost:49337/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49337/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:04:57 INFO - PROCESS | 12205 | RSS: Main: 164818944 15:04:57 INFO - PROCESS | 12205 | 15:05:00 INFO - PROCESS | 12205 | Cycle 1(1): loaded http://localhost:49337/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49337/tests/kraken/driver.html?testName=imaging-darkroom) 15:05:01 INFO - PROCESS | 12205 | RSS: Main: 164421632 15:05:01 INFO - PROCESS | 12205 | 15:05:04 INFO - PROCESS | 12205 | Cycle 1(1): loaded http://localhost:49337/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49337/tests/kraken/driver.html?testName=imaging-desaturate) 15:05:05 INFO - PROCESS | 12205 | RSS: Main: 162643968 15:05:05 INFO - PROCESS | 12205 | 15:05:08 INFO - PROCESS | 12205 | Cycle 1(1): loaded http://localhost:49337/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49337/tests/kraken/driver.html?testName=json-parse-financial) 15:05:08 INFO - PROCESS | 12205 | RSS: Main: 163815424 15:05:08 INFO - PROCESS | 12205 | 15:05:10 INFO - PROCESS | 12205 | Cycle 1(1): loaded http://localhost:49337/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49337/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:05:11 INFO - PROCESS | 12205 | RSS: Main: 164868096 15:05:11 INFO - PROCESS | 12205 | 15:05:13 INFO - PROCESS | 12205 | Cycle 1(1): loaded http://localhost:49337/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49337/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:05:13 INFO - PROCESS | 12205 | RSS: Main: 164638720 15:05:13 INFO - PROCESS | 12205 | 15:05:15 INFO - PROCESS | 12205 | Cycle 1(1): loaded http://localhost:49337/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49337/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:05:16 INFO - PROCESS | 12205 | RSS: Main: 164884480 15:05:16 INFO - PROCESS | 12205 | 15:05:19 INFO - PROCESS | 12205 | Cycle 1(1): loaded http://localhost:49337/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49337/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:05:20 INFO - PROCESS | 12205 | RSS: Main: 164573184 15:05:20 INFO - PROCESS | 12205 | 15:05:23 INFO - PROCESS | 12205 | Cycle 1(1): loaded http://localhost:49337/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49337/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:05:23 INFO - PROCESS | 12205 | RSS: Main: 164413440 15:05:23 INFO - PROCESS | 12205 | 15:05:25 INFO - PROCESS | 12205 | Cycle 1(1): loaded http://localhost:49337/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49337/tests/kraken/driver.html?testName=ai-astar) 15:05:25 INFO - PROCESS | 12205 | RSS: Main: 165879808 15:05:25 INFO - PROCESS | 12205 | 15:05:25 INFO - PROCESS | 12205 | __start_tp_report 15:05:25 INFO - PROCESS | 12205 | _x_x_mozilla_page_load 15:05:25 INFO - PROCESS | 12205 | _x_x_mozilla_page_load_details 15:05:25 INFO - PROCESS | 12205 | |i|pagename|runs| 15:05:25 INFO - PROCESS | 12205 | |0;ai-astar;113;115;107;115;116;114;108;115;116;117 15:05:25 INFO - PROCESS | 12205 | |1;audio-beat-detection;155;131;159;202;137;154;163;134;198;135 15:05:25 INFO - PROCESS | 12205 | |2;audio-dft;163;165;170;179;164;164;164;164;164;162 15:05:25 INFO - PROCESS | 12205 | |3;audio-fft;77;77;77;162;78;76;76;75;162;77 15:05:25 INFO - PROCESS | 12205 | |4;audio-oscillator;94;94;156;93;94;93;138;94;92;151 15:05:25 INFO - PROCESS | 12205 | |5;imaging-gaussian-blur;118;118;119;118;118;117;117;118;118;117 15:05:25 INFO - PROCESS | 12205 | |6;imaging-darkroom;147;147;150;147;147;148;147;148;147;148 15:05:25 INFO - PROCESS | 12205 | |7;imaging-desaturate;95;96;96;100;95;95;96;95;95;96 15:05:25 INFO - PROCESS | 12205 | |8;json-parse-financial;68;70;68;68;68;68;66;85;65;66 15:05:25 INFO - PROCESS | 12205 | |9;json-stringify-tinderbox;64;63;63;63;64;63;63;64;64;64 15:05:25 INFO - PROCESS | 12205 | |10;stanford-crypto-aes;84;83;87;83;84;84;84;84;83;83 15:05:25 INFO - PROCESS | 12205 | |11;stanford-crypto-ccm;141;154;135;134;132;134;134;139;181;135 15:05:25 INFO - PROCESS | 12205 | |12;stanford-crypto-pbkdf2;176;177;181;180;175;175;179;175;180;175 15:05:25 INFO - PROCESS | 12205 | |13;stanford-crypto-sha256-iterative;69;69;68;68;70;72;67;71;66;67 15:05:25 INFO - PROCESS | 12205 | __end_tp_report 15:05:25 INFO - PROCESS | 12205 | __start_cc_report 15:05:25 INFO - PROCESS | 12205 | _x_x_mozilla_cycle_collect,910 15:05:25 INFO - PROCESS | 12205 | __end_cc_report 15:05:25 INFO - PROCESS | 12205 | __startTimestamp1462485925705__endTimestamp 15:05:25 INFO - PROCESS | 12205 | 15:05:25 INFO - PROCESS | 12205 | ------- Summary: start ------- 15:05:25 INFO - PROCESS | 12205 | Number of tests: 14 15:05:25 INFO - PROCESS | 12205 | 15:05:25 INFO - PROCESS | 12205 | [#0] ai-astar Cycles:10 Average:113.60 Median:115.00 stddev:3.41 (3.0%) stddev-sans-first:3.61 15:05:25 INFO - PROCESS | 12205 | Values: 113.0 115.0 107.0 115.0 116.0 114.0 108.0 115.0 116.0 117.0 15:05:25 INFO - PROCESS | 12205 | 15:05:25 INFO - PROCESS | 12205 | [#1] audio-beat-detection Cycles:10 Average:156.80 Median:157.00 stddev:25.49 (16.2%) stddev-sans-first:27.03 15:05:25 INFO - PROCESS | 12205 | Values: 155.0 131.0 159.0 202.0 137.0 154.0 163.0 134.0 198.0 135.0 15:05:25 INFO - PROCESS | 12205 | 15:05:25 INFO - PROCESS | 12205 | [#2] audio-dft Cycles:10 Average:165.90 Median:164.00 stddev:5.07 (3.1%) stddev-sans-first:5.26 15:05:25 INFO - PROCESS | 12205 | Values: 163.0 165.0 170.0 179.0 164.0 164.0 164.0 164.0 164.0 162.0 15:05:25 INFO - PROCESS | 12205 | 15:05:25 INFO - PROCESS | 12205 | [#3] audio-fft Cycles:10 Average:93.70 Median:77.00 stddev:36.01 (46.8%) stddev-sans-first:37.68 15:05:25 INFO - PROCESS | 12205 | Values: 77.0 77.0 77.0 162.0 78.0 76.0 76.0 75.0 162.0 77.0 15:05:25 INFO - PROCESS | 12205 | 15:05:25 INFO - PROCESS | 12205 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:93.50 stddev:26.89 (28.8%) stddev-sans-first:27.90 15:05:25 INFO - PROCESS | 12205 | Values: 94.0 94.0 156.0 93.0 94.0 93.0 138.0 94.0 92.0 151.0 15:05:25 INFO - PROCESS | 12205 | 15:05:25 INFO - PROCESS | 12205 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 15:05:25 INFO - PROCESS | 12205 | Values: 118.0 118.0 119.0 118.0 118.0 117.0 117.0 118.0 118.0 117.0 15:05:25 INFO - PROCESS | 12205 | 15:05:25 INFO - PROCESS | 12205 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.50 stddev:0.97 (0.7%) stddev-sans-first:1.00 15:05:25 INFO - PROCESS | 12205 | Values: 147.0 147.0 150.0 147.0 147.0 148.0 147.0 148.0 147.0 148.0 15:05:25 INFO - PROCESS | 12205 | 15:05:25 INFO - PROCESS | 12205 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:95.50 stddev:1.52 (1.6%) stddev-sans-first:1.58 15:05:25 INFO - PROCESS | 12205 | Values: 95.0 96.0 96.0 100.0 95.0 95.0 96.0 95.0 95.0 96.0 15:05:25 INFO - PROCESS | 12205 | 15:05:25 INFO - PROCESS | 12205 | [#8] json-parse-financial Cycles:10 Average:69.20 Median:68.00 stddev:5.73 (8.4%) stddev-sans-first:6.06 15:05:25 INFO - PROCESS | 12205 | Values: 68.0 70.0 68.0 68.0 68.0 68.0 66.0 85.0 65.0 66.0 15:05:25 INFO - PROCESS | 12205 | 15:05:25 INFO - PROCESS | 12205 | [#9] json-stringify-tinderbox Cycles:10 Average:63.50 Median:64.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 15:05:25 INFO - PROCESS | 12205 | Values: 64.0 63.0 63.0 63.0 64.0 63.0 63.0 64.0 64.0 64.0 15:05:25 INFO - PROCESS | 12205 | 15:05:25 INFO - PROCESS | 12205 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:84.00 stddev:1.20 (1.4%) stddev-sans-first:1.27 15:05:25 INFO - PROCESS | 12205 | Values: 84.0 83.0 87.0 83.0 84.0 84.0 84.0 84.0 83.0 83.0 15:05:25 INFO - PROCESS | 12205 | 15:05:25 INFO - PROCESS | 12205 | [#11] stanford-crypto-ccm Cycles:10 Average:141.90 Median:137.00 stddev:15.15 (11.1%) stddev-sans-first:16.06 15:05:25 INFO - PROCESS | 12205 | Values: 141.0 154.0 135.0 134.0 132.0 134.0 134.0 139.0 181.0 135.0 15:05:25 INFO - PROCESS | 12205 | 15:05:25 INFO - PROCESS | 12205 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.30 Median:178.00 stddev:2.45 (1.4%) stddev-sans-first:2.55 15:05:25 INFO - PROCESS | 12205 | Values: 176.0 177.0 181.0 180.0 175.0 175.0 179.0 175.0 180.0 175.0 15:05:25 INFO - PROCESS | 12205 | 15:05:25 INFO - PROCESS | 12205 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.89 (2.7%) stddev-sans-first:2.00 15:05:25 INFO - PROCESS | 12205 | Values: 69.0 69.0 68.0 68.0 70.0 72.0 67.0 71.0 66.0 67.0 15:05:25 INFO - PROCESS | 12205 | -------- Summary: end -------- 15:05:25 INFO - PROCESS | 12205 | 15:05:26 INFO - TEST-INFO | 12205: exit 0 15:05:26 INFO - TEST-OK | kraken | took 64280ms 15:05:26 INFO - SUITE-END | took 1180s 15:05:26 INFO - Completed test suite (00:19:40) 15:05:26 INFO - javascript benchmark 15:05:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2702.5405681034226, 2745.3273947882767, 2746.7527922486984, 2752.1330780804033, 2763.69599344072, 4778.952210477894, 4785.210440277355, 4809.350737650416, 4882.8779280518, 4958.330625365575, 4757.524247575249, 4818.590419814312, 4834.854954351366, 4874.049560335736, 4874.902501949959, 4410.911781764363, 4446.421965144526, 4450.154470650582, 4491.887702807423, 4500.874781304674, 4476.440444944382, 4501.5273396293405, 4535.795889184995, 4540.525413649569, 4589.173948689235, 4416.977915110404, 4473.619742321906, 4477.149341625113, 4493.0, 4569.246074397737, 4475.172093162775, 4481.0, 4503.0768692418305, 4512.345709872083, 4533.54664533544, 4463.531329210418, 4478.0, 4478.529754375776, 4516.23224051912, 4550.0, 4593.311003349524, 4606.332081848113, 4645.512221216791, 4686.133065382881, 4730.574248317668, 5045.823396181116, 5060.2156665716875, 5063.518965698289, 5078.5937125029905, 5158.277841102249, 5123.257127716498, 5140.665856719339, 5141.15170996785, 5154.355705536808, 5154.53609175176, 4810.6151507879285, 4887.486813884527, 4916.827911023169, 4926.408830940239, 4929.112759703216, 5369.6509726867625, 5385.0, 5387.299651045339, 5388.164834450667, 5388.326459192601, 4972.8508144755715, 5021.447640759514, 5185.429602743695, 5186.792528298901, 5192.818251361185, 5094.1849304111165, 5094.465081166498, 5137.691738495702, 5138.203578445347, 5191.5846732261325, 5070.138076527, 5082.720450375191, 5094.1849304111165, 5105.5149760772665, 5148.304978827885, 5009.799608015638, 5036.143855544567, 5065.670731402521, 5082.872928176826, 5099.209622508517, 4376.124775045004, 4396.538363471854, 4421.53573874745, 4422.181896349186, 4423.159599676115, 3820.0449887528116, 3823.330917089498, 3855.9228815423535, 3862.1503269280715, 3862.613738626115, 4365.80353884076, 4456.220161471794, 4460.130274596422, 4466.173757854807, 4517.6160026397465, 5122.103631864484, 5149.304843846107, 5149.639525233272, 5149.897002059938, 5153.201253805666, 4440.4671439427475, 4452.755098469615, 4467.843625473158, 4476.194285028661, 4496.775161241925, 4630.536946305342, 4681.227597446451, 4702.177119004161, 4724.622030237572, 4740.14677358072, 4942.258661200777, 4977.800887964441, 5002.324686167321, 5022.673526220784, 5065.974670126626, 5304.628675992643, 5326.142758170347, 5356.062689029326, 5359.973200133974, 5407.297051383295, 4760.500147484464, 4868.513148685103, 4894.119058569491, 5005.149124648891, 5030.924536131888, 5077.111505486451, 5093.4651861555485, 5125.7693403796175, 5128.410232823273, 5182.948170518246, 5227.817026404057, 5234.345706786652, 5245.527902488641, 5249.448807875118, 5277.709725965109, 4937.284093806306, 4960.355153829979, 5074.035933172685, 5092.108880945893, 5102.2346648003095, 4985.227289769947, 4996.575291100297, 5017.3226614406585, 5022.271770593316, 5044.772985215747, 4980.103581355391, 4997.200447928314, 5000.12497812874, 5011.548960593418, 5040.243963405372, 5039.496050394931, 5076.568491678101, 5080.187170052774, 5112.9744351278005, 5124.205748109049, 4980.825671101494, 5037.622178336713, 5042.773075211551, 5048.116579598629, 5082.745862706776], "value": 4764.960025099323, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.9831705048847, 600.6576251536625, 608.1516284782725, 622.2408661433055, 626.8338890194098, 38942.0, 40241.195176096495, 40295.39556906649, 40295.59704402955, 40355.39466907995, 39784.80107599458, 40309.39535906957, 40611.59388406115, 40720.59279407205, 40745.0, 8053.114157442691, 8148.6333115009675, 8177.0, 8180.754577362689, 8184.140665230155, 7942.761717148466, 8091.231333023354, 8099.51402915824, 8130.227628375294, 8169.550674712888, 8138.0, 8184.2224988625985, 8194.713185038525, 8207.917920820804, 8234.752957411287, 8141.959290203541, 8152.6331315090665, 8153.0, 8155.918440815575, 8170.42807003507, 7957.482763620404, 8088.433809633328, 8090.555019473926, 8096.352291816641, 8098.987626546682, 37733.81133094344, 37893.43159852605, 38058.0, 38129.23741525154, 38136.42795358072, 3277.737780977516, 3503.439449688063, 3834.386498160281, 3847.172857835551, 3965.5836137205465, 27727.890884364602, 30246.99669374492, 30566.84716576425, 30759.38481230385, 30854.537181942287, 3190.1546090286092, 3254.08885512057, 3360.915977100592, 3419.145213696576, 3461.8442170102408, 267205.0, 268552.0, 269935.0, 270056.0, 270461.0, 53762.0, 59887.0, 60359.69820150871, 61883.0, 62066.37933620696, 62613.68693156505, 63104.0, 63207.36792632015, 63299.36700633027, 63518.682406588596, 14740.410383584536, 14817.185054822088, 14850.960432769818, 14881.33034013472, 14891.106533608017, 11318.490667919963, 11362.602308919148, 11399.544018239343, 11428.428578571038, 11434.199606027498, 19680.311189108314, 19887.801121988883, 20184.293549725688, 20201.090950907244, 20340.186392544427, 6999.510034297652, 7246.855062898712, 7312.451566132561, 7326.377257933029, 7440.55356678601, 899.6626265150569, 924.3621900888365, 967.6129548180643, 985.5466485416789, 1008.5310330696115, 28590.857045714638, 29596.0, 29911.252218694706, 30214.395712085636, 30358.392832143232, 960.951952402391, 1020.9285350025427, 1022.1873610479687, 1040.958361665525, 1060.3531845574194, 15045.247737613076, 15165.0, 15423.151726655142, 15537.611559711098, 15655.530334089995, 352789.0, 357086.0, 359213.0, 359229.0, 361200.0, 53489.73255133777, 54084.0, 54331.72834135804, 54620.45379546233, 54637.0, 1281.6988007818156, 1316.1116246533552, 1323.7617228898698, 1331.1347624044256, 1336.3652265173964, 27173.728262717912, 27697.169084927486, 28333.433331332846, 28475.572866406605, 28872.566911496764, 45296.32055519236, 45594.77202613965, 45782.31326530038, 45834.77082614566, 45876.77061614671, 244431.0, 249463.0, 249534.0, 249784.0, 250712.0, 26499.337516562242, 26873.193804185907, 27028.45943081167, 27140.45719085647, 27159.321016974733, 44712.77643611761, 45800.77099614614, 46062.539374607164, 46449.30326045045, 46752.0, 38213.61786382212, 38548.42177367398, 38621.6137838618, 38931.805340973115, 39081.80459097686, 37912.24175516419, 38216.80891595635, 38427.23145537129, 38494.230115398095, 39432.21135577215, 33730.0, 34813.47779783356, 38560.42159367668, 38680.2263954725, 39102.4134637975, 33851.0, 34592.48111278282, 34823.0, 35158.29683406369, 35182.29635407329, 26713.732862671903, 26945.191644250703, 27018.189454315616, 27164.456710865277, 27200.319992000357], "value": 18307.001223686308, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.1306056887453, 373.85606541481536, 376.42219193537926, 385.3295266236747, 392.01017430986735, 16029.519114426572, 16702.496775290223, 17191.023032351284, 17480.562985925357, 17554.561135971606, 10131.493425328741, 10491.42297173655, 10503.0, 10526.42104684242, 10541.78916421671, 4587.15137699525, 4774.856754297377, 4791.928121078186, 5157.948420515803, 5185.196294574328, 5075.543201111899, 5101.617378696613, 5106.285120083191, 5153.742312884359, 5156.123459011977, 4932.778024988884, 5086.084504789136, 5102.515261050195, 5305.549028332577, 5306.071437498442, 5271.736413179326, 5301.125314323171, 5310.203469479589, 5313.548348390392, 5325.4142044375085, 4490.730556166641, 4633.559811817872, 4665.510121437234, 4669.112868554964, 4782.234842425195, 12004.279743215435, 12411.503539858395, 12435.813462798065, 12448.439820208112, 12612.054095942749, 1934.1006432009042, 1938.9612207755765, 1941.9513462730108, 2023.3828682251908, 2201.2955854126685, 8959.059298773665, 9021.639134434614, 9032.141946515136, 9100.499472529009, 9108.772280692969, 1774.6539424812167, 1790.7492950986873, 1805.1876655504943, 1815.0833828916313, 1893.1480833624923, 49524.25713614262, 60163.39836601622, 61144.0, 68317.3168268316, 71730.64134679294, 9725.708228753148, 9746.366486178376, 10186.0, 10222.182225421948, 10233.92543782907, 13921.0, 13995.090319129224, 14046.71906561863, 14057.01600887928, 14102.71794564103, 7348.559086454829, 7506.099268087864, 7544.698212071456, 7708.0, 7771.288103244111, 7250.4199664026755, 7285.380742636935, 7380.298871607189, 7553.433492487976, 7574.394048476219, 4282.143571285756, 4371.404437380397, 4450.599446049871, 4459.643228541709, 4507.481639611421, 1803.2967142814314, 1818.6362727454562, 1827.570520927581, 1831.102759647763, 1878.4928069421453, 835.4820011592851, 929.8744669469535, 991.7619771254991, 992.1120597065731, 995.8207522645848, 16768.496945091665, 17024.953445065177, 17503.29986800514, 17704.822951770577, 17785.0, 904.4618452021037, 909.4043401571981, 940.7507010642186, 948.8576713492894, 984.2372161574837, 9337.813243735087, 9813.803723925625, 9821.459819709842, 9942.105210531086, 10043.548040338203, 386306.0, 404022.0, 405494.0, 405918.0, 407715.0, 74355.25644743591, 75603.62198189084, 75715.62142189364, 77521.0, 78972.26166430033, 939.5865819039601, 942.9905700942903, 964.0600414595713, 975.3026585990908, 986.2159583131428, 15136.394544218108, 15159.696806064037, 15192.240387980335, 15288.388464461297, 15704.371825126867, 34109.82945085259, 34423.65576344305, 34488.13779655529, 34541.0, 35803.641963580034, 47887.281690775366, 48175.5182448171, 48530.5146948526, 48545.27182092342, 48710.0, 7359.521631093961, 7474.813129671802, 7582.54504729718, 7802.804929876572, 7838.294553490213, 9827.656032038843, 10563.524641391003, 11424.143189260672, 11547.364894930859, 11754.588589399329, 9437.150656440954, 9794.706158815246, 9874.308798384043, 9945.0, 9985.800283994426, 9685.273604479833, 9845.901540984498, 9902.405855648683, 9937.453440060866, 10020.298579099393, 9756.170725488413, 9937.155341796028, 10168.28821982454, 10214.0, 10401.42792146409, 7658.502197357154, 7703.191164927826, 7772.883406749016, 7778.533288002738, 7790.1041380241995, 9114.680986165718, 9801.0, 9923.851142232728, 10004.849927251242, 10539.525721342712], "value": 7943.417806958736, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1536.4391996921124, 1539.9999999999995, 1717.4246627379828, 1811.5471132216946, 1828.6342731453703, 6661.10075139856, 7168.462365322602, 7305.342519173273, 7672.53964762114, 7676.50102743322, 7520.0, 7724.2661947115075, 7781.572013539253, 7791.259830316125, 7807.5315481071175, 2146.914123435061, 2187.9671804922937, 2191.298784388996, 2191.485001024758, 2200.4058904095887, 2161.027537608075, 2192.3861318830754, 2200.867947923122, 2207.2054060538194, 2207.94480137997, 2167.6423390140685, 2168.29530402619, 2178.8474806763534, 2187.103287652063, 2200.526886719355, 2131.435169680036, 2133.1893880325533, 2138.8395870309787, 2139.2833400810746, 2142.967855482161, 2127.0428307261795, 2136.8717876927435, 2140.914363425461, 2141.0900367343816, 2168.8481806273567, 7727.574983375912, 7766.57283849388, 7766.961165194138, 7772.7668169954995, 7791.8441631167625, 4460.553944605546, 4559.703619264737, 4562.041971186055, 4562.406887104688, 4594.885127871797, 2775.8473283969374, 2791.8185317954267, 2945.955810662842, 2946.3959888223076, 2955.674875763664, 920.6501529418845, 944.8346539355585, 954.9809003819954, 961.8845738511353, 970.1365784451843, 9704.12662860339, 9994.500274986221, 10010.49947502622, 10181.592736290539, 10268.43523606194, 3814.771113733185, 3861.3821788514265, 3892.591277915778, 3924.077841707254, 3933.272344616255, 8052.0, 8062.234087761653, 8070.192980702001, 8072.636731347104, 8090.797730056795, 4348.108637729258, 4360.324149756792, 4442.800073996678, 4497.820087196541, 4506.324051392252, 3490.3019396120876, 4114.238865809834, 4126.504819421629, 4132.070284186094, 4246.087091275391, 3375.9831200843837, 3438.6561343865915, 3488.302339532104, 3512.929741405209, 3527.0476971217627, 1014.5535964175739, 1029.7191720339483, 1040.4693606260862, 1043.7286305560458, 1050.3855244681947, 865.2126564825978, 882.6248844241172, 886.2998231397253, 910.6858133943779, 922.7554698005034, 5327.227552004938, 5341.946580534222, 5395.7841686332895, 5532.114861622121, 5648.181013752983, 414.2874256279195, 420.2100051902404, 434.48296527133243, 435.075464637645, 435.78646463232786, 3579.6062433132333, 3605.2428989911887, 3657.524521812147, 3692.095436618046, 3718.1076541630355, 9157.130072643089, 9434.622615095457, 9440.858387124199, 9485.051494850597, 9519.619215231452, 9266.490343031199, 9376.156145946761, 9413.76465588352, 9441.055894410503, 9441.90558094424, 7175.677094530759, 7204.207537170907, 7273.127224733066, 7320.853582928312, 7394.889076663854, 5289.836236028068, 5314.256004159343, 5349.732513374393, 5440.483154100354, 5575.526080283222, 8662.653493860174, 8718.128187181232, 8778.03441621434, 8788.16512431318, 8824.911750882666, 8295.668173273001, 8664.263537599123, 8754.91245087541, 8882.955585222033, 8929.374943753875, 6094.2077529920825, 6503.837404064936, 6689.832754181184, 6739.157605299338, 6805.795826125224, 7477.775666730006, 7506.361959233526, 7508.474406791473, 7540.924590754242, 7576.621168941641, 6712.093867327848, 6862.279460656559, 6864.7940561783225, 6950.339717726808, 6985.511014228955, 6720.865582688417, 6776.559523630948, 6782.491313151435, 6812.693428795816, 6828.351306625863, 6409.070684750778, 6419.903701444388, 6486.0, 6500.414962653384, 6529.967350163219, 4652.278896771006, 4711.905761884812, 4736.8578942631775, 4737.786799594095, 4776.785044672929, 4694.366260554782, 4758.976205118952, 4803.013811646834, 4820.0, 4857.708537487762], "value": 4027.1370949324, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.3701364148929, 304.162033597439, 305.76608894195937, 310.4210647143076, 311.3321924472006, 4986.152354099802, 4995.125852975724, 5023.974880125595, 5024.547790698836, 5076.796928122875, 4953.108440480712, 4970.8318545141865, 4979.302897594331, 4994.375703037121, 5033.068882256776, 3683.668469837714, 3795.405929509599, 3857.9807100964454, 3870.3550990828926, 3897.512810898638, 3866.2654095721723, 3888.727789054767, 3890.280298144838, 3890.961090389088, 3896.376579747241, 3814.389697648377, 3833.5783063862955, 3835.657519868038, 3838.7312888097704, 3844.0, 3787.223619158066, 3824.3880979043497, 3863.864764733235, 3871.1676989447406, 3905.7265991380614, 3407.9659203407896, 3425.6745609167087, 3447.7414193935556, 3450.913727156816, 3453.6028356739043, 4757.167495688241, 4783.258594917758, 4790.712557246577, 4792.185328494164, 4806.855794326176, 4451.354553589711, 4473.926257698162, 4481.0955343979, 4486.371907932892, 4498.257787465064, 4935.321990523239, 5279.155335146358, 5296.390915044781, 5302.522772950414, 5310.858165494437, 3667.6699097081123, 3692.298463291966, 3692.7968961707097, 3696.2792255510185, 3703.6481684185346, 5412.4587541245955, 5416.864578385533, 5442.265294185274, 5465.234867118646, 5490.91763623542, 3656.8902932912056, 3746.7189960753053, 3764.981175094107, 3771.5097037384962, 3775.7923314217983, 3792.7345085844277, 3820.140468394589, 3822.522184726909, 3824.1395685970433, 3828.712846536521, 4395.604395604411, 4399.296112622029, 4418.5802348776815, 4433.049458238364, 4440.845380201106, 5033.521815427529, 5180.948190518122, 5195.636305458657, 5220.295260139908, 5292.894142117136, 1284.4862055177816, 1312.9540466083831, 1316.9473221071241, 1319.1030099532218, 1319.9538016169388, 817.8323443694028, 852.0244320253399, 887.60057973912, 891.3760367742606, 896.6013019689306, 4551.795169217393, 4617.284320930261, 4626.745528995937, 4647.488776234612, 4650.093231819763, 5393.973030134903, 5417.485338892799, 5448.346198456132, 5458.426865179178, 5490.231367608538, 4419.381286619876, 4602.723836569817, 4612.192866248393, 4620.768961551909, 4659.324397962277, 2829.7877659175233, 2862.141357592714, 2873.5689646553183, 2882.5820256062752, 2904.9854750726113, 4977.253411988231, 5070.225421102585, 5074.695518268915, 5091.592672586185, 5105.285260063594, 5251.4485978972425, 5402.839338986737, 5413.404525502192, 5421.74695182895, 5520.420355862657, 5116.590672746172, 5125.256837758504, 5138.584865113391, 5154.768035438415, 5182.507661772125, 5497.312835895513, 5508.504234618904, 5521.337439507285, 5547.0, 5555.055730494295, 5210.817621383233, 5352.785888564414, 5386.48828361305, 5410.3778065522965, 5417.431169727122, 5172.818951336685, 5180.792768289226, 5181.145111056633, 5186.844394668166, 5202.843914682566, 3792.5259342582176, 3795.1840354323954, 3805.828737706865, 3813.8283777229535, 3829.5978922212767, 5327.653702509325, 5436.374816896107, 5458.7444887675265, 5465.836024919259, 5483.424240454695, 5216.295800066942, 5275.182346736262, 5282.81510147143, 5289.492494639009, 5303.814366497154, 5215.243789650403, 5220.0, 5260.185236093542, 5268.710220937885, 5272.340957380327, 4990.675606085593, 5133.486651334837, 5196.558292545176, 5222.616006758288, 5231.0, 5104.897902041864, 5175.353080864892, 5323.361196656426, 5345.599080069088, 5353.54494867925, 5151.819686311111, 5159.845204643867, 5166.509181627739, 5198.714070726146, 5211.921821172761], "value": 3942.104381950159, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [689.6586189836032, 711.2602892991287, 750.264740554257, 791.4024911192051, 793.8690116130836, 11981.580644677439, 12500.687482812935, 12680.556180533684, 12698.80951785724, 12707.491700331975, 13080.803787943189, 13562.050656454052, 13563.728725425486, 14120.929395353034, 14164.858351416482, 876.412803421709, 876.7063033883657, 877.6928075173702, 880.5509190312954, 882.2985726347537, 685.468761709674, 856.5802756649259, 859.7678626770768, 860.7675927499571, 861.8319427711599, 924.0990034716165, 925.9212966897788, 926.3839546701436, 927.8469052606312, 930.0931591698074, 918.4902379179553, 918.6555041859302, 918.7794929217007, 919.4483310014004, 921.3642586615281, 669.0666520204288, 671.0772687554612, 672.3209558346057, 672.7174586673609, 673.0140344395435, 12388.566400176041, 12400.56598019065, 12411.503539858395, 12441.688957776038, 12451.066170037284, 12501.3749312534, 12546.874531254753, 12615.116941814076, 12877.935610321982, 13049.478020879153, 10007.249456290807, 10015.549300281506, 10422.062014418738, 10481.213908956859, 10884.727881802939, 3221.1463962050075, 3259.5110733389943, 3292.27569934614, 3356.110630682871, 3410.6418826023405, 39928.800355998326, 40122.79938600318, 40208.0, 43779.78110109429, 45933.54066459326, 9632.373895696757, 9733.464659443798, 9763.902360976299, 9952.80094398108, 10052.346597471287, 17274.309027638752, 17276.827231727522, 17296.654066918592, 17300.22149003298, 17305.13474326304, 6837.1111755471475, 6843.520953533205, 6916.100906882073, 6967.372936435745, 7036.6481675916, 3610.332088563624, 3651.744377893522, 3739.1132224861117, 3739.775613463201, 3780.6219378061974, 2751.8073734838767, 2849.7435230829324, 2861.9427611448073, 2876.0796545105363, 2893.5225687761704, 513.1584201908872, 519.2574618295873, 520.6199474383722, 523.7538356972217, 529.5049129064337, 582.6300299309969, 636.7583212735185, 648.0214875537972, 656.3764423797317, 661.9635920024349, 7678.769636910902, 7922.564258965812, 7956.283934445928, 8007.759767206993, 8024.398170137147, 601.1493736363085, 608.1353001674385, 608.2214765100679, 622.791364892757, 649.4674367018999, 3666.7983260920905, 3751.718621103428, 3808.3716186829415, 3838.4626152338697, 3887.7084218683144, 44605.10789784186, 46589.76705116453, 46862.76568617203, 51114.74442627763, 51958.480415195365, 45139.54860451419, 45694.771526142154, 45968.3104753429, 46092.0, 47069.52930470651, 43102.784486077995, 43650.56349436465, 43724.344134838, 44064.339034914505, 44102.55897441049, 7901.525908445512, 8052.83894322122, 8233.0, 8349.499030058216, 8624.09447008055, 29691.109266722033, 29996.70003299939, 30215.546766798077, 30305.090847274616, 30960.380792384476, 37730.8113459431, 37750.2449951005, 37930.81034594809, 38070.61929380671, 38342.42486362651, 10553.577856885639, 10601.787964240826, 10893.782124357627, 10905.618303359344, 11056.723581910517, 10939.671809845717, 11243.66269011931, 11598.47806848677, 12017.158798883995, 12163.209391389531, 10692.14462842955, 10795.19036072282, 10972.286801357886, 11082.778344432905, 11375.772484550098, 11225.494852731483, 11245.71885702864, 11395.373254471084, 11795.882041179479, 11863.110266729856, 10869.891301086887, 10958.780824383628, 11008.614698485515, 11216.93439123282, 11222.607208747655, 8643.438176518506, 8670.13298670128, 8739.300855931637, 8764.91235087641, 8819.514926679094, 8738.563071846509, 9186.816263674555, 9205.447673139633, 9301.395409298373, 9395.154436100784], "value": 6024.5421760165855, "unit": "score"}], "name": "dromaeo_css", "value": 6361.561726054207, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 107.0, 115.0, 116.0, 114.0, 108.0, 115.0, 116.0, 117.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 131.0, 159.0, 202.0, 137.0, 154.0, 163.0, 134.0, 198.0, 135.0], "value": 156.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 170.0, 179.0, 164.0, 164.0, 164.0, 164.0, 164.0, 162.0], "value": 165.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 162.0, 78.0, 76.0, 76.0, 75.0, 162.0, 77.0], "value": 93.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 156.0, 93.0, 94.0, 93.0, 138.0, 94.0, 92.0, 151.0], "value": 109.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 119.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 150.0, 147.0, 147.0, 148.0, 147.0, 148.0, 147.0, 148.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 100.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 68.0, 68.0, 68.0, 68.0, 66.0, 85.0, 65.0, 66.0], "value": 69.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 63.0, 64.0, 63.0, 63.0, 64.0, 64.0, 64.0], "value": 63.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 87.0, 83.0, 84.0, 84.0, 84.0, 84.0, 83.0, 83.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 154.0, 135.0, 134.0, 132.0, 134.0, 134.0, 139.0, 181.0, 135.0], "value": 141.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 177.0, 181.0, 180.0, 175.0, 175.0, 179.0, 175.0, 180.0, 175.0], "value": 177.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 68.0, 68.0, 70.0, 72.0, 67.0, 71.0, 66.0, 67.0], "value": 68.7, "unit": "score"}], "name": "kraken", "value": 1605.7, "alertThreshold": 2.0}]} 15:05:26 INFO - Return code: 0 15:05:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:05:27 ERROR - # TBPL SUCCESS # 15:05:27 INFO - Running post-action listener: _resource_record_post_action 15:05:27 INFO - Running post-run listener: _resource_record_post_run 15:05:28 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 8192; Write bytes: 533676032; Read time: 304; Write time: 655552 15:05:28 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 240721920; Read time: 0; Write time: 310204 15:05:28 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 8192; Write bytes: 292900864; Read time: 304; Write time: 345332 15:05:28 INFO - Running post-run listener: _upload_blobber_files 15:05:28 INFO - Blob upload gear active. 15:05:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:05:28 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 15:05:28 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:05:28 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:05:28 INFO - (blobuploader) - INFO - Open directory for files ... 15:05:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:05:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:05:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:05:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:05:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:05:29 INFO - (blobuploader) - INFO - Done attempting. 15:05:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:05:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:05:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:05:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:05:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:05:30 INFO - (blobuploader) - INFO - Done attempting. 15:05:30 INFO - (blobuploader) - INFO - Iteration through files over. 15:05:30 INFO - Return code: 0 15:05:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:05:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:05:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/073ab2fb780864ed51f2f3eeb99190555d567b14d5abaa39992f5c057b996bd608e662c7c736e3d91364761912431708031c72d480d8c67bf45d43321c710583", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/246d263486379624078b9cef0f926d7818237ea6ed30286b50d65ed34371676e1fafaca6750e3ceb05d1018c870d29cb52bb875cab6d2be91a7d4ceec689c67e"} 15:05:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:05:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:05:30 INFO - Contents: 15:05:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/073ab2fb780864ed51f2f3eeb99190555d567b14d5abaa39992f5c057b996bd608e662c7c736e3d91364761912431708031c72d480d8c67bf45d43321c710583", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/246d263486379624078b9cef0f926d7818237ea6ed30286b50d65ed34371676e1fafaca6750e3ceb05d1018c870d29cb52bb875cab6d2be91a7d4ceec689c67e"} 15:05:30 INFO - Running post-run listener: copy_logs_to_upload_dir 15:05:30 INFO - Copying logs to upload dir... 15:05:30 INFO - mkdir: /builds/slave/test/build/upload/logs 15:05:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.583664 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-05 15:05:28.647396) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 15:05:28.651156) ========= 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=fa44defc139c4ba8574fe040000001db-1462484693.63716-1933703558 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-Non-PGO/sha512/073ab2fb780864ed51f2f3eeb99190555d567b14d5abaa39992f5c057b996bd608e662c7c736e3d91364761912431708031c72d480d8c67bf45d43321c710583", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/246d263486379624078b9cef0f926d7818237ea6ed30286b50d65ed34371676e1fafaca6750e3ceb05d1018c870d29cb52bb875cab6d2be91a7d4ceec689c67e"} build_url:https://queue.taskcluster.net/v1/task/GkvPTsqkRDqMgMTGHc7o6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011354 build_url: 'https://queue.taskcluster.net/v1/task/GkvPTsqkRDqMgMTGHc7o6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/073ab2fb780864ed51f2f3eeb99190555d567b14d5abaa39992f5c057b996bd608e662c7c736e3d91364761912431708031c72d480d8c67bf45d43321c710583", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/246d263486379624078b9cef0f926d7818237ea6ed30286b50d65ed34371676e1fafaca6750e3ceb05d1018c870d29cb52bb875cab6d2be91a7d4ceec689c67e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 15:05:28.676267) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 15:05:28.676616) ========= 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=fa44defc139c4ba8574fe040000001db-1462484693.63716-1933703558 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 15:05:28.761363) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 15:05:28.761966) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 15:05:28.762482) ========= ========= Total master_lag: 0.16 =========