builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1462104932.84 results: success (0) buildid: 20160501023016 builduid: e41287974f1a46c08e01c24f59121ba5 revision: 7e4ac3f24fa87986c044d9ee13c1cf557ea55d07 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-01 05:15:32.843330) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-01 05:15:32.843858) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-01 05:15:32.844206) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-01 05:15:32.872502) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 05:15:32.872844) ========= 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=41bf3e9aed84707956354da8000001c5-1462101504.771903-199676796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-01 05:15:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-05-01 05:15:33 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.073922 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 05:15:32.969325) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 05:15:32.969658) ========= 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=41bf3e9aed84707956354da8000001c5-1462101504.771903-199676796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019595 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 05:15:33.045179) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 05:15:33.045770) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7e4ac3f24fa87986c044d9ee13c1cf557ea55d07 --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 7e4ac3f24fa87986c044d9ee13c1cf557ea55d07 --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=41bf3e9aed84707956354da8000001c5-1462101504.771903-199676796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-01 05:15:33,207 truncating revision to first 12 chars 2016-05-01 05:15:33,207 Setting DEBUG logging. 2016-05-01 05:15:33,207 attempt 1/10 2016-05-01 05:15:33,207 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7e4ac3f24fa8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-01 05:15:33,562 unpacking tar archive at: fx-team-7e4ac3f24fa8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.640682 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 05:15:33.701177) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-01 05:15:33.701510) ========= script_repo_revision: 7e4ac3f24fa87986c044d9ee13c1cf557ea55d07 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-01 05:15:33.701949) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-01 05:15:33.702270) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-01 05:15:33.712772) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 50 secs) (at 2016-05-01 05:15:33.713173) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1462101504.771903-199676796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:15:33 INFO - MultiFileLogger online at 20160501 05:15:33 in /builds/slave/test 05:15:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:15:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:15:33 INFO - {'append_to_log': False, 05:15:33 INFO - 'base_work_dir': '/builds/slave/test', 05:15:33 INFO - 'blob_upload_branch': 'Fx-Team', 05:15:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:15:33 INFO - 'branch': 'Fx-Team', 05:15:33 INFO - 'buildbot_json_path': 'buildprops.json', 05:15:33 INFO - 'config_files': ('talos/linux_config.py',), 05:15:33 INFO - 'default_actions': ('clobber', 05:15:33 INFO - 'read-buildbot-config', 05:15:33 INFO - 'download-and-extract', 05:15:33 INFO - 'populate-webroot', 05:15:33 INFO - 'create-virtualenv', 05:15:33 INFO - 'install', 05:15:33 INFO - 'run-tests'), 05:15:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:15:33 INFO - 'download_minidump_stackwalk': True, 05:15:33 INFO - 'download_symbols': 'ondemand', 05:15:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:15:33 INFO - 'tooltool.py': '/tools/tooltool.py', 05:15:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:15:33 INFO - '/tools/misc-python/virtualenv.py')}, 05:15:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:15:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:15:33 INFO - 'installer_path': 'installer.exe', 05:15:33 INFO - 'log_level': 'info', 05:15:33 INFO - 'log_name': 'talos', 05:15:33 INFO - 'log_to_console': True, 05:15:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:15:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:15:33 INFO - 'opt_config_files': (), 05:15:33 INFO - 'pip_index': False, 05:15:33 INFO - 'sps_profile': False, 05:15:33 INFO - 'sps_profile_interval': 0, 05:15:33 INFO - 'suite': 'dromaeojs', 05:15:33 INFO - 'system_bits': '32', 05:15:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:15:33 INFO - 'title': 'talos-linux64-ix-026', 05:15:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:15:33 INFO - 'use_talos_json': True, 05:15:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:15:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:15:33 INFO - 'work_dir': 'build'} 05:15:33 INFO - ##### 05:15:33 INFO - ##### Running clobber step. 05:15:33 INFO - ##### 05:15:33 INFO - Running pre-action listener: _resource_record_pre_action 05:15:33 INFO - Running main action method: clobber 05:15:33 INFO - rmtree: /builds/slave/test/build 05:15:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:15:34 INFO - Running post-action listener: _resource_record_post_action 05:15:34 INFO - ##### 05:15:34 INFO - ##### Running read-buildbot-config step. 05:15:34 INFO - ##### 05:15:34 INFO - Running pre-action listener: _resource_record_pre_action 05:15:34 INFO - Running main action method: read_buildbot_config 05:15:34 INFO - Using buildbot properties: 05:15:34 INFO - { 05:15:34 INFO - "project": "", 05:15:34 INFO - "product": "firefox", 05:15:34 INFO - "script_repo_revision": "production", 05:15:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:15:34 INFO - "repository": "", 05:15:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:15:34 INFO - "buildid": "20160501023016", 05:15:34 INFO - "pgo_build": "True", 05:15:34 INFO - "basedir": "/builds/slave/test", 05:15:34 INFO - "buildnumber": 628, 05:15:34 INFO - "slavename": "talos-linux64-ix-026", 05:15:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:15:34 INFO - "platform": "ubuntu64_hw", 05:15:34 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:15:34 INFO - "branch": "fx-team", 05:15:34 INFO - "repo_path": "integration/fx-team", 05:15:34 INFO - "revision": "7e4ac3f24fa87986c044d9ee13c1cf557ea55d07", 05:15:34 INFO - "stage_platform": "linux64-pgo", 05:15:34 INFO - "builduid": "e41287974f1a46c08e01c24f59121ba5", 05:15:34 INFO - "slavebuilddir": "test" 05:15:34 INFO - } 05:15:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/Rk4QgiZKSWqAheVMULiuwg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:15:34 INFO - Running post-action listener: _resource_record_post_action 05:15:34 INFO - ##### 05:15:34 INFO - ##### Running download-and-extract step. 05:15:34 INFO - ##### 05:15:34 INFO - Running pre-action listener: _resource_record_pre_action 05:15:34 INFO - Running main action method: download_and_extract 05:15:34 INFO - mkdir: /builds/slave/test/build/tests 05:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:34 INFO - https://queue.taskcluster.net/v1/task/Rk4QgiZKSWqAheVMULiuwg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:15:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rk4QgiZKSWqAheVMULiuwg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:15:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rk4QgiZKSWqAheVMULiuwg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:15:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rk4QgiZKSWqAheVMULiuwg/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 05:15:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rk4QgiZKSWqAheVMULiuwg/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 05:16:04 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rk4QgiZKSWqAheVMULiuwg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json: timed out 05:16:04 INFO - retry: attempt #1 caught exception: timed out 05:16:04 INFO - retry: Failed, sleeping 30 seconds before retrying 05:16:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rk4QgiZKSWqAheVMULiuwg/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 #2 05:16:48 INFO - Downloaded 1361 bytes. 05:16:48 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:16:48 INFO - Using the following test package requirements: 05:16:48 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:16:48 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:16:48 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:16:48 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:48 INFO - u'jsshell-linux-x86_64.zip'], 05:16:48 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:16:48 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:16:48 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:16:48 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:16:48 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:16:48 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:16:48 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:16:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:48 INFO - https://queue.taskcluster.net/v1/task/Rk4QgiZKSWqAheVMULiuwg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:16:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rk4QgiZKSWqAheVMULiuwg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:16:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rk4QgiZKSWqAheVMULiuwg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:16:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rk4QgiZKSWqAheVMULiuwg/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 05:16:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rk4QgiZKSWqAheVMULiuwg/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 05:16:57 INFO - Downloaded 23877457 bytes. 05:16:57 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'] 05:16:57 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 05:16:59 INFO - Return code: 0 05:16:59 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 05:16:59 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')]} 05:16:59 INFO - https://queue.taskcluster.net/v1/task/Rk4QgiZKSWqAheVMULiuwg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:16:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rk4QgiZKSWqAheVMULiuwg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:16:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rk4QgiZKSWqAheVMULiuwg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:16:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rk4QgiZKSWqAheVMULiuwg/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 05:16:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rk4QgiZKSWqAheVMULiuwg/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 05:17:00 INFO - Downloaded 23877457 bytes. 05:17:00 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'] 05:17:00 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 05:17:02 INFO - Return code: 0 05:17: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')]} 05:17:02 INFO - https://queue.taskcluster.net/v1/task/Rk4QgiZKSWqAheVMULiuwg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:17:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rk4QgiZKSWqAheVMULiuwg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:17:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rk4QgiZKSWqAheVMULiuwg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:17:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rk4QgiZKSWqAheVMULiuwg/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 05:17:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rk4QgiZKSWqAheVMULiuwg/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 05:17:03 INFO - Downloaded 10840152 bytes. 05:17:03 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'] 05:17:03 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 05:17:03 INFO - Return code: 0 05:17:03 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')]} 05:17:03 INFO - https://queue.taskcluster.net/v1/task/Rk4QgiZKSWqAheVMULiuwg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:17:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rk4QgiZKSWqAheVMULiuwg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:17:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rk4QgiZKSWqAheVMULiuwg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:17:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rk4QgiZKSWqAheVMULiuwg/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 05:17:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rk4QgiZKSWqAheVMULiuwg/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 05:17:04 INFO - Downloaded 58618312 bytes. 05:17:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Rk4QgiZKSWqAheVMULiuwg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:17:04 INFO - mkdir: /builds/slave/test/properties 05:17:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:17:04 INFO - Writing to file /builds/slave/test/properties/build_url 05:17:04 INFO - Contents: 05:17:04 INFO - build_url:https://queue.taskcluster.net/v1/task/Rk4QgiZKSWqAheVMULiuwg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:17:05 INFO - Running post-action listener: _resource_record_post_action 05:17:05 INFO - Running post-action listener: set_extra_try_arguments 05:17:05 INFO - ##### 05:17:05 INFO - ##### Running populate-webroot step. 05:17:05 INFO - ##### 05:17:05 INFO - Running pre-action listener: _resource_record_pre_action 05:17:05 INFO - Running main action method: populate_webroot 05:17:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:17:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:17:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:17:05 INFO - '--tppagecycles', 05:17:05 INFO - '7'], 05:17:05 INFO - 'tests': ['tsvgm']}}, 05:17:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:17:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:17:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:17:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:17:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:17:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:17:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:05 INFO - 'talos_options': ['--disable-e10s'], 05:17:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:17:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:17:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:05 INFO - 'talos_options': ['--disable-e10s'], 05:17:05 INFO - 'tests': ['damp', 'tps']}, 05:17:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:05 INFO - 'tests': ['damp', 'tps']}, 05:17:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:17:05 INFO - 'tests': ['dromaeo_dom']}, 05:17:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:17:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:17:05 INFO - 'tests': ['a11yr', 05:17:05 INFO - 'ts_paint', 05:17:05 INFO - 'tpaint', 05:17:05 INFO - 'sessionrestore', 05:17:05 INFO - 'sessionrestore_no_auto_restore', 05:17:05 INFO - 'tabpaint']}, 05:17:05 INFO - 'other-e10s': {'tests': ['a11yr', 05:17:05 INFO - 'ts_paint', 05:17:05 INFO - 'tpaint', 05:17:05 INFO - 'sessionrestore', 05:17:05 INFO - 'sessionrestore_no_auto_restore', 05:17:05 INFO - 'tabpaint']}, 05:17:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:17:05 INFO - 'ts_paint', 05:17:05 INFO - 'tpaint', 05:17:05 INFO - 'sessionrestore', 05:17:05 INFO - 'sessionrestore_no_auto_restore', 05:17:05 INFO - 'tabpaint']}, 05:17:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:17:05 INFO - 'ts_paint', 05:17:05 INFO - 'tpaint', 05:17:05 INFO - 'sessionrestore', 05:17:05 INFO - 'sessionrestore_no_auto_restore', 05:17:05 INFO - 'tabpaint']}, 05:17:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:17:05 INFO - 'tests': ['a11yr', 05:17:05 INFO - 'ts_paint', 05:17:05 INFO - 'tpaint', 05:17:05 INFO - 'sessionrestore', 05:17:05 INFO - 'sessionrestore_no_auto_restore', 05:17:05 INFO - 'tabpaint']}, 05:17:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:17:05 INFO - 'tests': ['a11yr', 05:17:05 INFO - 'ts_paint', 05:17:05 INFO - 'tpaint', 05:17:05 INFO - 'sessionrestore', 05:17:05 INFO - 'sessionrestore_no_auto_restore', 05:17:05 INFO - 'tabpaint']}, 05:17:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:17:05 INFO - 'tests': ['tsvgx', 05:17:05 INFO - 'tsvgr_opacity', 05:17:05 INFO - 'tart', 05:17:05 INFO - 'tscrollx', 05:17:05 INFO - 'cart']}, 05:17:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:17:05 INFO - 'tsvgr_opacity', 05:17:05 INFO - 'tart', 05:17:05 INFO - 'tscrollx', 05:17:05 INFO - 'cart']}, 05:17:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:05 INFO - 'talos_options': ['--disable-e10s'], 05:17:05 INFO - 'tests': ['tp5o']}, 05:17:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:05 INFO - 'tests': ['tp5o']}, 05:17:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:05 INFO - 'talos_options': ['--disable-e10s', 05:17:05 INFO - '--xperf_path', 05:17:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:17:05 INFO - 'tests': ['tp5n']}, 05:17:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:05 INFO - 'talos_options': ['--xperf_path', 05:17:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:17:05 INFO - 'tests': ['tp5n']}}, 05:17:05 INFO - 'talos.zip': {'path': '', 05:17:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:17:05 INFO - Running post-action listener: _resource_record_post_action 05:17:05 INFO - ##### 05:17:05 INFO - ##### Running create-virtualenv step. 05:17:05 INFO - ##### 05:17:05 INFO - Running pre-action listener: _resource_record_pre_action 05:17:05 INFO - Running main action method: create_virtualenv 05:17:05 INFO - Creating virtualenv /builds/slave/test/build/venv 05:17:05 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 05:17:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:17:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:17:05 INFO - Using real prefix '/usr' 05:17:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:17:06 INFO - Installing distribute.............................................................................................................................................................................................done. 05:17:08 INFO - Installing pip.................done. 05:17:08 INFO - Return code: 0 05:17:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:17:08 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')]} 05:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:08 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')]} 05:17:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:08 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 0x7f8e2dc52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29049a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2993810>, '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 0x2994710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2994ba0>, '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': '41bf3e9aed84707956354da8000001c5-1462101504.771903-199676796', '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 05:17:08 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 05:17:08 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 05:17:08 INFO - Using env: {'DISPLAY': ':0', 05:17:08 INFO - 'HOME': '/home/cltbld', 05:17:08 INFO - 'LANG': 'en_US.UTF-8', 05:17:08 INFO - 'LANGUAGE': 'en_US:en', 05:17:08 INFO - 'LOGNAME': 'cltbld', 05:17:08 INFO - 'MAIL': '/var/mail/cltbld', 05:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:08 INFO - 'MOZ_NO_REMOTE': '1', 05:17:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:08 INFO - 'NO_EM_RESTART': '1', 05:17:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:08 INFO - 'PWD': '/builds/slave/test', 05:17:08 INFO - 'SHELL': '/bin/bash', 05:17:08 INFO - 'SHLVL': '1', 05:17:08 INFO - 'TERM': 'linux', 05:17:08 INFO - 'TMOUT': '86400', 05:17:08 INFO - 'USER': 'cltbld', 05:17:08 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1462101504.771903-199676796', 05:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:08 INFO - '_': '/tools/buildbot/bin/python'} 05:17:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:08 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 05:17:08 INFO - Cleaning up... 05:17:08 INFO - Return code: 0 05:17:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:17:08 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')]} 05:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:08 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')]} 05:17:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:08 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 0x7f8e2dc52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29049a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2993810>, '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 0x2994710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2994ba0>, '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': '41bf3e9aed84707956354da8000001c5-1462101504.771903-199676796', '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 05:17:08 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 05:17:08 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 05:17:08 INFO - Using env: {'DISPLAY': ':0', 05:17:08 INFO - 'HOME': '/home/cltbld', 05:17:08 INFO - 'LANG': 'en_US.UTF-8', 05:17:08 INFO - 'LANGUAGE': 'en_US:en', 05:17:08 INFO - 'LOGNAME': 'cltbld', 05:17:08 INFO - 'MAIL': '/var/mail/cltbld', 05:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:08 INFO - 'MOZ_NO_REMOTE': '1', 05:17:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:08 INFO - 'NO_EM_RESTART': '1', 05:17:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:08 INFO - 'PWD': '/builds/slave/test', 05:17:08 INFO - 'SHELL': '/bin/bash', 05:17:08 INFO - 'SHLVL': '1', 05:17:08 INFO - 'TERM': 'linux', 05:17:08 INFO - 'TMOUT': '86400', 05:17:08 INFO - 'USER': 'cltbld', 05:17:08 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1462101504.771903-199676796', 05:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:08 INFO - '_': '/tools/buildbot/bin/python'} 05:17:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:08 INFO - Downloading/unpacking psutil>=0.7.1 05:17:08 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 05:17:08 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 05:17:08 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 05:17:08 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 05:17:08 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 05:17:08 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 05:17:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:17:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:17:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:17:10 INFO - Installing collected packages: psutil 05:17:10 INFO - Running setup.py install for psutil 05:17:10 INFO - building 'psutil._psutil_linux' extension 05:17:10 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 05:17:10 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 05:17:10 INFO - building 'psutil._psutil_posix' extension 05:17:10 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 05:17:11 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 05:17:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:17:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:17:11 INFO - Successfully installed psutil 05:17:11 INFO - Cleaning up... 05:17:11 INFO - Return code: 0 05:17:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:17:11 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')]} 05:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:11 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')]} 05:17:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:11 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 0x7f8e2dc52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29049a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2993810>, '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 0x2994710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2994ba0>, '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': '41bf3e9aed84707956354da8000001c5-1462101504.771903-199676796', '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 05:17:11 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 05:17:11 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 05:17:11 INFO - Using env: {'DISPLAY': ':0', 05:17:11 INFO - 'HOME': '/home/cltbld', 05:17:11 INFO - 'LANG': 'en_US.UTF-8', 05:17:11 INFO - 'LANGUAGE': 'en_US:en', 05:17:11 INFO - 'LOGNAME': 'cltbld', 05:17:11 INFO - 'MAIL': '/var/mail/cltbld', 05:17:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:11 INFO - 'MOZ_NO_REMOTE': '1', 05:17:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:11 INFO - 'NO_EM_RESTART': '1', 05:17:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:11 INFO - 'PWD': '/builds/slave/test', 05:17:11 INFO - 'SHELL': '/bin/bash', 05:17:11 INFO - 'SHLVL': '1', 05:17:11 INFO - 'TERM': 'linux', 05:17:11 INFO - 'TMOUT': '86400', 05:17:11 INFO - 'USER': 'cltbld', 05:17:11 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1462101504.771903-199676796', 05:17:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:11 INFO - '_': '/tools/buildbot/bin/python'} 05:17:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:17:11 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 05:17:11 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 05:17:11 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 05:17:11 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 05:17:11 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 05:17:11 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 05:17:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:17:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:17:13 INFO - Installing collected packages: mozsystemmonitor 05:17:13 INFO - Running setup.py install for mozsystemmonitor 05:17:13 INFO - Successfully installed mozsystemmonitor 05:17:13 INFO - Cleaning up... 05:17:13 INFO - Return code: 0 05:17:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:17:13 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')]} 05:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:13 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')]} 05:17:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:13 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 0x7f8e2dc52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29049a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2993810>, '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 0x2994710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2994ba0>, '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': '41bf3e9aed84707956354da8000001c5-1462101504.771903-199676796', '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 05:17:13 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 05:17:13 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 05:17:13 INFO - Using env: {'DISPLAY': ':0', 05:17:13 INFO - 'HOME': '/home/cltbld', 05:17:13 INFO - 'LANG': 'en_US.UTF-8', 05:17:13 INFO - 'LANGUAGE': 'en_US:en', 05:17:13 INFO - 'LOGNAME': 'cltbld', 05:17:13 INFO - 'MAIL': '/var/mail/cltbld', 05:17:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:13 INFO - 'MOZ_NO_REMOTE': '1', 05:17:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:13 INFO - 'NO_EM_RESTART': '1', 05:17:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:13 INFO - 'PWD': '/builds/slave/test', 05:17:13 INFO - 'SHELL': '/bin/bash', 05:17:13 INFO - 'SHLVL': '1', 05:17:13 INFO - 'TERM': 'linux', 05:17:13 INFO - 'TMOUT': '86400', 05:17:13 INFO - 'USER': 'cltbld', 05:17:13 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1462101504.771903-199676796', 05:17:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:13 INFO - '_': '/tools/buildbot/bin/python'} 05:17:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:13 INFO - Downloading/unpacking blobuploader==1.2.4 05:17:13 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 05:17:13 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 05:17:13 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 05:17:13 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 05:17:13 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 05:17:13 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 05:17:15 INFO - Downloading blobuploader-1.2.4.tar.gz 05:17:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:17:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:17:15 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 05:17:15 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 05:17:15 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 05:17:15 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 05:17:15 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 05:17:15 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 05:17:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:17:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:17:16 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 05:17:16 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 05:17:16 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 05:17:16 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 05:17:16 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 05:17:16 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 05:17:16 INFO - Downloading docopt-0.6.1.tar.gz 05:17:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:17:16 INFO - Installing collected packages: blobuploader, requests, docopt 05:17:16 INFO - Running setup.py install for blobuploader 05:17:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:17:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:17:16 INFO - Running setup.py install for requests 05:17:16 INFO - Running setup.py install for docopt 05:17:16 INFO - Successfully installed blobuploader requests docopt 05:17:16 INFO - Cleaning up... 05:17:17 INFO - Return code: 0 05:17:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17:17 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')]} 05:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:17 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')]} 05:17:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:17 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 0x7f8e2dc52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29049a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2993810>, '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 0x2994710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2994ba0>, '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': '41bf3e9aed84707956354da8000001c5-1462101504.771903-199676796', '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 05:17:17 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 05:17:17 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 05:17:17 INFO - Using env: {'DISPLAY': ':0', 05:17:17 INFO - 'HOME': '/home/cltbld', 05:17:17 INFO - 'LANG': 'en_US.UTF-8', 05:17:17 INFO - 'LANGUAGE': 'en_US:en', 05:17:17 INFO - 'LOGNAME': 'cltbld', 05:17:17 INFO - 'MAIL': '/var/mail/cltbld', 05:17:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:17 INFO - 'MOZ_NO_REMOTE': '1', 05:17:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:17 INFO - 'NO_EM_RESTART': '1', 05:17:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:17 INFO - 'PWD': '/builds/slave/test', 05:17:17 INFO - 'SHELL': '/bin/bash', 05:17:17 INFO - 'SHLVL': '1', 05:17:17 INFO - 'TERM': 'linux', 05:17:17 INFO - 'TMOUT': '86400', 05:17:17 INFO - 'USER': 'cltbld', 05:17:17 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1462101504.771903-199676796', 05:17:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:17 INFO - '_': '/tools/buildbot/bin/python'} 05:17:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:17:17 INFO - Running setup.py (path:/tmp/pip-ImVg8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:17:17 INFO - Running setup.py (path:/tmp/pip-nzKtmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:17:17 INFO - Running setup.py (path:/tmp/pip-r_DvjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:17:17 INFO - Running setup.py (path:/tmp/pip-80U9GM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:17:17 INFO - Running setup.py (path:/tmp/pip-H0IWBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:17:17 INFO - Running setup.py (path:/tmp/pip-2jVUUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:17:17 INFO - Running setup.py (path:/tmp/pip-q5OW9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:17:17 INFO - Running setup.py (path:/tmp/pip-gJYBwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:17:17 INFO - Running setup.py (path:/tmp/pip-TSJipg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:17:17 INFO - Running setup.py (path:/tmp/pip-vYCuG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:17:18 INFO - Running setup.py (path:/tmp/pip-NWNQb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:17:18 INFO - Running setup.py (path:/tmp/pip-YaWgfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:17:18 INFO - Running setup.py (path:/tmp/pip-fW4TAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:17:18 INFO - Running setup.py (path:/tmp/pip-Fhyn5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:18 INFO - Running setup.py (path:/tmp/pip-Z5Zi9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:17:18 INFO - Running setup.py (path:/tmp/pip-vJwFqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:17:18 INFO - Running setup.py (path:/tmp/pip-s9qjNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:17:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:17:18 INFO - Running setup.py install for manifestparser 05:17:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:17:18 INFO - Running setup.py install for mozcrash 05:17:18 INFO - Running setup.py install for mozdebug 05:17:18 INFO - Running setup.py install for mozdevice 05:17:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:17:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:17:18 INFO - Running setup.py install for mozfile 05:17:19 INFO - Running setup.py install for mozhttpd 05:17:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:17:19 INFO - Running setup.py install for mozinfo 05:17:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:17:19 INFO - Running setup.py install for mozInstall 05:17:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:17:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:17:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:17:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:17:19 INFO - Running setup.py install for mozleak 05:17:19 INFO - Running setup.py install for mozlog 05:17:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:17:19 INFO - Running setup.py install for moznetwork 05:17:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:17:19 INFO - Running setup.py install for mozprocess 05:17:19 INFO - Running setup.py install for mozprofile 05:17:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:17:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:17:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:17:19 INFO - Running setup.py install for mozrunner 05:17:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:17:19 INFO - Running setup.py install for mozscreenshot 05:17:20 INFO - Running setup.py install for moztest 05:17:20 INFO - Running setup.py install for mozversion 05:17:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:17:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:17:20 INFO - Cleaning up... 05:17:20 INFO - Return code: 0 05:17:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17:20 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')]} 05:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:20 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')]} 05:17:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:20 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 0x7f8e2dc52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29049a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2993810>, '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 0x2994710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2994ba0>, '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': '41bf3e9aed84707956354da8000001c5-1462101504.771903-199676796', '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 05:17:20 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 05:17:20 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 05:17:20 INFO - Using env: {'DISPLAY': ':0', 05:17:20 INFO - 'HOME': '/home/cltbld', 05:17:20 INFO - 'LANG': 'en_US.UTF-8', 05:17:20 INFO - 'LANGUAGE': 'en_US:en', 05:17:20 INFO - 'LOGNAME': 'cltbld', 05:17:20 INFO - 'MAIL': '/var/mail/cltbld', 05:17:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:20 INFO - 'MOZ_NO_REMOTE': '1', 05:17:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:20 INFO - 'NO_EM_RESTART': '1', 05:17:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:20 INFO - 'PWD': '/builds/slave/test', 05:17:20 INFO - 'SHELL': '/bin/bash', 05:17:20 INFO - 'SHLVL': '1', 05:17:20 INFO - 'TERM': 'linux', 05:17:20 INFO - 'TMOUT': '86400', 05:17:20 INFO - 'USER': 'cltbld', 05:17:20 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1462101504.771903-199676796', 05:17:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:20 INFO - '_': '/tools/buildbot/bin/python'} 05:17:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:17:20 INFO - Running setup.py (path:/tmp/pip-weNJcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:17:20 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)) 05:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:17:20 INFO - Running setup.py (path:/tmp/pip-rh8V9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:17:20 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)) 05:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:17:20 INFO - Running setup.py (path:/tmp/pip-bKmliP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:17:20 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)) 05:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:17:20 INFO - Running setup.py (path:/tmp/pip-MHIACS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:17:20 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)) 05:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:17:20 INFO - Running setup.py (path:/tmp/pip-37diDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:17:20 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)) 05:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:17:20 INFO - Running setup.py (path:/tmp/pip-IPQBNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:17:20 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)) 05:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:17:20 INFO - Running setup.py (path:/tmp/pip-g6pzXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:17:21 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)) 05:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:17:21 INFO - Running setup.py (path:/tmp/pip-kXeTCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:17:21 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)) 05:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:17:21 INFO - Running setup.py (path:/tmp/pip-bJqBIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:17:21 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)) 05:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:17:21 INFO - Running setup.py (path:/tmp/pip-t1Mjk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:17:21 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)) 05:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:17:21 INFO - Running setup.py (path:/tmp/pip-Rkxu9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:17:21 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)) 05:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:17:21 INFO - Running setup.py (path:/tmp/pip-1G7tdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:17:21 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)) 05:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:17:21 INFO - Running setup.py (path:/tmp/pip-8UIhwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:17:21 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)) 05:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:17:21 INFO - Running setup.py (path:/tmp/pip-UQwYtr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:17:21 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)) 05:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:21 INFO - Running setup.py (path:/tmp/pip-ei2En6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:21 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)) 05:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:17:21 INFO - Running setup.py (path:/tmp/pip-ZgAtKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:17:21 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)) 05:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:17:21 INFO - Running setup.py (path:/tmp/pip-cJ7qpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:17:21 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)) 05:17:21 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)) 05:17:21 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)) 05:17:21 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)) 05:17:21 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)) 05:17:21 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)) 05:17:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:17:21 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 05:17:21 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 05:17:21 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 05:17:21 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 05:17:21 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 05:17:21 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 05:17:23 INFO - Downloading blessings-1.6.tar.gz 05:17:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:17:23 INFO - Installing collected packages: blessings 05:17:23 INFO - Running setup.py install for blessings 05:17:23 INFO - Successfully installed blessings 05:17:23 INFO - Cleaning up... 05:17:24 INFO - Return code: 0 05:17:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:17:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:17:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:17:24 INFO - Reading from file tmpfile_stdout 05:17:24 INFO - Current package versions: 05:17:24 INFO - argparse == 1.2.1 05:17:24 INFO - blessings == 1.6 05:17:24 INFO - blobuploader == 1.2.4 05:17:24 INFO - docopt == 0.6.1 05:17:24 INFO - manifestparser == 1.1 05:17:24 INFO - mozInstall == 1.12 05:17:24 INFO - mozcrash == 0.17 05:17:24 INFO - mozdebug == 0.1 05:17:24 INFO - mozdevice == 0.48 05:17:24 INFO - mozfile == 1.2 05:17:24 INFO - mozhttpd == 0.7 05:17:24 INFO - mozinfo == 0.9 05:17:24 INFO - mozleak == 0.1 05:17:24 INFO - mozlog == 3.1 05:17:24 INFO - moznetwork == 0.27 05:17:24 INFO - mozprocess == 0.22 05:17:24 INFO - mozprofile == 0.28 05:17:24 INFO - mozrunner == 6.11 05:17:24 INFO - mozscreenshot == 0.1 05:17:24 INFO - mozsystemmonitor == 0.0 05:17:24 INFO - moztest == 0.7 05:17:24 INFO - mozversion == 1.4 05:17:24 INFO - psutil == 3.1.1 05:17:24 INFO - requests == 1.2.3 05:17:24 INFO - wsgiref == 0.1.2 05:17:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17:24 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')]} 05:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:24 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')]} 05:17:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:24 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 0x7f8e2dc52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29049a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2993810>, '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 0x2994710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2994ba0>, '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': '41bf3e9aed84707956354da8000001c5-1462101504.771903-199676796', '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 05:17:24 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 05:17:24 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 05:17:24 INFO - Using env: {'DISPLAY': ':0', 05:17:24 INFO - 'HOME': '/home/cltbld', 05:17:24 INFO - 'LANG': 'en_US.UTF-8', 05:17:24 INFO - 'LANGUAGE': 'en_US:en', 05:17:24 INFO - 'LOGNAME': 'cltbld', 05:17:24 INFO - 'MAIL': '/var/mail/cltbld', 05:17:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:24 INFO - 'MOZ_NO_REMOTE': '1', 05:17:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:24 INFO - 'NO_EM_RESTART': '1', 05:17:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:24 INFO - 'PWD': '/builds/slave/test', 05:17:24 INFO - 'SHELL': '/bin/bash', 05:17:24 INFO - 'SHLVL': '1', 05:17:24 INFO - 'TERM': 'linux', 05:17:24 INFO - 'TMOUT': '86400', 05:17:24 INFO - 'USER': 'cltbld', 05:17:24 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1462101504.771903-199676796', 05:17:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:24 INFO - '_': '/tools/buildbot/bin/python'} 05:17:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:24 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)) 05:17:24 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)) 05:17:24 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)) 05:17:24 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)) 05:17:24 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)) 05:17:24 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)) 05:17:24 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)) 05:17:24 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)) 05:17:24 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)) 05:17:24 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)) 05:17:24 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)) 05:17:24 INFO - Cleaning up... 05:17:24 INFO - Return code: 0 05:17:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:17:24 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')]} 05:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:24 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')]} 05:17:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:24 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 0x7f8e2dc52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29049a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2993810>, '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 0x2994710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2994ba0>, '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': '41bf3e9aed84707956354da8000001c5-1462101504.771903-199676796', '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 05:17:24 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 05:17:24 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 05:17:24 INFO - Using env: {'DISPLAY': ':0', 05:17:24 INFO - 'HOME': '/home/cltbld', 05:17:24 INFO - 'LANG': 'en_US.UTF-8', 05:17:24 INFO - 'LANGUAGE': 'en_US:en', 05:17:24 INFO - 'LOGNAME': 'cltbld', 05:17:24 INFO - 'MAIL': '/var/mail/cltbld', 05:17:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:24 INFO - 'MOZ_NO_REMOTE': '1', 05:17:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:24 INFO - 'NO_EM_RESTART': '1', 05:17:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:24 INFO - 'PWD': '/builds/slave/test', 05:17:24 INFO - 'SHELL': '/bin/bash', 05:17:24 INFO - 'SHLVL': '1', 05:17:24 INFO - 'TERM': 'linux', 05:17:24 INFO - 'TMOUT': '86400', 05:17:24 INFO - 'USER': 'cltbld', 05:17:24 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1462101504.771903-199676796', 05:17:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:24 INFO - '_': '/tools/buildbot/bin/python'} 05:17:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:24 INFO - Downloading/unpacking jsonschema 05:17:24 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 05:17:24 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 05:17:24 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 05:17:24 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 05:17:24 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 05:17:24 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 05:17:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:17:26 INFO - Downloading/unpacking functools32 (from jsonschema) 05:17:26 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 05:17:26 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 05:17:26 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 05:17:26 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 05:17:26 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 05:17:26 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 05:17:26 INFO - Downloading functools32-3.2.3-2.tar.gz 05:17:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:17:26 INFO - warning: no files found matching '*.txt' 05:17:26 INFO - no previously-included directories found matching 'build' 05:17:26 INFO - no previously-included directories found matching 'dist' 05:17:26 INFO - no previously-included directories found matching '.git*' 05:17:26 INFO - Installing collected packages: jsonschema, functools32 05:17:26 INFO - Running setup.py install for functools32 05:17:26 INFO - warning: no files found matching '*.txt' 05:17:26 INFO - no previously-included directories found matching 'build' 05:17:26 INFO - no previously-included directories found matching 'dist' 05:17:26 INFO - no previously-included directories found matching '.git*' 05:17:26 INFO - Successfully installed jsonschema functools32 05:17:26 INFO - Cleaning up... 05:17:27 INFO - Return code: 0 05:17:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:17:27 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')]} 05:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:27 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')]} 05:17:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:27 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 0x7f8e2dc52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29049a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2993810>, '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 0x2994710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2994ba0>, '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': '41bf3e9aed84707956354da8000001c5-1462101504.771903-199676796', '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 05:17:27 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 05:17:27 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 05:17:27 INFO - Using env: {'DISPLAY': ':0', 05:17:27 INFO - 'HOME': '/home/cltbld', 05:17:27 INFO - 'LANG': 'en_US.UTF-8', 05:17:27 INFO - 'LANGUAGE': 'en_US:en', 05:17:27 INFO - 'LOGNAME': 'cltbld', 05:17:27 INFO - 'MAIL': '/var/mail/cltbld', 05:17:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:27 INFO - 'MOZ_NO_REMOTE': '1', 05:17:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:27 INFO - 'NO_EM_RESTART': '1', 05:17:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:27 INFO - 'PWD': '/builds/slave/test', 05:17:27 INFO - 'SHELL': '/bin/bash', 05:17:27 INFO - 'SHLVL': '1', 05:17:27 INFO - 'TERM': 'linux', 05:17:27 INFO - 'TMOUT': '86400', 05:17:27 INFO - 'USER': 'cltbld', 05:17:27 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1462101504.771903-199676796', 05:17:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:27 INFO - '_': '/tools/buildbot/bin/python'} 05:17:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:27 INFO - Downloading/unpacking flake8 05:17: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 05:17: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 05:17: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 05:17: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 05:17: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 05:17: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 05:17:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:17:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:17:29 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 05:17:29 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 05:17:29 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 05:17:29 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 05:17:29 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 05:17:29 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 05:17:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:17:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:17:29 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 05:17:29 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 05:17:29 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 05:17:29 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 05:17:29 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 05:17:29 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 05:17:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:17:29 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 05:17:29 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 05:17:29 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 05:17:29 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 05:17:29 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 05:17:29 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 05:17:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:17:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:17:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:17:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:17:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:17:29 INFO - no previously-included directories found matching 'docs/_build' 05:17:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:17:29 INFO - Running setup.py install for pep8 05:17:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:17:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:17:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:17:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:17:29 INFO - no previously-included directories found matching 'docs/_build' 05:17:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:17:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:17:30 INFO - Cleaning up... 05:17:30 INFO - Return code: 0 05:17:30 INFO - Running post-action listener: _resource_record_post_action 05:17:30 INFO - Running post-action listener: _start_resource_monitoring 05:17:30 INFO - Starting resource monitoring. 05:17:30 INFO - ##### 05:17:30 INFO - ##### Running install step. 05:17:30 INFO - ##### 05:17:30 INFO - Running pre-action listener: _resource_record_pre_action 05:17:30 INFO - Running main action method: install 05:17:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:17:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:17:30 INFO - Reading from file tmpfile_stdout 05:17:30 INFO - Detecting whether we're running mozinstall >=1.0... 05:17:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:17:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:17:30 INFO - Reading from file tmpfile_stdout 05:17:30 INFO - Output received: 05:17:30 INFO - Usage: mozinstall [options] installer 05:17:30 INFO - Options: 05:17:30 INFO - -h, --help show this help message and exit 05:17:30 INFO - -d DEST, --destination=DEST 05:17:30 INFO - Directory to install application into. [default: 05:17:30 INFO - "/builds/slave/test"] 05:17:30 INFO - --app=APP Application being installed. [default: firefox] 05:17:30 INFO - mkdir: /builds/slave/test/build/application 05:17:30 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'] 05:17:30 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 05:17:47 INFO - Reading from file tmpfile_stdout 05:17:47 INFO - Output received: 05:17:47 INFO - /builds/slave/test/build/application/firefox/firefox 05:17:47 INFO - Running post-action listener: _resource_record_post_action 05:17:47 INFO - ##### 05:17:47 INFO - ##### Running run-tests step. 05:17:47 INFO - ##### 05:17:47 INFO - Running pre-action listener: _resource_record_pre_action 05:17:47 INFO - Running main action method: run_tests 05:17:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:17:47 INFO - Python 2.7.3 05:17:47 INFO - Return code: 0 05:17:47 INFO - grabbing minidump binary from tooltool 05:17:47 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')]} 05:17:47 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 0x2993810>, '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 0x2994710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2994ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:17:47 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 05:17:47 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 05:17:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:17:47 INFO - Return code: 0 05:17:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:17:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:17:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:17:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:17:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:17:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:17:48 INFO - Return code: 0 05:17:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Rk4QgiZKSWqAheVMULiuwg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:17:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Rk4QgiZKSWqAheVMULiuwg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:17:48 INFO - Using env: {'DISPLAY': ':0', 05:17:48 INFO - 'HOME': '/home/cltbld', 05:17:48 INFO - 'LANG': 'en_US.UTF-8', 05:17:48 INFO - 'LANGUAGE': 'en_US:en', 05:17:48 INFO - 'LOGNAME': 'cltbld', 05:17:48 INFO - 'MAIL': '/var/mail/cltbld', 05:17:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:17:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:48 INFO - 'MOZ_NO_REMOTE': '1', 05:17:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:17:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:48 INFO - 'NO_EM_RESTART': '1', 05:17:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:48 INFO - 'PWD': '/builds/slave/test', 05:17:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:17:48 INFO - 'SHELL': '/bin/bash', 05:17:48 INFO - 'SHLVL': '1', 05:17:48 INFO - 'TERM': 'linux', 05:17:48 INFO - 'TMOUT': '86400', 05:17:48 INFO - 'USER': 'cltbld', 05:17:48 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1462101504.771903-199676796', 05:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:48 INFO - '_': '/tools/buildbot/bin/python'} 05:17:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Rk4QgiZKSWqAheVMULiuwg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:17:48 INFO - mozversion application_buildid: 20160501023016 05:17:48 INFO - mozversion application_changeset: 7e4ac3f24fa87986c044d9ee13c1cf557ea55d07 05:17:48 INFO - mozversion application_display_name: Nightly 05:17:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:17:48 INFO - mozversion application_name: Firefox 05:17:48 INFO - mozversion application_remotingname: firefox 05:17:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:17:48 INFO - mozversion application_vendor: Mozilla 05:17:48 INFO - mozversion application_version: 49.0a1 05:17:48 INFO - mozversion platform_buildid: 20160501023016 05:17:48 INFO - mozversion platform_changeset: 7e4ac3f24fa87986c044d9ee13c1cf557ea55d07 05:17:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:17:48 INFO - mozversion platform_version: 49.0a1 05:17:48 INFO - using testdate: 1462105068 05:17:48 INFO - actual date: 1462105068 05:17:48 INFO - starting webserver on 'localhost:51699' 05:17:48 INFO - SUITE-START | Running 2 tests 05:17:48 INFO - TEST-START | dromaeo_css 05:17:48 INFO - operating with platform_type : linux_ 05:17:48 INFO - Initialising browser for dromaeo_css test... 05:17:48 INFO - TEST-INFO | started process 12435 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCApVqa/profile http://localhost:51699/getInfo.html) 05:17:52 INFO - PROCESS | 12435 | __metrics Screen width/height:1600/1200 05:17:52 INFO - PROCESS | 12435 | colorDepth:24 05:17:52 INFO - PROCESS | 12435 | Browser inner width/height: 1024/697 05:17:52 INFO - PROCESS | 12435 | __metrics 05:17:53 ERROR - PROCESS | 12435 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:17:54 INFO - TEST-INFO | 12435: exit 0 05:17:54 INFO - Browser initialized. 05:17:54 INFO - Running cycle 1/1 for dromaeo_css test... 05:17:54 INFO - TEST-INFO | started process 12518 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCApVqa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:18:05 INFO - PROCESS | 12518 | RSS: Main: 154947584 05:18:05 INFO - PROCESS | 12518 | 05:18:56 INFO - PROCESS | 12518 | 1462105136934 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] 05:21:04 INFO - PROCESS | 12518 | Cycle 1(1): loaded http://localhost:51699/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51699/tests/dromaeo/cssquery-ext.html) 05:21:05 INFO - PROCESS | 12518 | RSS: Main: 253898752 05:21:05 INFO - PROCESS | 12518 | 05:24:07 INFO - PROCESS | 12518 | Cycle 1(1): loaded http://localhost:51699/tests/dromaeo/cssquery-ext.html (next: http://localhost:51699/tests/dromaeo/cssquery-jquery.html) 05:24:08 INFO - PROCESS | 12518 | RSS: Main: 234614784 05:24:08 INFO - PROCESS | 12518 | 05:27:10 INFO - PROCESS | 12518 | Cycle 1(1): loaded http://localhost:51699/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51699/tests/dromaeo/cssquery-mootools.html) 05:27:10 INFO - PROCESS | 12518 | RSS: Main: 240283648 05:27:10 INFO - PROCESS | 12518 | 05:30:12 INFO - PROCESS | 12518 | Cycle 1(1): loaded http://localhost:51699/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51699/tests/dromaeo/cssquery-prototype.html) 05:30:13 INFO - PROCESS | 12518 | RSS: Main: 241012736 05:30:13 INFO - PROCESS | 12518 | 05:33:15 INFO - PROCESS | 12518 | Cycle 1(1): loaded http://localhost:51699/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51699/tests/dromaeo/cssquery-yui.html) 05:33:16 INFO - PROCESS | 12518 | RSS: Main: 215400448 05:33:16 INFO - PROCESS | 12518 | 05:36:19 INFO - PROCESS | 12518 | Cycle 1(1): loaded http://localhost:51699/tests/dromaeo/cssquery-yui.html (next: http://localhost:51699/tests/dromaeo/cssquery-dojo.html) 05:36:19 INFO - PROCESS | 12518 | RSS: Main: 273936384 05:36:19 INFO - PROCESS | 12518 | 05:36:19 INFO - PROCESS | 12518 | __start_tp_report 05:36:19 INFO - PROCESS | 12518 | _x_x_mozilla_page_load 05:36:19 INFO - PROCESS | 12518 | _x_x_mozilla_page_load_details 05:36:19 INFO - PROCESS | 12518 | |i|pagename|runs| 05:36:19 INFO - PROCESS | 12518 | |0;dojo.html;3076.4001019801135;3127.9677706356906;3151.2909595341052;3166.1609673436556;3192.8403579821;5145.09960756867;5228.47715228478;5286.788528458857;5296.205569164627;5327.92008119878;5225.425203227642;5281.841544753654;5313.256144139824;5392.811251606195;5434.0218760623075;4781.330613714074;4781.450133234688;4809.807607695706;4827.468978412372;4977.104121258172;4892.730899800509;4905.0925578767865;4910.484399138093;4967.403911530621;4967.577755890754;4701.764911754416;4725.763711814396;4773.546513081252;4818.518148185189;4902.950970490285;4821.445533763627;4836.7823447944575;4840.322354870321;4847;4869.318295438641;4718.9292160617615;4788.353572267734;4803.327534145223;4810.591099756525;4845.927311090337;5116.718580478072;5166.483351664803;5168.457311982225;5179.14544100223;5209.973950130263;5476.67139971603;5479.890402191973;5501.064818980783;5509.063459211903;5509.196058477508;5521.420250873641;5565.359983601857;5604.859878503029;5681.460261275213;5704.600677952545;5204.505571970657;5216.686998780086;5220.347456567929;5223.3209682741;5249.580033597303;5665.150227465913;5665.348484924287;5667.1782591524825;5670.206171136044;5702.714864256771;5364.785408583691;5423.078076726966;5428.375736790241;5451.700156491431;5483.122700367922;5559.249501317351;5559.610827242054;5568.749406276727;5575.0522411190195;5583.748731307101;5544.750486228129;5546.750396232179;5549.0289199389945;5558.944410555923;5596.720163991784;5433.8369848904595;5589.636673616202;5600.271964644651;5642.069058605366;5655.981923253854;4236.195122926634;4259.23333799919;4262.829486820492;4265.0830071534765;4305.009847734976;3738.3831667775057;3827.196288779332;3838.980805095957;3859.4403811447182;3888.202918401721;5152.124138896396;5249;5313.070212712837;5348.224507446398;5353.38436079848;5634.577406694514;5697.658140511582;5699.772009119672;5701.914471282934;5709.257796486513;5148.30497882781;5300.946990530122;5324.760385782649;5340.786368545215;5400.486953739389;4756.500567440438;4798.2082956311815;4816.662833601685;4846.297286893451;4846.539578740014;5787.5080618147085;5843.444872737083;5844.240248767633;5847.590668653239;5849;5542.307211598551;5567.972160139336;5620.831375058837;5705.030144875298;5759.65442073477;5709.143628455765;5716.571257155647;5725.169850371756;5750.30996280449;5780.826575202751;5498.1752737089755;5499.395066542597;5499.670019798825;5509.862253443535;5518.779248830002;5357.544608708304;5510.035743744748;5572.4148964358155;5580.469855363896;5586.050371436947;5446.482584154499;5451.182322651634;5457.69982650958;5474.698891561003;5496.7526461308535;5420.105682562491;5424.457554244544;5427.782888684408;5450.972745136249;5505.311836020497;5184.040952423814;5348.919766203588;5356.678599284055;5426.67439953604;5446.618736688394;5447.536959358499;5447.754851031792;5450.836474905759;5459.617826752248;5460.372057213472;5310.734463276744;5338.919916201337;5353.009693206769;5355.25026496283;5405.837824865261 05:36:19 INFO - PROCESS | 12518 | |1;ext.html;591.6272748168653;627.3632263252799;641.4002907281695;641.6406812185176;654.4894981914106;31880.521792173105;37055.25889482209;37592.06019849505;37648.81175594125;37654.24691506168;40114.7994260029;40880.79559602205;40997.79501102498;40998.38502422466;41102;7728.6908523658985;7894.842103157934;8311.210435008665;8538.487690738544;8541.16364981529;9720.270979676518;9939.15517181037;9989.350692204984;9998.500074996258;10001.799964000716;10027.59889604415;10206.489675516232;10209.540570674337;10210.336328138685;10219.744506387362;7692.4615276930635;9752.561134748918;9874.60501579936;10077.042680945298;10081.092701656813;9992.050755178247;10141.39151650896;10155.89844101557;10157.593696252141;10174.338667986558;39016.60983390158;39723.40414893779;39817.60182398168;39839.8008009961;39866.20267594661;3420.538227339327;3497.6502349765074;3821.7515861468914;3874;3998.420229066769;32126.196845078826;33030.17424564381;33166.502502462485;33183.834080829685;33394;4266.1467706458525;4328.5455027222315;4443.688941774077;4447;4493.168763778679;310168;313261;314342;315013;315080;62142;62608.686956564925;62775.68612157001;62797.686011570564;62872;65927;65992.34007659862;66090.66954665196;66399;66461.33538664551;16898.493045208663;17011.48965531036;17194.1402929853;17222;17249.827501725074;13161.53934612303;13221.338933053308;13223.537176198786;13226.074174807864;13231.603051908458;18227.340026266553;20104.98425236226;20153.697694534592;20238.291659791837;20278.290259840836;5543;6643.701033453506;6805.455563554904;6865.176178858569;6911.75808846688;999.4053538144792;1070.6573896353248;1083.6748975307376;1126.3748619516248;1149.954001839917;28943.71056289452;29692;29894.701052989625;30381.24046898801;30473.085807425814;1109.5728144664201;1112.410422476089;1116.3486719042276;1129.3788416370962;1215.750771091924;16895.155242238085;17105.572360690832;17232.569185770204;17241;17394.21726022332;310300;311923;312990;317573;462707;54660.72669636626;55185.44814551803;55423.44576554264;55603;55909.72045139748;1288.22062652096;1372.9588112356446;1387.833459984788;1388.0283801339103;1404.45226361719;28732.281692957007;31392.529112063796;32050.679493205702;33443.33113337671;33501.49747753737;50134;50452.49547504478;51045;51055;51088.48911510837;372189;375073;375272;375408;376851;33320.66679333176;38500.614993850824;38857.6114238854;39129.6087039126;43431.78284108685;43760.12479750451;44301;44376.33435498406;44593.331100032876;45526.54473455223;37604.99160067133;38269.617303826606;40966;41650;41872.371914421914;39402.40896386499;40489.79755101206;40929.59070409258;41177.79411102925;41316.38025429561;36919.8154009239;37619.811900941415;37717.81141094277;41091;41158.38262426006;31268.68731312658;32917.17707057343;33750.324993499504;33817.83091084529;35266;27062.458750825266;27469.17592472229;27550.5867411993;27595.58606620862;27902 05:36:19 INFO - PROCESS | 12518 | |2;jquery.html;369.76335145506874;373.9813009349532;379.27936919852283;384.5443149867406;384.55775857763587;17960.946639071357;17998.370057048007;18831.811681883177;19031.333903313385;19042.2383104676;17925.282988680436;18066.72899906499;18841.905790471028;18857.057147142656;18906.810931890675;5040.445550989398;5156;5192.6624769390055;5210.16637338026;5210.869728256786;3754.4743735877;3978.9602103978877;5685.658860468365;5697.914531282034;5699.401562835905;5490.56075513958;5564.5254007688;5573.554115670757;5588.86027849303;5596.944030559683;3854.402567602026;5353.411124776271;5428.5928555358505;5546.750396232179;5745.942540574582;5551.777928882881;5557.3886872444;5572.804951826707;5581.358143813472;5582.665040097607;13163.407646655924;13438.395272212774;13613.455461781517;13617.931910340483;13634;2286.325533967484;2339.7894189522854;2366.5148644528003;2499.4751102268547;2613.4773045391;9568.952155239249;9651.613935442574;9652.565634546392;10169.694909152737;10271.79456410875;1913.655542002439;1923.6633589121989;1930.9806901930942;1965.6167047425758;1974.3583335416047;75908.62045689792;78196.21803781946;80741.19258807396;81205.59397202976;81973;9442.15020648145;9442.669506567374;9486.715398538056;9552.665656701982;9618.903810961941;12806.295653739135;12834.29411382383;12836.871631283568;12866.035047371484;12866.614001579968;7603.505772124905;7685.769426917202;7701.460897737216;7748.728794492165;7841.921580784233;7693.307602315818;7694.730684426018;7759.961200194076;7922.603869806602;7923.12845586985;3922.3332033554366;3951.5060617422823;3966.940495892564;4057.918841623151;4071.368937814584;1641.5075477356745;1680.8823382363362;1704.1479260369815;1712.3664244229465;1732.6534693061437;957.0716405087054;966.9323147379756;1011.6155860773007;1030.6701855406197;1048.1038711901215;17863.26489934208;18120.728189077174;18476.907615461838;18786.624267514573;18788.342408015655;950.5864948747317;991.7669347703284;1000.5797565022708;1014.1075853249241;1042.4475028235047;9864.161546268504;10140.340877842917;10233.846492302622;10244.53899574521;10298.845517317246;488319;491503;492738;498292;499103;84985.15014849896;86570.56714716511;88032;88096;88525.55737221273;1036.7252678040325;1045.7542477517777;1047.876605557135;1055.72551136705;1063.4576366053368;15488.380464781283;15860.76208856845;15944.681106378039;16167.838321616633;16489.34042638281;35019.47470787889;35975.460368093976;36943;37127.25745485129;38403;49473.94152245096;54346;54668.45331546793;59152.40847591469;59295.110573342296;8382.455140415854;8509.851170092206;8583.785405364666;8608.956955215184;8805.031446541003;9464.479453630116;12298.077644176901;12902.096853220184;12952.41714122848;13093.279869606882;10875.945620271848;11049.613263535737;11334.149938754792;11708;11712.180147389941;11254.212205145888;11348.546058157912;11444.599439019594;11451.885481145415;11548.307101573933;6433.613983161025;8501.404901656824;11343.943280283545;11493.48279327449;11696.976057330652;8491.83016339682;8565.143485651384;8603.225709686158;8619;8665.653373864974;11365.374904380338;11465.770684586429;11512.19414640967;11570.363630000431;11570.826437603275 05:36:19 INFO - PROCESS | 12518 | |3;mootools.html;1310.9934450327746;1462.4588902106218;1480.9851901480986;1598.7362085255934;1748.9999999999993;7603.087629484463;7915.722949696762;7950.1652326505755;7971.840563188747;7976.840463190732;7677.270659287359;7928.326092282163;7933.484323518967;7936.325412339958;7940.801479962989;1904.7238150468174;2070.171931227506;2135.5728854229137;2160.0819651648067;2193.4406726284774;2177.140029688272;2193.331034034619;2198.9560208795815;2200.702905107814;2203.4160947348964;2077.0549400022956;2138.967915481261;2139.732533433321;2141.122139922632;2144.613969485492;1836.366453573515;2079.272254710854;2142.2502124256384;2145.9785402145935;2146.0450099705636;2061.0313152818153;2082.989585052065;2083.1875568528285;2084.4476213803205;2127.8829664368454;7559.470837041409;7640.808979775495;7647.579383133925;7661.463697541174;7807;4591.471980722193;4778.665493415462;4813.494583068762;4815.446223684251;4820.39745031871;2914;2929.8828046878098;2937.867795949166;2945.410917816424;2983.34366439383;978.3005151316771;982.9705108846746;999.8400255959011;1002.6039714312878;1005.3515482513737;10567.207459440573;10572.259941804077;10588.311759735592;10588.735281617945;10602.151827853753;4030.7380020298588;4064.227796718614;4119.526254480713;4222.683298752606;4254.085371645111;9054.275657947348;9067.546622668971;9069.093090690878;9079.863802042975;9087.409318394282;4307.633851122627;4753.524647535288;4783.976080119577;4819.927701084486;4826.083044221657;4013.3779264214095;4014.7791871447353;4041.818118184689;4300.677449191323;4382.780860956939;3469.6877281044826;3483.808390538494;3514.894553163409;3523.5419395478425;3581.6239294874185;1103.4923934989833;1132.9773404531863;1140.674907651332;1144.13046084976;1146.1060372909144;907.3557773980416;919.0212423768666;928.1878356438117;939.8637197606308;943.6697155995485;5456.181572764117;5459.235707001023;5470.945290547043;5487.6158668893595;5610.13042978339;913.3515204204956;924.8381533231658;935.4106912644991;953.6948176583427;955.9904400956041;3951.427043078795;4060.289449346412;4077.6533994610195;4081.3265811141423;4133.04939863827;9495.525223738923;9669.613215471443;9677.467739274407;9807.75480612976;9830.262730295113;9501.714948551555;9586.328956973084;9691.951540242253;9702.951485242529;9713.174380177623;7140.178879428932;7245.094363204599;7254.818629534198;7295.635218239173;7298.051253337138;5258.8948221036135;5354.170103633943;5543.916841247304;5556.277683901067;5609.663420194802;8772.429792063496;8798.868016979623;8948;9016.143466370684;9039.95480022622;9182.081791820765;9196.724098277062;9283.814323713623;9397.201237894582;9410.576524056298;6614.768483103068;6876.828079298058;6877.89683154763;7152.392046675883;7295.088113985752;7307.744228951961;7561.546307221584;7731.690732370642;7765.339946104645;7773.611319434119;6926.8614627708175;7041.084658994503;7078.292170782881;7117.964410177916;7222.674979625825;6943.305669433016;6962.164540254999;7057.36483716468;7102.893456598258;7287.125544934642;6620.404163625297;6638;6683.532152749261;6688.130543029375;6691.1636045494315;4799.160146974195;4822.855314340575;4943.826966056171;4997.3253610762085;5085.338905942203;5006.924896126488;5033.874153146201;5036.546710796046;5076.670016448919;5095.643304968617 05:36:19 INFO - PROCESS | 12518 | |4;prototype.html;312.55304913973026;313.107643216832;314.317930091701;317.9014505503293;317.9062176657886;5168.847003327972;5197.974010129944;5230.346206724154;5247.737613119339;5252.553532949699;5119.360079990001;5156.278121063054;5163.793448262065;5203.4796520347945;5209.817656382027;3875.5543112542136;3887.328448767029;3998.7200895937294;4022.296098182821;4050.534188568323;3952.901177470572;4016.15660711251;4018.176273863851;4018.45750823638;4035.3745169498775;3840.8079596020225;3980.383040628707;3988.960110398888;3995.1011022519847;4007.338789099795;3898.5321761388673;4031.4355990161107;4046.5751096134777;4048.5951404859575;4062.2281766464275;3527.5943266524164;3545.556805399325;3550.6981906537717;3555.839987200556;3556.3598552260582;5006.098902197603;5008.449070602231;5016.498350164954;5024.723640199788;5032.043911656773;4527.818887244506;4602.355670206174;4611.423572053493;4614.238650622643;4616.469106052813;5376.247325374451;5389.248494239388;5411.512963833235;5442.510174084312;5457.426970168115;3904.4533765272886;3917.9608203917883;3931.862384816546;3936.6063393660406;3947.4473573699706;5413.485718856702;5624.91562626561;5647.09646456569;5658.85852853682;5680.886382272372;3975.2447035063246;3975.900602484961;3978.1645854370327;4014.297497937908;4017.658499027557;4025.2352053109817;4036.9394459083137;4041.3533834586324;4048.554658987509;4059.6955228357992;4495.505494395614;4562.543745625478;4588.403507543998;4591.1965406053805;4642.53574642533;5366.436524164985;5443.346798384219;5467.890642187134;5481.588880833953;5529.723513824292;1480.8963372564033;1489.0321291160833;1489.1809504772332;1493.2309860421892;1494.1184701026446;948.6442584030989;991.5637119667323;1006.7281833904951;1015.6292953072076;1022.1771473963382;5531.834044978657;5553.139263414178;5592.5246354059545;5596.524295434852;5620.297462817148;5859.882802343929;5888.528917686661;5929.466348028612;5971.19388882504;5982.850428739229;5410.864728381822;5516.475934786189;5591.916121258185;5613.887722245614;5617.831465055973;3166.62503122658;3178.3166619176527;3184.188032051812;3188.3623275345026;3188.963586834288;5955.642661440327;6122.234720659918;6126.571140020245;6136.7852125175405;6138.07928810682;5969.820905372759;5983.401659834069;6017.428344307284;6041.395860413923;6051.636901785819;6038.547108966845;6088.4824789893355;6092.695365231721;6107.511399088063;6117.663528505975;5824.883502330014;5948.583599148191;5978.581499295182;5982.371850955587;5989.1914591529585;5820.563457740771;5834.445727655866;5839.474447299764;5846.678432686073;5861.794837180678;5926.496247818984;6042.758289668364;6058.12157237207;6072.362401947732;6086;4181.1428657125825;4228.661707063366;4244.151169765997;4244.702870799138;4255.936160957526;5907.143464197753;5922.407759224043;5927.644341339534;5936.961031819501;5974.074018527135;5555.916661250004;5732.71336433185;5767.134929760569;5773.53811695055;5820.912686309794;5728.997425450446;5746.626469279484;5749.54003679713;5778.353169346716;5784.4504772046585;5091.439941606346;5123.487651234846;5261.237120617566;5695.259616249861;5714.742836572281;5529.861753456195;5537.6954267515675;5538.363088244903;5592.7203639817035;5600.523955463831;5395.514403703685;5466.72666366688;5491.478309560585;5509.146082357241;5524 05:36:19 INFO - PROCESS | 12518 | |5;yui.html;778.3267473635306;838.6477679374664;843.1484200957032;843.991560084399;852.8507511185541;13193.34033298336;13432.126911750755;13447.1259368141;13460.798088028687;13475.460981560725;12945.676358091052;13175.93412032941;13251.072424930235;13263.668408289797;13549.729005419886;802.2939812964597;812.8902598149263;813.1218284253022;813.9470934389275;814.42989907065;794.0233512779284;796.928276455119;805.0741647105816;805.0781854776278;805.842860642175;839.290799274612;849.0660273698943;850.1116333431579;850.9574521273943;852.1265702654797;839.2111415269658;843.1863251961855;847.5889193741092;848.3171047306915;848.5969164646805;607.1257389359308;611.0467670434092;616.9598976066542;617.3332800575367;617.5646169450526;12753.681157971125;12780.872191278155;12793.744125117446;12810;12823.230606163566;11575.36335501547;11635.476403561775;11681.2407193533;11692.181547291693;11786.292822430596;10378.792424151474;10462.843057354146;10481.58073677052;10645.041946224877;10722.571097156104;3705.6850167735774;3745.6628903398823;3759.9436008459893;3770.8868733938025;3806.543214814212;40105;52441;53828.461715382735;54135;54294.72852635751;11328.320300781814;11421.143414243965;11511.251768635011;11605.76788464226;11855.17013809025;20289.086991085438;20319.085641146183;20336.491587710425;20361.592768144554;20366.592668146553;8173.754787356389;8255;8268.421210515327;8350.540720260444;8507.078507078459;4586.862394128115;4590.42619672541;4633;4693.577578017995;4821.493743156988;3181.0774875285906;3342.615599206074;3391.236971681352;3405.1827561385585;3405.250844814137;620.0606081786098;637.9681015949184;642.2710223895818;652.9510286728514;656.0061506817176;680.1803826389189;700.8563244534859;710.9111361079865;719.5682590445796;723;8907.376483646083;9252.444853308823;9342.392744471588;9387.90612093884;9441;686.1594546680376;689.7310049080862;694.264080075122;700.4536461559991;705.6330708031795;4073.089437346235;4291.184674911757;4319.265724826787;4320.222359975234;4389.4732632083715;49661.50338496641;51174.744126279875;51241.48758512367;51372.48627513752;51403;41570;48532.7573362138;49908.50091499111;54042;56629.71685141548;45863;48527.75736121368;48607.75696121497;49077.50922490729;49590;9379.827521559804;9606.27952903521;9612.327137100336;9681.225501959967;9775.21798256152;31784.36431271408;33067.83466082654;33100.33799323952;33435.49846752252;33777.32445351128;42273.577264226966;44105.11789764251;44918;45634;45740.771296143306;11598.246114002563;12128.332941688292;12198.085143614087;12271.75456490883;12538.937305313415;13302.667433314244;13723.862761372258;14201.715965680834;14238.928805355907;14575.979208467901;13021.283829389475;13496.797548036984;13559.728805424034;13780.517681881087;13953.511627093003;12940.870591294342;13065.673358166121;13211.405486752927;13286.402111905181;13371.598852034454;12521.37393130358;12818.487260509475;12862.485500579873;12894.226346419246;12993.870061299265;10570.894291057299;10580.41807700584;10813.67558973232;10899.237053406503;11061.281016733887;11270.83093753578;11337.659870203906;11432.256903301259;11511.827322590001;11583.710407239887 05:36:19 INFO - PROCESS | 12518 | __end_tp_report 05:36:19 INFO - PROCESS | 12518 | __start_cc_report 05:36:19 INFO - PROCESS | 12518 | _x_x_mozilla_cycle_collect,870 05:36:19 INFO - PROCESS | 12518 | __end_cc_report 05:36:19 INFO - PROCESS | 12518 | __startTimestamp1462106179275__endTimestamp 05:36:19 INFO - PROCESS | 12518 | 05:36:19 INFO - PROCESS | 12518 | ------- Summary: start ------- 05:36:19 INFO - PROCESS | 12518 | Number of tests: 6 05:36:19 INFO - PROCESS | 12518 | 05:36:19 INFO - PROCESS | 12518 | [#0] dojo.html Cycles:165 Average:5203.73 Median:5400.49 stddev:564.02 (10.4%) stddev-sans-first:540.50 05:36:19 INFO - PROCESS | 12518 | Values: 3076.4 3128.0 3151.3 3166.2 3192.8 5145.1 5228.5 5286.8 5296.2 5327.9 5225.4 5281.8 5313.3 5392.8 5434.0 4781.3 4781.5 4809.8 4827.5 4977.1 4892.7 4905.1 4910.5 4967.4 4967.6 4701.8 4725.8 4773.5 4818.5 4903.0 4821.4 4836.8 4840.3 4847.0 4869.3 4718.9 4788.4 4803.3 4810.6 4845.9 5116.7 5166.5 5168.5 5179.1 5210.0 5476.7 5479.9 5501.1 5509.1 5509.2 5521.4 5565.4 5604.9 5681.5 5704.6 5204.5 5216.7 5220.3 5223.3 5249.6 5665.2 5665.3 5667.2 5670.2 5702.7 5364.8 5423.1 5428.4 5451.7 5483.1 5559.2 5559.6 5568.7 5575.1 5583.7 5544.8 5546.8 5549.0 5558.9 5596.7 5433.8 5589.6 5600.3 5642.1 5656.0 4236.2 4259.2 4262.8 4265.1 4305.0 3738.4 3827.2 3839.0 3859.4 3888.2 5152.1 5249.0 5313.1 5348.2 5353.4 5634.6 5697.7 5699.8 5701.9 5709.3 5148.3 5300.9 5324.8 5340.8 5400.5 4756.5 4798.2 4816.7 4846.3 4846.5 5787.5 5843.4 5844.2 5847.6 5849.0 5542.3 5568.0 5620.8 5705.0 5759.7 5709.1 5716.6 5725.2 5750.3 5780.8 5498.2 5499.4 5499.7 5509.9 5518.8 5357.5 5510.0 5572.4 5580.5 5586.1 5446.5 5451.2 5457.7 5474.7 5496.8 5420.1 5424.5 5427.8 5451.0 5505.3 5184.0 5348.9 5356.7 5426.7 5446.6 5447.5 5447.8 5450.8 5459.6 5460.4 5310.7 5338.9 5353.0 5355.3 5405.8 05:36:19 INFO - PROCESS | 12518 | 05:36:19 INFO - PROCESS | 12518 | [#1] ext.html Cycles:180 Average:52108.72 Median:37598.53 stddev:90901.89 (241.8%) stddev-sans-first:91074.60 05:36:19 INFO - PROCESS | 12518 | Values: 591.6 627.4 641.4 641.6 654.5 31880.5 37055.3 37592.1 37648.8 37654.2 40114.8 40880.8 40997.8 40998.4 41102.0 7728.7 7894.8 8311.2 8538.5 8541.2 9720.3 9939.2 9989.4 9998.5 10001.8 10027.6 10206.5 10209.5 10210.3 10219.7 7692.5 9752.6 9874.6 10077.0 10081.1 9992.1 10141.4 10155.9 10157.6 10174.3 39016.6 39723.4 39817.6 39839.8 39866.2 3420.5 3497.7 3821.8 3874.0 3998.4 32126.2 33030.2 33166.5 33183.8 33394.0 4266.1 4328.5 4443.7 4447.0 4493.2 310168.0 313261.0 314342.0 315013.0 315080.0 62142.0 62608.7 62775.7 62797.7 62872.0 65927.0 65992.3 66090.7 66399.0 66461.3 16898.5 17011.5 17194.1 17222.0 17249.8 13161.5 13221.3 13223.5 13226.1 13231.6 18227.3 20105.0 20153.7 20238.3 20278.3 5543.0 6643.7 6805.5 6865.2 6911.8 999.4 1070.7 1083.7 1126.4 1150.0 28943.7 29692.0 29894.7 30381.2 30473.1 1109.6 1112.4 1116.3 1129.4 1215.8 16895.2 17105.6 17232.6 17241.0 17394.2 310300.0 311923.0 312990.0 317573.0 462707.0 54660.7 55185.4 55423.4 55603.0 55909.7 1288.2 1373.0 1387.8 1388.0 1404.5 28732.3 31392.5 32050.7 33443.3 33501.5 50134.0 50452.5 51045.0 51055.0 51088.5 372189.0 375073.0 375272.0 375408.0 376851.0 33320.7 38500.6 38857.6 39129.6 43431.8 43760.1 44301.0 44376.3 44593.3 45526.5 37605.0 38269.6 40966.0 41650.0 41872.4 39402.4 40489.8 40929.6 41177.8 41316.4 36919.8 37619.8 37717.8 41091.0 41158.4 31268.7 32917.2 33750.3 33817.8 35266.0 27062.5 27469.2 27550.6 27595.6 27902.0 05:36:19 INFO - PROCESS | 12518 | 05:36:19 INFO - PROCESS | 12518 | [#2] jquery.html Cycles:180 Average:28032.16 Median:2066.88 stddev:81388.64 (3937.8%) stddev-sans-first:81590.45 05:36:19 INFO - PROCESS | 12518 | Values: 369.8 374.0 379.3 384.5 384.6 17960.9 17998.4 18831.8 19031.3 19042.2 17925.3 18066.7 18841.9 18857.1 18906.8 5040.4 5156.0 5192.7 5210.2 5210.9 3754.5 3979.0 5685.7 5697.9 5699.4 5490.6 5564.5 5573.6 5588.9 5596.9 3854.4 5353.4 5428.6 5546.8 5745.9 5551.8 5557.4 5572.8 5581.4 5582.7 13163.4 13438.4 13613.5 13617.9 13634.0 2286.3 2339.8 2366.5 2499.5 2613.5 9569.0 9651.6 9652.6 10169.7 10271.8 1913.7 1923.7 1931.0 1965.6 1974.4 75908.6 78196.2 80741.2 81205.6 81973.0 9442.2 9442.7 9486.7 9552.7 9618.9 12806.3 12834.3 12836.9 12866.0 12866.6 7603.5 7685.8 7701.5 7748.7 7841.9 7693.3 7694.7 7760.0 7922.6 7923.1 3922.3 3951.5 3966.9 4057.9 4071.4 1641.5 1680.9 1704.1 1712.4 1732.7 957.1 966.9 1011.6 1030.7 1048.1 17863.3 18120.7 18476.9 18786.6 18788.3 950.6 991.8 1000.6 1014.1 1042.4 9864.2 10140.3 10233.8 10244.5 10298.8 488319.0 491503.0 492738.0 498292.0 499103.0 84985.2 86570.6 88032.0 88096.0 88525.6 1036.7 1045.8 1047.9 1055.7 1063.5 15488.4 15860.8 15944.7 16167.8 16489.3 35019.5 35975.5 36943.0 37127.3 38403.0 49473.9 54346.0 54668.5 59152.4 59295.1 8382.5 8509.9 8583.8 8609.0 8805.0 9464.5 12298.1 12902.1 12952.4 13093.3 10875.9 11049.6 11334.1 11708.0 11712.2 11254.2 11348.5 11444.6 11451.9 11548.3 6433.6 8501.4 11343.9 11493.5 11697.0 8491.8 8565.1 8603.2 8619.0 8665.7 11365.4 11465.8 11512.2 11570.4 11570.8 05:36:19 INFO - PROCESS | 12518 | 05:36:19 INFO - PROCESS | 12518 | [#3] mootools.html Cycles:180 Average:5238.21 Median:5465.09 stddev:2902.33 (53.1%) stddev-sans-first:2895.46 05:36:19 INFO - PROCESS | 12518 | Values: 1311.0 1462.5 1481.0 1598.7 1749.0 7603.1 7915.7 7950.2 7971.8 7976.8 7677.3 7928.3 7933.5 7936.3 7940.8 1904.7 2070.2 2135.6 2160.1 2193.4 2177.1 2193.3 2199.0 2200.7 2203.4 2077.1 2139.0 2139.7 2141.1 2144.6 1836.4 2079.3 2142.3 2146.0 2146.0 2061.0 2083.0 2083.2 2084.4 2127.9 7559.5 7640.8 7647.6 7661.5 7807.0 4591.5 4778.7 4813.5 4815.4 4820.4 2914.0 2929.9 2937.9 2945.4 2983.3 978.3 983.0 999.8 1002.6 1005.4 10567.2 10572.3 10588.3 10588.7 10602.2 4030.7 4064.2 4119.5 4222.7 4254.1 9054.3 9067.5 9069.1 9079.9 9087.4 4307.6 4753.5 4784.0 4819.9 4826.1 4013.4 4014.8 4041.8 4300.7 4382.8 3469.7 3483.8 3514.9 3523.5 3581.6 1103.5 1133.0 1140.7 1144.1 1146.1 907.4 919.0 928.2 939.9 943.7 5456.2 5459.2 5470.9 5487.6 5610.1 913.4 924.8 935.4 953.7 956.0 3951.4 4060.3 4077.7 4081.3 4133.0 9495.5 9669.6 9677.5 9807.8 9830.3 9501.7 9586.3 9692.0 9703.0 9713.2 7140.2 7245.1 7254.8 7295.6 7298.1 5258.9 5354.2 5543.9 5556.3 5609.7 8772.4 8798.9 8948.0 9016.1 9040.0 9182.1 9196.7 9283.8 9397.2 9410.6 6614.8 6876.8 6877.9 7152.4 7295.1 7307.7 7561.5 7731.7 7765.3 7773.6 6926.9 7041.1 7078.3 7118.0 7222.7 6943.3 6962.2 7057.4 7102.9 7287.1 6620.4 6638.0 6683.5 6688.1 6691.2 4799.2 4822.9 4943.8 4997.3 5085.3 5006.9 5033.9 5036.5 5076.7 5095.6 05:36:19 INFO - PROCESS | 12518 | 05:36:19 INFO - PROCESS | 12518 | [#4] prototype.html Cycles:180 Average:4712.38 Median:5313.84 stddev:1418.80 (26.7%) stddev-sans-first:1383.81 05:36:19 INFO - PROCESS | 12518 | Values: 312.6 313.1 314.3 317.9 317.9 5168.8 5198.0 5230.3 5247.7 5252.6 5119.4 5156.3 5163.8 5203.5 5209.8 3875.6 3887.3 3998.7 4022.3 4050.5 3952.9 4016.2 4018.2 4018.5 4035.4 3840.8 3980.4 3989.0 3995.1 4007.3 3898.5 4031.4 4046.6 4048.6 4062.2 3527.6 3545.6 3550.7 3555.8 3556.4 5006.1 5008.4 5016.5 5024.7 5032.0 4527.8 4602.4 4611.4 4614.2 4616.5 5376.2 5389.2 5411.5 5442.5 5457.4 3904.5 3918.0 3931.9 3936.6 3947.4 5413.5 5624.9 5647.1 5658.9 5680.9 3975.2 3975.9 3978.2 4014.3 4017.7 4025.2 4036.9 4041.4 4048.6 4059.7 4495.5 4562.5 4588.4 4591.2 4642.5 5366.4 5443.3 5467.9 5481.6 5529.7 1480.9 1489.0 1489.2 1493.2 1494.1 948.6 991.6 1006.7 1015.6 1022.2 5531.8 5553.1 5592.5 5596.5 5620.3 5859.9 5888.5 5929.5 5971.2 5982.9 5410.9 5516.5 5591.9 5613.9 5617.8 3166.6 3178.3 3184.2 3188.4 3189.0 5955.6 6122.2 6126.6 6136.8 6138.1 5969.8 5983.4 6017.4 6041.4 6051.6 6038.5 6088.5 6092.7 6107.5 6117.7 5824.9 5948.6 5978.6 5982.4 5989.2 5820.6 5834.4 5839.5 5846.7 5861.8 5926.5 6042.8 6058.1 6072.4 6086.0 4181.1 4228.7 4244.2 4244.7 4255.9 5907.1 5922.4 5927.6 5937.0 5974.1 5555.9 5732.7 5767.1 5773.5 5820.9 5729.0 5746.6 5749.5 5778.4 5784.5 5091.4 5123.5 5261.2 5695.3 5714.7 5529.9 5537.7 5538.4 5592.7 5600.5 5395.5 5466.7 5491.5 5509.1 5524.0 05:36:19 INFO - PROCESS | 12518 | 05:36:19 INFO - PROCESS | 12518 | [#5] yui.html Cycles:180 Average:14151.26 Median:4319.74 stddev:15601.90 (361.2%) stddev-sans-first:15613.35 05:36:19 INFO - PROCESS | 12518 | Values: 778.3 838.6 843.1 844.0 852.9 13193.3 13432.1 13447.1 13460.8 13475.5 12945.7 13175.9 13251.1 13263.7 13549.7 802.3 812.9 813.1 813.9 814.4 794.0 796.9 805.1 805.1 805.8 839.3 849.1 850.1 851.0 852.1 839.2 843.2 847.6 848.3 848.6 607.1 611.0 617.0 617.3 617.6 12753.7 12780.9 12793.7 12810.0 12823.2 11575.4 11635.5 11681.2 11692.2 11786.3 10378.8 10462.8 10481.6 10645.0 10722.6 3705.7 3745.7 3759.9 3770.9 3806.5 40105.0 52441.0 53828.5 54135.0 54294.7 11328.3 11421.1 11511.3 11605.8 11855.2 20289.1 20319.1 20336.5 20361.6 20366.6 8173.8 8255.0 8268.4 8350.5 8507.1 4586.9 4590.4 4633.0 4693.6 4821.5 3181.1 3342.6 3391.2 3405.2 3405.3 620.1 638.0 642.3 653.0 656.0 680.2 700.9 710.9 719.6 723.0 8907.4 9252.4 9342.4 9387.9 9441.0 686.2 689.7 694.3 700.5 705.6 4073.1 4291.2 4319.3 4320.2 4389.5 49661.5 51174.7 51241.5 51372.5 51403.0 41570.0 48532.8 49908.5 54042.0 56629.7 45863.0 48527.8 48607.8 49077.5 49590.0 9379.8 9606.3 9612.3 9681.2 9775.2 31784.4 33067.8 33100.3 33435.5 33777.3 42273.6 44105.1 44918.0 45634.0 45740.8 11598.2 12128.3 12198.1 12271.8 12538.9 13302.7 13723.9 14201.7 14238.9 14576.0 13021.3 13496.8 13559.7 13780.5 13953.5 12940.9 13065.7 13211.4 13286.4 13371.6 12521.4 12818.5 12862.5 12894.2 12993.9 10570.9 10580.4 10813.7 10899.2 11061.3 11270.8 11337.7 11432.3 11511.8 11583.7 05:36:19 INFO - PROCESS | 12518 | -------- Summary: end -------- 05:36:19 INFO - PROCESS | 12518 | 05:36:19 INFO - TEST-INFO | 12518: exit 0 05:36:19 INFO - TEST-OK | dromaeo_css | took 1111761ms 05:36:19 INFO - TEST-START | kraken 05:36:19 INFO - operating with platform_type : linux_ 05:36:19 INFO - Initialising browser for kraken test... 05:36:20 INFO - TEST-INFO | started process 12695 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFwN6fE/profile http://localhost:51699/getInfo.html) 05:36:23 INFO - PROCESS | 12695 | __metrics Screen width/height:1600/1200 05:36:23 INFO - PROCESS | 12695 | colorDepth:24 05:36:23 INFO - PROCESS | 12695 | Browser inner width/height: 1024/697 05:36:23 INFO - PROCESS | 12695 | __metrics 05:36:24 ERROR - PROCESS | 12695 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:36:25 INFO - TEST-INFO | 12695: exit 0 05:36:25 INFO - Browser initialized. 05:36:25 INFO - Running cycle 1/1 for kraken test... 05:36:25 INFO - TEST-INFO | started process 12776 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFwN6fE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:36:37 INFO - PROCESS | 12776 | RSS: Main: 154517504 05:36:37 INFO - PROCESS | 12776 | 05:36:39 INFO - PROCESS | 12776 | Cycle 1(1): loaded http://localhost:51699/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51699/tests/kraken/driver.html?testName=audio-beat-detection) 05:36:40 INFO - PROCESS | 12776 | RSS: Main: 209772544 05:36:40 INFO - PROCESS | 12776 | 05:36:43 INFO - PROCESS | 12776 | Cycle 1(1): loaded http://localhost:51699/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51699/tests/kraken/driver.html?testName=audio-dft) 05:36:44 INFO - PROCESS | 12776 | RSS: Main: 196059136 05:36:44 INFO - PROCESS | 12776 | 05:36:47 INFO - PROCESS | 12776 | Cycle 1(1): loaded http://localhost:51699/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51699/tests/kraken/driver.html?testName=audio-fft) 05:36:47 INFO - PROCESS | 12776 | RSS: Main: 265560064 05:36:47 INFO - PROCESS | 12776 | 05:36:49 INFO - PROCESS | 12776 | Cycle 1(1): loaded http://localhost:51699/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51699/tests/kraken/driver.html?testName=audio-oscillator) 05:36:50 INFO - PROCESS | 12776 | RSS: Main: 174198784 05:36:50 INFO - PROCESS | 12776 | 05:36:52 INFO - PROCESS | 12776 | Cycle 1(1): loaded http://localhost:51699/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51699/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:36:53 INFO - PROCESS | 12776 | RSS: Main: 178241536 05:36:53 INFO - PROCESS | 12776 | 05:36:56 INFO - PROCESS | 12776 | Cycle 1(1): loaded http://localhost:51699/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51699/tests/kraken/driver.html?testName=imaging-darkroom) 05:36:57 INFO - PROCESS | 12776 | RSS: Main: 214315008 05:36:57 INFO - PROCESS | 12776 | 05:37:00 INFO - PROCESS | 12776 | Cycle 1(1): loaded http://localhost:51699/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51699/tests/kraken/driver.html?testName=imaging-desaturate) 05:37:01 INFO - PROCESS | 12776 | RSS: Main: 215150592 05:37:01 INFO - PROCESS | 12776 | 05:37:03 INFO - PROCESS | 12776 | Cycle 1(1): loaded http://localhost:51699/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51699/tests/kraken/driver.html?testName=json-parse-financial) 05:37:04 INFO - PROCESS | 12776 | RSS: Main: 215904256 05:37:04 INFO - PROCESS | 12776 | 05:37:06 INFO - PROCESS | 12776 | Cycle 1(1): loaded http://localhost:51699/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51699/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:37:06 INFO - PROCESS | 12776 | RSS: Main: 205643776 05:37:06 INFO - PROCESS | 12776 | 05:37:08 INFO - PROCESS | 12776 | Cycle 1(1): loaded http://localhost:51699/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51699/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:37:08 INFO - PROCESS | 12776 | RSS: Main: 205750272 05:37:08 INFO - PROCESS | 12776 | 05:37:11 INFO - PROCESS | 12776 | Cycle 1(1): loaded http://localhost:51699/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51699/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:37:11 INFO - PROCESS | 12776 | RSS: Main: 215855104 05:37:11 INFO - PROCESS | 12776 | 05:37:14 INFO - PROCESS | 12776 | Cycle 1(1): loaded http://localhost:51699/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51699/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:37:14 INFO - PROCESS | 12776 | RSS: Main: 223051776 05:37:14 INFO - PROCESS | 12776 | 05:37:17 INFO - PROCESS | 12776 | Cycle 1(1): loaded http://localhost:51699/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51699/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:37:18 INFO - PROCESS | 12776 | RSS: Main: 221343744 05:37:18 INFO - PROCESS | 12776 | 05:37:20 INFO - PROCESS | 12776 | Cycle 1(1): loaded http://localhost:51699/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51699/tests/kraken/driver.html?testName=ai-astar) 05:37:20 INFO - PROCESS | 12776 | RSS: Main: 284413952 05:37:20 INFO - PROCESS | 12776 | 05:37:20 INFO - PROCESS | 12776 | __start_tp_report 05:37:20 INFO - PROCESS | 12776 | _x_x_mozilla_page_load 05:37:20 INFO - PROCESS | 12776 | _x_x_mozilla_page_load_details 05:37:20 INFO - PROCESS | 12776 | |i|pagename|runs| 05:37:20 INFO - PROCESS | 12776 | |0;ai-astar;111;112;108;113;111;112;100;111;111;110 05:37:20 INFO - PROCESS | 12776 | |1;audio-beat-detection;155;130;157;181;136;159;163;129;199;130 05:37:20 INFO - PROCESS | 12776 | |2;audio-dft;163;163;163;163;164;162;164;163;163;164 05:37:20 INFO - PROCESS | 12776 | |3;audio-fft;74;78;105;127;79;77;78;112;117;78 05:37:20 INFO - PROCESS | 12776 | |4;audio-oscillator;93;93;158;94;93;93;151;93;92;158 05:37:20 INFO - PROCESS | 12776 | |5;imaging-gaussian-blur;116;117;116;117;116;117;116;117;117;117 05:37:20 INFO - PROCESS | 12776 | |6;imaging-darkroom;145;145;144;146;145;145;146;145;145;146 05:37:20 INFO - PROCESS | 12776 | |7;imaging-desaturate;95;94;95;95;97;95;96;95;95;94 05:37:20 INFO - PROCESS | 12776 | |8;json-parse-financial;56;57;55;57;56;56;56;73;54;54 05:37:20 INFO - PROCESS | 12776 | |9;json-stringify-tinderbox;62;63;63;63;69;62;63;63;62;61 05:37:20 INFO - PROCESS | 12776 | |10;stanford-crypto-aes;82;86;80;79;80;81;79;82;81;81 05:37:20 INFO - PROCESS | 12776 | |11;stanford-crypto-ccm;124;121;122;128;120;120;120;123;224;126 05:37:20 INFO - PROCESS | 12776 | |12;stanford-crypto-pbkdf2;180;174;169;176;173;173;175;173;176;168 05:37:20 INFO - PROCESS | 12776 | |13;stanford-crypto-sha256-iterative;70;69;69;69;68;68;67;70;69;69 05:37:20 INFO - PROCESS | 12776 | __end_tp_report 05:37:20 INFO - PROCESS | 12776 | __start_cc_report 05:37:20 INFO - PROCESS | 12776 | _x_x_mozilla_cycle_collect,1627 05:37:20 INFO - PROCESS | 12776 | __end_cc_report 05:37:20 INFO - PROCESS | 12776 | __startTimestamp1462106240379__endTimestamp 05:37:20 INFO - PROCESS | 12776 | 05:37:20 INFO - PROCESS | 12776 | ------- Summary: start ------- 05:37:20 INFO - PROCESS | 12776 | Number of tests: 14 05:37:20 INFO - PROCESS | 12776 | 05:37:20 INFO - PROCESS | 12776 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:3.73 (3.4%) stddev-sans-first:3.93 05:37:20 INFO - PROCESS | 12776 | Values: 111.0 112.0 108.0 113.0 111.0 112.0 100.0 111.0 111.0 110.0 05:37:20 INFO - PROCESS | 12776 | 05:37:20 INFO - PROCESS | 12776 | [#1] audio-beat-detection Cycles:10 Average:153.90 Median:158.00 stddev:23.50 (14.9%) stddev-sans-first:24.92 05:37:20 INFO - PROCESS | 12776 | Values: 155.0 130.0 157.0 181.0 136.0 159.0 163.0 129.0 199.0 130.0 05:37:20 INFO - PROCESS | 12776 | 05:37:20 INFO - PROCESS | 12776 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 05:37:20 INFO - PROCESS | 12776 | Values: 163.0 163.0 163.0 163.0 164.0 162.0 164.0 163.0 163.0 164.0 05:37:20 INFO - PROCESS | 12776 | 05:37:20 INFO - PROCESS | 12776 | [#3] audio-fft Cycles:10 Average:92.50 Median:77.50 stddev:20.34 (26.2%) stddev-sans-first:20.44 05:37:20 INFO - PROCESS | 12776 | Values: 74.0 78.0 105.0 127.0 79.0 77.0 78.0 112.0 117.0 78.0 05:37:20 INFO - PROCESS | 12776 | 05:37:20 INFO - PROCESS | 12776 | [#4] audio-oscillator Cycles:10 Average:111.80 Median:93.00 stddev:30.33 (32.6%) stddev-sans-first:31.40 05:37:20 INFO - PROCESS | 12776 | Values: 93.0 93.0 158.0 94.0 93.0 93.0 151.0 93.0 92.0 158.0 05:37:20 INFO - PROCESS | 12776 | 05:37:20 INFO - PROCESS | 12776 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 05:37:20 INFO - PROCESS | 12776 | Values: 116.0 117.0 116.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 05:37:20 INFO - PROCESS | 12776 | 05:37:20 INFO - PROCESS | 12776 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 05:37:20 INFO - PROCESS | 12776 | Values: 145.0 145.0 144.0 146.0 145.0 145.0 146.0 145.0 145.0 146.0 05:37:20 INFO - PROCESS | 12776 | 05:37:20 INFO - PROCESS | 12776 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.88 (0.9%) stddev-sans-first:0.93 05:37:20 INFO - PROCESS | 12776 | Values: 95.0 94.0 95.0 95.0 97.0 95.0 96.0 95.0 95.0 94.0 05:37:20 INFO - PROCESS | 12776 | 05:37:20 INFO - PROCESS | 12776 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:56.00 stddev:5.58 (10.0%) stddev-sans-first:5.90 05:37:20 INFO - PROCESS | 12776 | Values: 56.0 57.0 55.0 57.0 56.0 56.0 56.0 73.0 54.0 54.0 05:37:20 INFO - PROCESS | 12776 | 05:37:20 INFO - PROCESS | 12776 | [#9] json-stringify-tinderbox Cycles:10 Average:63.10 Median:63.00 stddev:2.18 (3.5%) stddev-sans-first:2.28 05:37:20 INFO - PROCESS | 12776 | Values: 62.0 63.0 63.0 63.0 69.0 62.0 63.0 63.0 62.0 61.0 05:37:20 INFO - PROCESS | 12776 | 05:37:20 INFO - PROCESS | 12776 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:81.00 stddev:2.02 (2.5%) stddev-sans-first:2.12 05:37:20 INFO - PROCESS | 12776 | Values: 82.0 86.0 80.0 79.0 80.0 81.0 79.0 82.0 81.0 81.0 05:37:20 INFO - PROCESS | 12776 | 05:37:20 INFO - PROCESS | 12776 | [#11] stanford-crypto-ccm Cycles:10 Average:132.80 Median:123.50 stddev:32.16 (26.0%) stddev-sans-first:33.95 05:37:20 INFO - PROCESS | 12776 | Values: 124.0 121.0 122.0 128.0 120.0 120.0 120.0 123.0 224.0 126.0 05:37:20 INFO - PROCESS | 12776 | 05:37:20 INFO - PROCESS | 12776 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.70 Median:174.50 stddev:3.47 (2.0%) stddev-sans-first:2.83 05:37:20 INFO - PROCESS | 12776 | Values: 180.0 174.0 169.0 176.0 173.0 173.0 175.0 173.0 176.0 168.0 05:37:20 INFO - PROCESS | 12776 | 05:37:20 INFO - PROCESS | 12776 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:0.92 (1.3%) stddev-sans-first:0.87 05:37:20 INFO - PROCESS | 12776 | Values: 70.0 69.0 69.0 69.0 68.0 68.0 67.0 70.0 69.0 69.0 05:37:20 INFO - PROCESS | 12776 | -------- Summary: end -------- 05:37:20 INFO - PROCESS | 12776 | 05:37:21 INFO - TEST-INFO | 12776: exit 0 05:37:21 INFO - TEST-OK | kraken | took 61379ms 05:37:21 INFO - SUITE-END | took 1173s 05:37:21 INFO - Completed test suite (00:19:33) 05:37:21 INFO - javascript benchmark 05:37:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3076.4001019801135, 3127.9677706356906, 3151.2909595341052, 3166.1609673436556, 3192.8403579821, 5145.09960756867, 5228.47715228478, 5286.788528458857, 5296.205569164627, 5327.92008119878, 5225.425203227642, 5281.841544753654, 5313.256144139824, 5392.811251606195, 5434.0218760623075, 4781.330613714074, 4781.450133234688, 4809.807607695706, 4827.468978412372, 4977.104121258172, 4892.730899800509, 4905.0925578767865, 4910.484399138093, 4967.403911530621, 4967.577755890754, 4701.764911754416, 4725.763711814396, 4773.546513081252, 4818.518148185189, 4902.950970490285, 4821.445533763627, 4836.7823447944575, 4840.322354870321, 4847.0, 4869.318295438641, 4718.9292160617615, 4788.353572267734, 4803.327534145223, 4810.591099756525, 4845.927311090337, 5116.718580478072, 5166.483351664803, 5168.457311982225, 5179.14544100223, 5209.973950130263, 5476.67139971603, 5479.890402191973, 5501.064818980783, 5509.063459211903, 5509.196058477508, 5521.420250873641, 5565.359983601857, 5604.859878503029, 5681.460261275213, 5704.600677952545, 5204.505571970657, 5216.686998780086, 5220.347456567929, 5223.3209682741, 5249.580033597303, 5665.150227465913, 5665.348484924287, 5667.1782591524825, 5670.206171136044, 5702.714864256771, 5364.785408583691, 5423.078076726966, 5428.375736790241, 5451.700156491431, 5483.122700367922, 5559.249501317351, 5559.610827242054, 5568.749406276727, 5575.0522411190195, 5583.748731307101, 5544.750486228129, 5546.750396232179, 5549.0289199389945, 5558.944410555923, 5596.720163991784, 5433.8369848904595, 5589.636673616202, 5600.271964644651, 5642.069058605366, 5655.981923253854, 4236.195122926634, 4259.23333799919, 4262.829486820492, 4265.0830071534765, 4305.009847734976, 3738.3831667775057, 3827.196288779332, 3838.980805095957, 3859.4403811447182, 3888.202918401721, 5152.124138896396, 5249.0, 5313.070212712837, 5348.224507446398, 5353.38436079848, 5634.577406694514, 5697.658140511582, 5699.772009119672, 5701.914471282934, 5709.257796486513, 5148.30497882781, 5300.946990530122, 5324.760385782649, 5340.786368545215, 5400.486953739389, 4756.500567440438, 4798.2082956311815, 4816.662833601685, 4846.297286893451, 4846.539578740014, 5787.5080618147085, 5843.444872737083, 5844.240248767633, 5847.590668653239, 5849.0, 5542.307211598551, 5567.972160139336, 5620.831375058837, 5705.030144875298, 5759.65442073477, 5709.143628455765, 5716.571257155647, 5725.169850371756, 5750.30996280449, 5780.826575202751, 5498.1752737089755, 5499.395066542597, 5499.670019798825, 5509.862253443535, 5518.779248830002, 5357.544608708304, 5510.035743744748, 5572.4148964358155, 5580.469855363896, 5586.050371436947, 5446.482584154499, 5451.182322651634, 5457.69982650958, 5474.698891561003, 5496.7526461308535, 5420.105682562491, 5424.457554244544, 5427.782888684408, 5450.972745136249, 5505.311836020497, 5184.040952423814, 5348.919766203588, 5356.678599284055, 5426.67439953604, 5446.618736688394, 5447.536959358499, 5447.754851031792, 5450.836474905759, 5459.617826752248, 5460.372057213472, 5310.734463276744, 5338.919916201337, 5353.009693206769, 5355.25026496283, 5405.837824865261], "value": 5167.713843973218, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.6272748168653, 627.3632263252799, 641.4002907281695, 641.6406812185176, 654.4894981914106, 31880.521792173105, 37055.25889482209, 37592.06019849505, 37648.81175594125, 37654.24691506168, 40114.7994260029, 40880.79559602205, 40997.79501102498, 40998.38502422466, 41102.0, 7728.6908523658985, 7894.842103157934, 8311.210435008665, 8538.487690738544, 8541.16364981529, 9720.270979676518, 9939.15517181037, 9989.350692204984, 9998.500074996258, 10001.799964000716, 10027.59889604415, 10206.489675516232, 10209.540570674337, 10210.336328138685, 10219.744506387362, 7692.4615276930635, 9752.561134748918, 9874.60501579936, 10077.042680945298, 10081.092701656813, 9992.050755178247, 10141.39151650896, 10155.89844101557, 10157.593696252141, 10174.338667986558, 39016.60983390158, 39723.40414893779, 39817.60182398168, 39839.8008009961, 39866.20267594661, 3420.538227339327, 3497.6502349765074, 3821.7515861468914, 3874.0, 3998.420229066769, 32126.196845078826, 33030.17424564381, 33166.502502462485, 33183.834080829685, 33394.0, 4266.1467706458525, 4328.5455027222315, 4443.688941774077, 4447.0, 4493.168763778679, 310168.0, 313261.0, 314342.0, 315013.0, 315080.0, 62142.0, 62608.686956564925, 62775.68612157001, 62797.686011570564, 62872.0, 65927.0, 65992.34007659862, 66090.66954665196, 66399.0, 66461.33538664551, 16898.493045208663, 17011.48965531036, 17194.1402929853, 17222.0, 17249.827501725074, 13161.53934612303, 13221.338933053308, 13223.537176198786, 13226.074174807864, 13231.603051908458, 18227.340026266553, 20104.98425236226, 20153.697694534592, 20238.291659791837, 20278.290259840836, 5543.0, 6643.701033453506, 6805.455563554904, 6865.176178858569, 6911.75808846688, 999.4053538144792, 1070.6573896353248, 1083.6748975307376, 1126.3748619516248, 1149.954001839917, 28943.71056289452, 29692.0, 29894.701052989625, 30381.24046898801, 30473.085807425814, 1109.5728144664201, 1112.410422476089, 1116.3486719042276, 1129.3788416370962, 1215.750771091924, 16895.155242238085, 17105.572360690832, 17232.569185770204, 17241.0, 17394.21726022332, 310300.0, 311923.0, 312990.0, 317573.0, 462707.0, 54660.72669636626, 55185.44814551803, 55423.44576554264, 55603.0, 55909.72045139748, 1288.22062652096, 1372.9588112356446, 1387.833459984788, 1388.0283801339103, 1404.45226361719, 28732.281692957007, 31392.529112063796, 32050.679493205702, 33443.33113337671, 33501.49747753737, 50134.0, 50452.49547504478, 51045.0, 51055.0, 51088.48911510837, 372189.0, 375073.0, 375272.0, 375408.0, 376851.0, 33320.66679333176, 38500.614993850824, 38857.6114238854, 39129.6087039126, 43431.78284108685, 43760.12479750451, 44301.0, 44376.33435498406, 44593.331100032876, 45526.54473455223, 37604.99160067133, 38269.617303826606, 40966.0, 41650.0, 41872.371914421914, 39402.40896386499, 40489.79755101206, 40929.59070409258, 41177.79411102925, 41316.38025429561, 36919.8154009239, 37619.811900941415, 37717.81141094277, 41091.0, 41158.38262426006, 31268.68731312658, 32917.17707057343, 33750.324993499504, 33817.83091084529, 35266.0, 27062.458750825266, 27469.17592472229, 27550.5867411993, 27595.58606620862, 27902.0], "value": 19935.256856745968, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.76335145506874, 373.9813009349532, 379.27936919852283, 384.5443149867406, 384.55775857763587, 17960.946639071357, 17998.370057048007, 18831.811681883177, 19031.333903313385, 19042.2383104676, 17925.282988680436, 18066.72899906499, 18841.905790471028, 18857.057147142656, 18906.810931890675, 5040.445550989398, 5156.0, 5192.6624769390055, 5210.16637338026, 5210.869728256786, 3754.4743735877, 3978.9602103978877, 5685.658860468365, 5697.914531282034, 5699.401562835905, 5490.56075513958, 5564.5254007688, 5573.554115670757, 5588.86027849303, 5596.944030559683, 3854.402567602026, 5353.411124776271, 5428.5928555358505, 5546.750396232179, 5745.942540574582, 5551.777928882881, 5557.3886872444, 5572.804951826707, 5581.358143813472, 5582.665040097607, 13163.407646655924, 13438.395272212774, 13613.455461781517, 13617.931910340483, 13634.0, 2286.325533967484, 2339.7894189522854, 2366.5148644528003, 2499.4751102268547, 2613.4773045391, 9568.952155239249, 9651.613935442574, 9652.565634546392, 10169.694909152737, 10271.79456410875, 1913.655542002439, 1923.6633589121989, 1930.9806901930942, 1965.6167047425758, 1974.3583335416047, 75908.62045689792, 78196.21803781946, 80741.19258807396, 81205.59397202976, 81973.0, 9442.15020648145, 9442.669506567374, 9486.715398538056, 9552.665656701982, 9618.903810961941, 12806.295653739135, 12834.29411382383, 12836.871631283568, 12866.035047371484, 12866.614001579968, 7603.505772124905, 7685.769426917202, 7701.460897737216, 7748.728794492165, 7841.921580784233, 7693.307602315818, 7694.730684426018, 7759.961200194076, 7922.603869806602, 7923.12845586985, 3922.3332033554366, 3951.5060617422823, 3966.940495892564, 4057.918841623151, 4071.368937814584, 1641.5075477356745, 1680.8823382363362, 1704.1479260369815, 1712.3664244229465, 1732.6534693061437, 957.0716405087054, 966.9323147379756, 1011.6155860773007, 1030.6701855406197, 1048.1038711901215, 17863.26489934208, 18120.728189077174, 18476.907615461838, 18786.624267514573, 18788.342408015655, 950.5864948747317, 991.7669347703284, 1000.5797565022708, 1014.1075853249241, 1042.4475028235047, 9864.161546268504, 10140.340877842917, 10233.846492302622, 10244.53899574521, 10298.845517317246, 488319.0, 491503.0, 492738.0, 498292.0, 499103.0, 84985.15014849896, 86570.56714716511, 88032.0, 88096.0, 88525.55737221273, 1036.7252678040325, 1045.7542477517777, 1047.876605557135, 1055.72551136705, 1063.4576366053368, 15488.380464781283, 15860.76208856845, 15944.681106378039, 16167.838321616633, 16489.34042638281, 35019.47470787889, 35975.460368093976, 36943.0, 37127.25745485129, 38403.0, 49473.94152245096, 54346.0, 54668.45331546793, 59152.40847591469, 59295.110573342296, 8382.455140415854, 8509.851170092206, 8583.785405364666, 8608.956955215184, 8805.031446541003, 9464.479453630116, 12298.077644176901, 12902.096853220184, 12952.41714122848, 13093.279869606882, 10875.945620271848, 11049.613263535737, 11334.149938754792, 11708.0, 11712.180147389941, 11254.212205145888, 11348.546058157912, 11444.599439019594, 11451.885481145415, 11548.307101573933, 6433.613983161025, 8501.404901656824, 11343.943280283545, 11493.48279327449, 11696.976057330652, 8491.83016339682, 8565.143485651384, 8603.225709686158, 8619.0, 8665.653373864974, 11365.374904380338, 11465.770684586429, 11512.19414640967, 11570.363630000431, 11570.826437603275], "value": 8623.734022950799, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1310.9934450327746, 1462.4588902106218, 1480.9851901480986, 1598.7362085255934, 1748.9999999999993, 7603.087629484463, 7915.722949696762, 7950.1652326505755, 7971.840563188747, 7976.840463190732, 7677.270659287359, 7928.326092282163, 7933.484323518967, 7936.325412339958, 7940.801479962989, 1904.7238150468174, 2070.171931227506, 2135.5728854229137, 2160.0819651648067, 2193.4406726284774, 2177.140029688272, 2193.331034034619, 2198.9560208795815, 2200.702905107814, 2203.4160947348964, 2077.0549400022956, 2138.967915481261, 2139.732533433321, 2141.122139922632, 2144.613969485492, 1836.366453573515, 2079.272254710854, 2142.2502124256384, 2145.9785402145935, 2146.0450099705636, 2061.0313152818153, 2082.989585052065, 2083.1875568528285, 2084.4476213803205, 2127.8829664368454, 7559.470837041409, 7640.808979775495, 7647.579383133925, 7661.463697541174, 7807.0, 4591.471980722193, 4778.665493415462, 4813.494583068762, 4815.446223684251, 4820.39745031871, 2914.0, 2929.8828046878098, 2937.867795949166, 2945.410917816424, 2983.34366439383, 978.3005151316771, 982.9705108846746, 999.8400255959011, 1002.6039714312878, 1005.3515482513737, 10567.207459440573, 10572.259941804077, 10588.311759735592, 10588.735281617945, 10602.151827853753, 4030.7380020298588, 4064.227796718614, 4119.526254480713, 4222.683298752606, 4254.085371645111, 9054.275657947348, 9067.546622668971, 9069.093090690878, 9079.863802042975, 9087.409318394282, 4307.633851122627, 4753.524647535288, 4783.976080119577, 4819.927701084486, 4826.083044221657, 4013.3779264214095, 4014.7791871447353, 4041.818118184689, 4300.677449191323, 4382.780860956939, 3469.6877281044826, 3483.808390538494, 3514.894553163409, 3523.5419395478425, 3581.6239294874185, 1103.4923934989833, 1132.9773404531863, 1140.674907651332, 1144.13046084976, 1146.1060372909144, 907.3557773980416, 919.0212423768666, 928.1878356438117, 939.8637197606308, 943.6697155995485, 5456.181572764117, 5459.235707001023, 5470.945290547043, 5487.6158668893595, 5610.13042978339, 913.3515204204956, 924.8381533231658, 935.4106912644991, 953.6948176583427, 955.9904400956041, 3951.427043078795, 4060.289449346412, 4077.6533994610195, 4081.3265811141423, 4133.04939863827, 9495.525223738923, 9669.613215471443, 9677.467739274407, 9807.75480612976, 9830.262730295113, 9501.714948551555, 9586.328956973084, 9691.951540242253, 9702.951485242529, 9713.174380177623, 7140.178879428932, 7245.094363204599, 7254.818629534198, 7295.635218239173, 7298.051253337138, 5258.8948221036135, 5354.170103633943, 5543.916841247304, 5556.277683901067, 5609.663420194802, 8772.429792063496, 8798.868016979623, 8948.0, 9016.143466370684, 9039.95480022622, 9182.081791820765, 9196.724098277062, 9283.814323713623, 9397.201237894582, 9410.576524056298, 6614.768483103068, 6876.828079298058, 6877.89683154763, 7152.392046675883, 7295.088113985752, 7307.744228951961, 7561.546307221584, 7731.690732370642, 7765.339946104645, 7773.611319434119, 6926.8614627708175, 7041.084658994503, 7078.292170782881, 7117.964410177916, 7222.674979625825, 6943.305669433016, 6962.164540254999, 7057.36483716468, 7102.893456598258, 7287.125544934642, 6620.404163625297, 6638.0, 6683.532152749261, 6688.130543029375, 6691.1636045494315, 4799.160146974195, 4822.855314340575, 4943.826966056171, 4997.3253610762085, 5085.338905942203, 5006.924896126488, 5033.874153146201, 5036.546710796046, 5076.670016448919, 5095.643304968617], "value": 4227.518343413337, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.55304913973026, 313.107643216832, 314.317930091701, 317.9014505503293, 317.9062176657886, 5168.847003327972, 5197.974010129944, 5230.346206724154, 5247.737613119339, 5252.553532949699, 5119.360079990001, 5156.278121063054, 5163.793448262065, 5203.4796520347945, 5209.817656382027, 3875.5543112542136, 3887.328448767029, 3998.7200895937294, 4022.296098182821, 4050.534188568323, 3952.901177470572, 4016.15660711251, 4018.176273863851, 4018.45750823638, 4035.3745169498775, 3840.8079596020225, 3980.383040628707, 3988.960110398888, 3995.1011022519847, 4007.338789099795, 3898.5321761388673, 4031.4355990161107, 4046.5751096134777, 4048.5951404859575, 4062.2281766464275, 3527.5943266524164, 3545.556805399325, 3550.6981906537717, 3555.839987200556, 3556.3598552260582, 5006.098902197603, 5008.449070602231, 5016.498350164954, 5024.723640199788, 5032.043911656773, 4527.818887244506, 4602.355670206174, 4611.423572053493, 4614.238650622643, 4616.469106052813, 5376.247325374451, 5389.248494239388, 5411.512963833235, 5442.510174084312, 5457.426970168115, 3904.4533765272886, 3917.9608203917883, 3931.862384816546, 3936.6063393660406, 3947.4473573699706, 5413.485718856702, 5624.91562626561, 5647.09646456569, 5658.85852853682, 5680.886382272372, 3975.2447035063246, 3975.900602484961, 3978.1645854370327, 4014.297497937908, 4017.658499027557, 4025.2352053109817, 4036.9394459083137, 4041.3533834586324, 4048.554658987509, 4059.6955228357992, 4495.505494395614, 4562.543745625478, 4588.403507543998, 4591.1965406053805, 4642.53574642533, 5366.436524164985, 5443.346798384219, 5467.890642187134, 5481.588880833953, 5529.723513824292, 1480.8963372564033, 1489.0321291160833, 1489.1809504772332, 1493.2309860421892, 1494.1184701026446, 948.6442584030989, 991.5637119667323, 1006.7281833904951, 1015.6292953072076, 1022.1771473963382, 5531.834044978657, 5553.139263414178, 5592.5246354059545, 5596.524295434852, 5620.297462817148, 5859.882802343929, 5888.528917686661, 5929.466348028612, 5971.19388882504, 5982.850428739229, 5410.864728381822, 5516.475934786189, 5591.916121258185, 5613.887722245614, 5617.831465055973, 3166.62503122658, 3178.3166619176527, 3184.188032051812, 3188.3623275345026, 3188.963586834288, 5955.642661440327, 6122.234720659918, 6126.571140020245, 6136.7852125175405, 6138.07928810682, 5969.820905372759, 5983.401659834069, 6017.428344307284, 6041.395860413923, 6051.636901785819, 6038.547108966845, 6088.4824789893355, 6092.695365231721, 6107.511399088063, 6117.663528505975, 5824.883502330014, 5948.583599148191, 5978.581499295182, 5982.371850955587, 5989.1914591529585, 5820.563457740771, 5834.445727655866, 5839.474447299764, 5846.678432686073, 5861.794837180678, 5926.496247818984, 6042.758289668364, 6058.12157237207, 6072.362401947732, 6086.0, 4181.1428657125825, 4228.661707063366, 4244.151169765997, 4244.702870799138, 4255.936160957526, 5907.143464197753, 5922.407759224043, 5927.644341339534, 5936.961031819501, 5974.074018527135, 5555.916661250004, 5732.71336433185, 5767.134929760569, 5773.53811695055, 5820.912686309794, 5728.997425450446, 5746.626469279484, 5749.54003679713, 5778.353169346716, 5784.4504772046585, 5091.439941606346, 5123.487651234846, 5261.237120617566, 5695.259616249861, 5714.742836572281, 5529.861753456195, 5537.6954267515675, 5538.363088244903, 5592.7203639817035, 5600.523955463831, 5395.514403703685, 5466.72666366688, 5491.478309560585, 5509.146082357241, 5524.0], "value": 4262.800406065266, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [778.3267473635306, 838.6477679374664, 843.1484200957032, 843.991560084399, 852.8507511185541, 13193.34033298336, 13432.126911750755, 13447.1259368141, 13460.798088028687, 13475.460981560725, 12945.676358091052, 13175.93412032941, 13251.072424930235, 13263.668408289797, 13549.729005419886, 802.2939812964597, 812.8902598149263, 813.1218284253022, 813.9470934389275, 814.42989907065, 794.0233512779284, 796.928276455119, 805.0741647105816, 805.0781854776278, 805.842860642175, 839.290799274612, 849.0660273698943, 850.1116333431579, 850.9574521273943, 852.1265702654797, 839.2111415269658, 843.1863251961855, 847.5889193741092, 848.3171047306915, 848.5969164646805, 607.1257389359308, 611.0467670434092, 616.9598976066542, 617.3332800575367, 617.5646169450526, 12753.681157971125, 12780.872191278155, 12793.744125117446, 12810.0, 12823.230606163566, 11575.36335501547, 11635.476403561775, 11681.2407193533, 11692.181547291693, 11786.292822430596, 10378.792424151474, 10462.843057354146, 10481.58073677052, 10645.041946224877, 10722.571097156104, 3705.6850167735774, 3745.6628903398823, 3759.9436008459893, 3770.8868733938025, 3806.543214814212, 40105.0, 52441.0, 53828.461715382735, 54135.0, 54294.72852635751, 11328.320300781814, 11421.143414243965, 11511.251768635011, 11605.76788464226, 11855.17013809025, 20289.086991085438, 20319.085641146183, 20336.491587710425, 20361.592768144554, 20366.592668146553, 8173.754787356389, 8255.0, 8268.421210515327, 8350.540720260444, 8507.078507078459, 4586.862394128115, 4590.42619672541, 4633.0, 4693.577578017995, 4821.493743156988, 3181.0774875285906, 3342.615599206074, 3391.236971681352, 3405.1827561385585, 3405.250844814137, 620.0606081786098, 637.9681015949184, 642.2710223895818, 652.9510286728514, 656.0061506817176, 680.1803826389189, 700.8563244534859, 710.9111361079865, 719.5682590445796, 723.0, 8907.376483646083, 9252.444853308823, 9342.392744471588, 9387.90612093884, 9441.0, 686.1594546680376, 689.7310049080862, 694.264080075122, 700.4536461559991, 705.6330708031795, 4073.089437346235, 4291.184674911757, 4319.265724826787, 4320.222359975234, 4389.4732632083715, 49661.50338496641, 51174.744126279875, 51241.48758512367, 51372.48627513752, 51403.0, 41570.0, 48532.7573362138, 49908.50091499111, 54042.0, 56629.71685141548, 45863.0, 48527.75736121368, 48607.75696121497, 49077.50922490729, 49590.0, 9379.827521559804, 9606.27952903521, 9612.327137100336, 9681.225501959967, 9775.21798256152, 31784.36431271408, 33067.83466082654, 33100.33799323952, 33435.49846752252, 33777.32445351128, 42273.577264226966, 44105.11789764251, 44918.0, 45634.0, 45740.771296143306, 11598.246114002563, 12128.332941688292, 12198.085143614087, 12271.75456490883, 12538.937305313415, 13302.667433314244, 13723.862761372258, 14201.715965680834, 14238.928805355907, 14575.979208467901, 13021.283829389475, 13496.797548036984, 13559.728805424034, 13780.517681881087, 13953.511627093003, 12940.870591294342, 13065.673358166121, 13211.405486752927, 13286.402111905181, 13371.598852034454, 12521.37393130358, 12818.487260509475, 12862.485500579873, 12894.226346419246, 12993.870061299265, 10570.894291057299, 10580.41807700584, 10813.67558973232, 10899.237053406503, 11061.281016733887, 11270.83093753578, 11337.659870203906, 11432.256903301259, 11511.827322590001, 11583.710407239887], "value": 6646.372636683874, "unit": "score"}], "name": "dromaeo_css", "value": 6883.955777787762, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 108.0, 113.0, 111.0, 112.0, 100.0, 111.0, 111.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 130.0, 157.0, 181.0, 136.0, 159.0, 163.0, 129.0, 199.0, 130.0], "value": 153.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 163.0, 164.0, 162.0, 164.0, 163.0, 163.0, 164.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 78.0, 105.0, 127.0, 79.0, 77.0, 78.0, 112.0, 117.0, 78.0], "value": 92.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 158.0, 94.0, 93.0, 93.0, 151.0, 93.0, 92.0, 158.0], "value": 111.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 144.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 97.0, 95.0, 96.0, 95.0, 95.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 55.0, 57.0, 56.0, 56.0, 56.0, 73.0, 54.0, 54.0], "value": 57.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 63.0, 69.0, 62.0, 63.0, 63.0, 62.0, 61.0], "value": 63.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 86.0, 80.0, 79.0, 80.0, 81.0, 79.0, 82.0, 81.0, 81.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 121.0, 122.0, 128.0, 120.0, 120.0, 120.0, 123.0, 224.0, 126.0], "value": 132.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 174.0, 169.0, 176.0, 173.0, 173.0, 175.0, 173.0, 176.0, 168.0], "value": 173.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 69.0, 69.0, 68.0, 68.0, 67.0, 70.0, 69.0, 69.0], "value": 68.8, "unit": "score"}], "name": "kraken", "value": 1565.0999999999997, "alertThreshold": 2.0}]} 05:37:21 INFO - Return code: 0 05:37:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:37:21 ERROR - # TBPL SUCCESS # 05:37:21 INFO - Running post-action listener: _resource_record_post_action 05:37:21 INFO - Running post-run listener: _resource_record_post_run 05:37:22 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 8192; Write bytes: 539140096; Read time: 204; Write time: 466120 05:37:22 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 251084800; Read time: 188; Write time: 245620 05:37:22 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288055296; Read time: 16; Write time: 220500 05:37:22 INFO - Running post-run listener: _upload_blobber_files 05:37:22 INFO - Blob upload gear active. 05:37:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:37:22 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 05:37:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:37:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:37:23 INFO - (blobuploader) - INFO - Open directory for files ... 05:37:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:37:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:37:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:23 INFO - (blobuploader) - INFO - Done attempting. 05:37:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:37:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:37:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:24 INFO - (blobuploader) - INFO - Done attempting. 05:37:24 INFO - (blobuploader) - INFO - Iteration through files over. 05:37:24 INFO - Return code: 0 05:37:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:37:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:37:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d26ee4af33e62884e6def681adebaffa2dbc8aa1decb4a1332e9025e1352b4c08102de70b8362f2317667ab657a02423bfe616a6c6e4d6f72dbb6d86e28f56e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d191459b7c6f7fa952a53ef24677529838a3dce581a2d614f2626870d580919750e0a80823aa0ec5eeb9604d1996bef2d1c850d5e0e84fdbf0e28fff88d397c8"} 05:37:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:37:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:37:24 INFO - Contents: 05:37:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d26ee4af33e62884e6def681adebaffa2dbc8aa1decb4a1332e9025e1352b4c08102de70b8362f2317667ab657a02423bfe616a6c6e4d6f72dbb6d86e28f56e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d191459b7c6f7fa952a53ef24677529838a3dce581a2d614f2626870d580919750e0a80823aa0ec5eeb9604d1996bef2d1c850d5e0e84fdbf0e28fff88d397c8"} 05:37:24 INFO - Running post-run listener: copy_logs_to_upload_dir 05:37:24 INFO - Copying logs to upload dir... 05:37:24 INFO - mkdir: /builds/slave/test/build/upload/logs 05:37:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1310.905463 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 50 secs) (at 2016-05-01 05:37:24.636622) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-01 05:37:24.640462) ========= 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=41bf3e9aed84707956354da8000001c5-1462101504.771903-199676796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d26ee4af33e62884e6def681adebaffa2dbc8aa1decb4a1332e9025e1352b4c08102de70b8362f2317667ab657a02423bfe616a6c6e4d6f72dbb6d86e28f56e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d191459b7c6f7fa952a53ef24677529838a3dce581a2d614f2626870d580919750e0a80823aa0ec5eeb9604d1996bef2d1c850d5e0e84fdbf0e28fff88d397c8"} build_url:https://queue.taskcluster.net/v1/task/Rk4QgiZKSWqAheVMULiuwg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011360 build_url: 'https://queue.taskcluster.net/v1/task/Rk4QgiZKSWqAheVMULiuwg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d26ee4af33e62884e6def681adebaffa2dbc8aa1decb4a1332e9025e1352b4c08102de70b8362f2317667ab657a02423bfe616a6c6e4d6f72dbb6d86e28f56e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d191459b7c6f7fa952a53ef24677529838a3dce581a2d614f2626870d580919750e0a80823aa0ec5eeb9604d1996bef2d1c850d5e0e84fdbf0e28fff88d397c8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-01 05:37:24.665807) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 05:37:24.666205) ========= 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=41bf3e9aed84707956354da8000001c5-1462101504.771903-199676796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004442 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 05:37:24.749010) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-01 05:37:24.749340) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-01 05:37:24.749642) ========= ========= Total master_lag: 0.20 =========