builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-004 starttime: 1471986918.68 results: success (0) buildid: 20160823121617 builduid: 224537630c104762a06d8ac80ff02f26 revision: a72bfbdf5c9b36e68ca806a25944180f2652f0c9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 14:15:18.680743) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 14:15:18.681211) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 14:15:18.681486) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 14:15:18.696256) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 14:15:18.696599) ========= 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=c6927cf182745ad25b1d38b9000001fe-1471986918.139483-489443446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-23 14:15:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 82.5M=0s 2016-08-23 14:15:19 (82.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.069295 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 14:15:18.779626) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 14:15:18.779938) ========= 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=c6927cf182745ad25b1d38b9000001fe-1471986918.139483-489443446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014836 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 14:15:18.829901) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-23 14:15:18.830308) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a72bfbdf5c9b36e68ca806a25944180f2652f0c9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a72bfbdf5c9b36e68ca806a25944180f2652f0c9 --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=c6927cf182745ad25b1d38b9000001fe-1471986918.139483-489443446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-23 14:15:19,184 truncating revision to first 12 chars 2016-08-23 14:15:19,184 Setting DEBUG logging. 2016-08-23 14:15:19,184 attempt 1/10 2016-08-23 14:15:19,184 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a72bfbdf5c9b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-23 14:15:20,305 unpacking tar archive at: mozilla-aurora-a72bfbdf5c9b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.442096 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-23 14:15:20.286484) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 14:15:20.286853) ========= script_repo_revision: a72bfbdf5c9b36e68ca806a25944180f2652f0c9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 14:15:20.287368) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 14:15:20.287641) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 14:15:20.299175) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 56 secs) (at 2016-08-23 14:15:20.299570) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=c6927cf182745ad25b1d38b9000001fe-1471986918.139483-489443446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:15:20 INFO - MultiFileLogger online at 20160823 14:15:20 in /builds/slave/test 14:15:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 14:15:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:15:20 INFO - {'append_to_log': False, 14:15:20 INFO - 'base_work_dir': '/builds/slave/test', 14:15:20 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:15:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:15:20 INFO - 'branch': 'Mozilla-Aurora', 14:15:20 INFO - 'buildbot_json_path': 'buildprops.json', 14:15:20 INFO - 'config_files': ('talos/linux_config.py',), 14:15:20 INFO - 'default_actions': ('clobber', 14:15:20 INFO - 'read-buildbot-config', 14:15:20 INFO - 'download-and-extract', 14:15:20 INFO - 'populate-webroot', 14:15:20 INFO - 'create-virtualenv', 14:15:20 INFO - 'install', 14:15:20 INFO - 'run-tests'), 14:15:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:15:20 INFO - 'download_minidump_stackwalk': True, 14:15:20 INFO - 'download_symbols': 'ondemand', 14:15:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:15:20 INFO - 'tooltool.py': '/tools/tooltool.py', 14:15:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:15:20 INFO - '/tools/misc-python/virtualenv.py')}, 14:15:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:15:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:15:20 INFO - 'installer_path': 'installer.exe', 14:15:20 INFO - 'log_level': 'info', 14:15:20 INFO - 'log_name': 'talos', 14:15:20 INFO - 'log_to_console': True, 14:15:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:15:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:15:20 INFO - 'opt_config_files': (), 14:15:20 INFO - 'pip_index': False, 14:15:20 INFO - 'sps_profile': False, 14:15:20 INFO - 'sps_profile_interval': 0, 14:15:20 INFO - 'suite': 'dromaeojs-e10s', 14:15:20 INFO - 'system_bits': '32', 14:15:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:15:20 INFO - 'title': 'talos-linux64-ix-004', 14:15:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:15:20 INFO - 'use_talos_json': True, 14:15:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:15:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:15:20 INFO - 'work_dir': 'build'} 14:15:20 INFO - [mozharness: 2016-08-23 21:15:20.746376Z] Running clobber step. 14:15:20 INFO - Running pre-action listener: _resource_record_pre_action 14:15:20 INFO - Running main action method: clobber 14:15:20 INFO - rmtree: /builds/slave/test/build 14:15:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:15:21 INFO - Running post-action listener: _resource_record_post_action 14:15:21 INFO - [mozharness: 2016-08-23 21:15:21.721254Z] Finished clobber step (success) 14:15:21 INFO - [mozharness: 2016-08-23 21:15:21.721364Z] Running read-buildbot-config step. 14:15:21 INFO - Running pre-action listener: _resource_record_pre_action 14:15:21 INFO - Running main action method: read_buildbot_config 14:15:21 INFO - Using buildbot properties: 14:15:21 INFO - { 14:15:21 INFO - "project": "", 14:15:21 INFO - "product": "firefox", 14:15:21 INFO - "script_repo_revision": "production", 14:15:21 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 14:15:21 INFO - "repository": "", 14:15:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 14:15:21 INFO - "buildid": "20160823121617", 14:15:21 INFO - "pgo_build": "True", 14:15:21 INFO - "basedir": "/builds/slave/test", 14:15:21 INFO - "buildnumber": 503, 14:15:21 INFO - "slavename": "talos-linux64-ix-004", 14:15:21 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:15:21 INFO - "platform": "ubuntu64_hw", 14:15:21 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 14:15:21 INFO - "branch": "mozilla-aurora", 14:15:21 INFO - "repo_path": "releases/mozilla-aurora", 14:15:21 INFO - "revision": "a72bfbdf5c9b36e68ca806a25944180f2652f0c9", 14:15:21 INFO - "stage_platform": "linux64-pgo", 14:15:21 INFO - "builduid": "224537630c104762a06d8ac80ff02f26", 14:15:21 INFO - "slavebuilddir": "test" 14:15:21 INFO - } 14:15:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 14:15:21 INFO - Running post-action listener: _resource_record_post_action 14:15:21 INFO - [mozharness: 2016-08-23 21:15:21.723799Z] Finished read-buildbot-config step (success) 14:15:21 INFO - [mozharness: 2016-08-23 21:15:21.723886Z] Running download-and-extract step. 14:15:21 INFO - Running pre-action listener: _resource_record_pre_action 14:15:21 INFO - Running main action method: download_and_extract 14:15:21 INFO - mkdir: /builds/slave/test/build/tests 14:15:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:21 INFO - https://queue.taskcluster.net/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:15:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 14:15:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 14:15:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 14:15:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:15:21 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 14:15:21 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 14:15:21 INFO - retry: Failed, sleeping 30 seconds before retrying 14:15:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #2 14:15:51 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 14:15:51 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 14:15:51 INFO - retry: Failed, sleeping 60 seconds before retrying 14:16:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #3 14:16:51 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 14:16:51 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 14:16:51 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json! 14:16:51 INFO - Caught exception: HTTP Error 404: Not Found 14:16:51 INFO - Caught exception: HTTP Error 404: Not Found 14:16:51 INFO - Caught exception: HTTP Error 404: Not Found 14:16:51 INFO - trying https://queue.taskcluster.net/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 14:16:51 INFO - Downloading https://queue.taskcluster.net/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 14:16:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:16:52 INFO - Downloaded 1361 bytes. 14:16:52 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 14:16:52 INFO - Using the following test package requirements: 14:16:52 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 14:16:52 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 14:16:52 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 14:16:52 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 14:16:52 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 14:16:52 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 14:16:52 INFO - u'jsshell-linux-x86_64.zip'], 14:16:52 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 14:16:52 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 14:16:52 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 14:16:52 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 14:16:52 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 14:16:52 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 14:16:52 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 14:16:52 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 14:16:52 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 14:16:52 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 14:16:52 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 14:16:52 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:52 INFO - https://queue.taskcluster.net/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:16:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:16:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:16:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:16:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:16:52 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:16:52 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 14:16:52 INFO - retry: Failed, sleeping 30 seconds before retrying 14:17:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 14:17:22 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:17:22 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 14:17:22 INFO - retry: Failed, sleeping 60 seconds before retrying 14:18:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 14:18:22 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:18:22 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 14:18:22 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 14:18:22 INFO - Caught exception: HTTP Error 404: Not Found 14:18:22 INFO - Caught exception: HTTP Error 404: Not Found 14:18:22 INFO - Caught exception: HTTP Error 404: Not Found 14:18:22 INFO - trying https://queue.taskcluster.net/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:18:22 INFO - Downloading https://queue.taskcluster.net/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:18:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:18:23 INFO - Downloaded 21767590 bytes. 14:18:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:18:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:18:24 INFO - Return code: 0 14:18:24 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:18: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')]} 14:18:24 INFO - https://queue.taskcluster.net/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:18:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:18:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:18:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:18:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:18:24 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:18:24 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 14:18:24 INFO - retry: Failed, sleeping 30 seconds before retrying 14:18:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 14:18:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:18:54 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 14:18:54 INFO - retry: Failed, sleeping 60 seconds before retrying 14:19:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 14:19:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:19:54 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 14:19:54 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 14:19:54 INFO - Caught exception: HTTP Error 404: Not Found 14:19:54 INFO - Caught exception: HTTP Error 404: Not Found 14:19:54 INFO - Caught exception: HTTP Error 404: Not Found 14:19:54 INFO - trying https://queue.taskcluster.net/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:19:54 INFO - Downloading https://queue.taskcluster.net/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:19:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:19:55 INFO - Downloaded 21767590 bytes. 14:19:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:19:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:19:56 INFO - Return code: 0 14:19:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:56 INFO - https://queue.taskcluster.net/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:19:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 14:19:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 14:19:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 14:19:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:19:56 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 14:19:56 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 14:19:56 INFO - retry: Failed, sleeping 30 seconds before retrying 14:20:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 14:20:26 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 14:20:26 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 14:20:26 INFO - retry: Failed, sleeping 60 seconds before retrying 14:21:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 14:21:26 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 14:21:26 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 14:21:26 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip! 14:21:26 INFO - Caught exception: HTTP Error 404: Not Found 14:21:26 INFO - Caught exception: HTTP Error 404: Not Found 14:21:26 INFO - Caught exception: HTTP Error 404: Not Found 14:21:26 INFO - trying https://queue.taskcluster.net/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 14:21:26 INFO - Downloading https://queue.taskcluster.net/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 14:21:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:21:27 INFO - Downloaded 14413723 bytes. 14:21:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:21:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:21:27 INFO - Return code: 0 14:21: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')]} 14:21:27 INFO - https://queue.taskcluster.net/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:21:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 14:21:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 14:21:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 14:21:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:21:27 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 14:21:27 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 14:21:27 INFO - retry: Failed, sleeping 30 seconds before retrying 14:21:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #2 14:21:58 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 14:21:58 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 14:21:58 INFO - retry: Failed, sleeping 60 seconds before retrying 14:22:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #3 14:22:58 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 14:22:58 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 14:22:58 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2! 14:22:58 INFO - Caught exception: HTTP Error 404: Not Found 14:22:58 INFO - Caught exception: HTTP Error 404: Not Found 14:22:58 INFO - Caught exception: HTTP Error 404: Not Found 14:22:58 INFO - trying https://queue.taskcluster.net/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 14:22:58 INFO - Downloading https://queue.taskcluster.net/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 14:22:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:22:59 INFO - Downloaded 63744205 bytes. 14:22:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 14:22:59 INFO - mkdir: /builds/slave/test/properties 14:22:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:22:59 INFO - Writing to file /builds/slave/test/properties/build_url 14:22:59 INFO - Contents: 14:22:59 INFO - build_url:https://queue.taskcluster.net/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 14:22:59 INFO - Running post-action listener: _resource_record_post_action 14:22:59 INFO - Running post-action listener: set_extra_try_arguments 14:22:59 INFO - [mozharness: 2016-08-23 21:22:59.920329Z] Finished download-and-extract step (success) 14:22:59 INFO - [mozharness: 2016-08-23 21:22:59.920560Z] Running populate-webroot step. 14:22:59 INFO - Running pre-action listener: _resource_record_pre_action 14:22:59 INFO - Running main action method: populate_webroot 14:22:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:22:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:22:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:22:59 INFO - '--tppagecycles', 14:22:59 INFO - '7'], 14:22:59 INFO - 'tests': ['tsvgm']}}, 14:22:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:22:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:22:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:22:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:22:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:22:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:22:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:22:59 INFO - 'talos_options': ['--disable-e10s'], 14:22:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:22:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:22:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:22:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:22:59 INFO - 'talos_options': ['--disable-e10s'], 14:22:59 INFO - 'tests': ['damp', 'tps']}, 14:22:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:22:59 INFO - 'tests': ['damp', 'tps']}, 14:22:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:22:59 INFO - 'tests': ['dromaeo_dom']}, 14:22:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:22:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:22:59 INFO - 'tests': ['basic_compositor_video']}, 14:22:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:22:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:22:59 INFO - 'tests': ['a11yr', 14:22:59 INFO - 'ts_paint', 14:22:59 INFO - 'tpaint', 14:22:59 INFO - 'sessionrestore', 14:22:59 INFO - 'sessionrestore_no_auto_restore', 14:22:59 INFO - 'tabpaint']}, 14:22:59 INFO - 'other-e10s': {'tests': ['a11yr', 14:22:59 INFO - 'ts_paint', 14:22:59 INFO - 'tpaint', 14:22:59 INFO - 'sessionrestore', 14:22:59 INFO - 'sessionrestore_no_auto_restore', 14:22:59 INFO - 'tabpaint']}, 14:22:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:22:59 INFO - 'ts_paint', 14:22:59 INFO - 'tpaint', 14:22:59 INFO - 'sessionrestore', 14:22:59 INFO - 'sessionrestore_no_auto_restore', 14:22:59 INFO - 'tabpaint']}, 14:22:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:22:59 INFO - 'ts_paint', 14:22:59 INFO - 'tpaint', 14:22:59 INFO - 'sessionrestore', 14:22:59 INFO - 'sessionrestore_no_auto_restore', 14:22:59 INFO - 'tabpaint']}, 14:22:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:22:59 INFO - 'tests': ['a11yr', 14:22:59 INFO - 'ts_paint', 14:22:59 INFO - 'tpaint', 14:22:59 INFO - 'sessionrestore', 14:22:59 INFO - 'sessionrestore_no_auto_restore', 14:22:59 INFO - 'tabpaint']}, 14:22:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:22:59 INFO - 'tests': ['a11yr', 14:22:59 INFO - 'ts_paint', 14:22:59 INFO - 'tpaint', 14:22:59 INFO - 'sessionrestore', 14:22:59 INFO - 'sessionrestore_no_auto_restore', 14:22:59 INFO - 'tabpaint']}, 14:22:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:22:59 INFO - 'tests': ['tsvgx', 14:22:59 INFO - 'tsvgr_opacity', 14:22:59 INFO - 'tart', 14:22:59 INFO - 'tscrollx', 14:22:59 INFO - 'cart']}, 14:22:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:22:59 INFO - 'tsvgr_opacity', 14:22:59 INFO - 'tart', 14:22:59 INFO - 'tscrollx', 14:22:59 INFO - 'cart']}, 14:22:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:22:59 INFO - 'talos_options': ['--disable-e10s'], 14:22:59 INFO - 'tests': ['tp5o']}, 14:22:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:22:59 INFO - 'tests': ['tp5o']}, 14:22:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:22:59 INFO - 'talos_options': ['--disable-e10s', 14:22:59 INFO - '--xperf_path', 14:22:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:22:59 INFO - 'tests': ['tp5n']}, 14:22:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:22:59 INFO - 'talos_options': ['--xperf_path', 14:22:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:22:59 INFO - 'tests': ['tp5n']}}, 14:22:59 INFO - 'talos.zip': {'path': '', 14:22:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:22:59 INFO - Running post-action listener: _resource_record_post_action 14:22:59 INFO - [mozharness: 2016-08-23 21:22:59.936909Z] Finished populate-webroot step (success) 14:22:59 INFO - [mozharness: 2016-08-23 21:22:59.936998Z] Running create-virtualenv step. 14:22:59 INFO - Running pre-action listener: _resource_record_pre_action 14:22:59 INFO - Running main action method: create_virtualenv 14:22:59 INFO - Creating virtualenv /builds/slave/test/build/venv 14:22:59 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:22:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:23:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:23:00 INFO - Using real prefix '/usr' 14:23:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:23:00 INFO - Installing distribute.............................................................................................................................................................................................done. 14:23:02 INFO - Installing pip.................done. 14:23:02 INFO - Return code: 0 14:23:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:02 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 0x1eaa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2168570>, '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 0x2169470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2169900>, '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': 'c6927cf182745ad25b1d38b9000001fe-1471986918.139483-489443446', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:23:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:23:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:23:02 INFO - Using env: {'DISPLAY': ':0', 14:23:02 INFO - 'HOME': '/home/cltbld', 14:23:02 INFO - 'LANG': 'en_US.UTF-8', 14:23:02 INFO - 'LANGUAGE': 'en_US:en', 14:23:02 INFO - 'LOGNAME': 'cltbld', 14:23:02 INFO - 'MAIL': '/var/mail/cltbld', 14:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:02 INFO - 'MOZ_NO_REMOTE': '1', 14:23:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:02 INFO - 'NO_EM_RESTART': '1', 14:23:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:02 INFO - 'PWD': '/builds/slave/test', 14:23:02 INFO - 'SHELL': '/bin/bash', 14:23:02 INFO - 'SHLVL': '1', 14:23:02 INFO - 'TERM': 'linux', 14:23:02 INFO - 'TMOUT': '86400', 14:23:02 INFO - 'USER': 'cltbld', 14:23:02 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1471986918.139483-489443446', 14:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:02 INFO - '_': '/tools/buildbot/bin/python'} 14:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:23:02 INFO - Cleaning up... 14:23:02 INFO - Return code: 0 14:23:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:02 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eaa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2168570>, '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 0x2169470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2169900>, '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': 'c6927cf182745ad25b1d38b9000001fe-1471986918.139483-489443446', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:23:02 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>=3.1.1'] in /builds/slave/test/build 14:23:02 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>=3.1.1 14:23:02 INFO - Using env: {'DISPLAY': ':0', 14:23:02 INFO - 'HOME': '/home/cltbld', 14:23:02 INFO - 'LANG': 'en_US.UTF-8', 14:23:02 INFO - 'LANGUAGE': 'en_US:en', 14:23:02 INFO - 'LOGNAME': 'cltbld', 14:23:02 INFO - 'MAIL': '/var/mail/cltbld', 14:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:02 INFO - 'MOZ_NO_REMOTE': '1', 14:23:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:02 INFO - 'NO_EM_RESTART': '1', 14:23:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:02 INFO - 'PWD': '/builds/slave/test', 14:23:02 INFO - 'SHELL': '/bin/bash', 14:23:02 INFO - 'SHLVL': '1', 14:23:02 INFO - 'TERM': 'linux', 14:23:02 INFO - 'TMOUT': '86400', 14:23:02 INFO - 'USER': 'cltbld', 14:23:02 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1471986918.139483-489443446', 14:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:02 INFO - '_': '/tools/buildbot/bin/python'} 14:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:02 INFO - Downloading/unpacking psutil>=3.1.1 14:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:23:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:23:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:23:04 INFO - Installing collected packages: psutil 14:23:04 INFO - Running setup.py install for psutil 14:23:04 INFO - building 'psutil._psutil_linux' extension 14:23:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:23:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:23:05 INFO - building 'psutil._psutil_posix' extension 14:23:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:23:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:23:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:23:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:23:05 INFO - Successfully installed psutil 14:23:05 INFO - Cleaning up... 14:23:05 INFO - Return code: 0 14:23:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:05 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eaa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2168570>, '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 0x2169470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2169900>, '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': 'c6927cf182745ad25b1d38b9000001fe-1471986918.139483-489443446', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:23:05 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.3'] in /builds/slave/test/build 14:23:05 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.3 14:23:05 INFO - Using env: {'DISPLAY': ':0', 14:23:05 INFO - 'HOME': '/home/cltbld', 14:23:05 INFO - 'LANG': 'en_US.UTF-8', 14:23:05 INFO - 'LANGUAGE': 'en_US:en', 14:23:05 INFO - 'LOGNAME': 'cltbld', 14:23:05 INFO - 'MAIL': '/var/mail/cltbld', 14:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:05 INFO - 'MOZ_NO_REMOTE': '1', 14:23:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:05 INFO - 'NO_EM_RESTART': '1', 14:23:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:05 INFO - 'PWD': '/builds/slave/test', 14:23:05 INFO - 'SHELL': '/bin/bash', 14:23:05 INFO - 'SHLVL': '1', 14:23:05 INFO - 'TERM': 'linux', 14:23:05 INFO - 'TMOUT': '86400', 14:23:05 INFO - 'USER': 'cltbld', 14:23:05 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1471986918.139483-489443446', 14:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:05 INFO - '_': '/tools/buildbot/bin/python'} 14:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:23:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:23:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:23:07 INFO - Installing collected packages: mozsystemmonitor 14:23:07 INFO - Running setup.py install for mozsystemmonitor 14:23:07 INFO - Successfully installed mozsystemmonitor 14:23:07 INFO - Cleaning up... 14:23:07 INFO - Return code: 0 14:23:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eaa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2168570>, '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 0x2169470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2169900>, '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': 'c6927cf182745ad25b1d38b9000001fe-1471986918.139483-489443446', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:23:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:23:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:23:07 INFO - Using env: {'DISPLAY': ':0', 14:23:07 INFO - 'HOME': '/home/cltbld', 14:23:07 INFO - 'LANG': 'en_US.UTF-8', 14:23:07 INFO - 'LANGUAGE': 'en_US:en', 14:23:07 INFO - 'LOGNAME': 'cltbld', 14:23:07 INFO - 'MAIL': '/var/mail/cltbld', 14:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:07 INFO - 'MOZ_NO_REMOTE': '1', 14:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:07 INFO - 'NO_EM_RESTART': '1', 14:23:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:07 INFO - 'PWD': '/builds/slave/test', 14:23:07 INFO - 'SHELL': '/bin/bash', 14:23:07 INFO - 'SHLVL': '1', 14:23:07 INFO - 'TERM': 'linux', 14:23:07 INFO - 'TMOUT': '86400', 14:23:07 INFO - 'USER': 'cltbld', 14:23:07 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1471986918.139483-489443446', 14:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:07 INFO - '_': '/tools/buildbot/bin/python'} 14:23:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:07 INFO - Downloading/unpacking jsonschema==2.5.1 14:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:23:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:10 INFO - Downloading functools32-3.2.3-2.tar.gz 14:23:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:23:10 INFO - warning: no files found matching '*.txt' 14:23:10 INFO - no previously-included directories found matching 'build' 14:23:10 INFO - no previously-included directories found matching 'dist' 14:23:10 INFO - no previously-included directories found matching '.git*' 14:23:10 INFO - Installing collected packages: jsonschema, functools32 14:23:10 INFO - Running setup.py install for functools32 14:23:10 INFO - warning: no files found matching '*.txt' 14:23:10 INFO - no previously-included directories found matching 'build' 14:23:10 INFO - no previously-included directories found matching 'dist' 14:23:10 INFO - no previously-included directories found matching '.git*' 14:23:10 INFO - Successfully installed jsonschema functools32 14:23:10 INFO - Cleaning up... 14:23:10 INFO - Return code: 0 14:23:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eaa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2168570>, '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 0x2169470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2169900>, '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': 'c6927cf182745ad25b1d38b9000001fe-1471986918.139483-489443446', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:23:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:23:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:23:10 INFO - Using env: {'DISPLAY': ':0', 14:23:10 INFO - 'HOME': '/home/cltbld', 14:23:10 INFO - 'LANG': 'en_US.UTF-8', 14:23:10 INFO - 'LANGUAGE': 'en_US:en', 14:23:10 INFO - 'LOGNAME': 'cltbld', 14:23:10 INFO - 'MAIL': '/var/mail/cltbld', 14:23:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:10 INFO - 'MOZ_NO_REMOTE': '1', 14:23:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:10 INFO - 'NO_EM_RESTART': '1', 14:23:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:10 INFO - 'PWD': '/builds/slave/test', 14:23:10 INFO - 'SHELL': '/bin/bash', 14:23:10 INFO - 'SHLVL': '1', 14:23:10 INFO - 'TERM': 'linux', 14:23:10 INFO - 'TMOUT': '86400', 14:23:10 INFO - 'USER': 'cltbld', 14:23:10 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1471986918.139483-489443446', 14:23:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:10 INFO - '_': '/tools/buildbot/bin/python'} 14:23:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:23:10 INFO - Cleaning up... 14:23:10 INFO - Return code: 0 14:23:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1eaa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2168570>, '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 0x2169470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2169900>, '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': 'c6927cf182745ad25b1d38b9000001fe-1471986918.139483-489443446', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:23:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:23:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:23:10 INFO - Using env: {'DISPLAY': ':0', 14:23:10 INFO - 'HOME': '/home/cltbld', 14:23:10 INFO - 'LANG': 'en_US.UTF-8', 14:23:10 INFO - 'LANGUAGE': 'en_US:en', 14:23:10 INFO - 'LOGNAME': 'cltbld', 14:23:10 INFO - 'MAIL': '/var/mail/cltbld', 14:23:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:10 INFO - 'MOZ_NO_REMOTE': '1', 14:23:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:10 INFO - 'NO_EM_RESTART': '1', 14:23:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:10 INFO - 'PWD': '/builds/slave/test', 14:23:10 INFO - 'SHELL': '/bin/bash', 14:23:10 INFO - 'SHLVL': '1', 14:23:10 INFO - 'TERM': 'linux', 14:23:10 INFO - 'TMOUT': '86400', 14:23:10 INFO - 'USER': 'cltbld', 14:23:10 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1471986918.139483-489443446', 14:23:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:10 INFO - '_': '/tools/buildbot/bin/python'} 14:23:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:10 INFO - Downloading/unpacking blobuploader==1.2.4 14:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:12 INFO - Downloading blobuploader-1.2.4.tar.gz 14:23:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:23:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:23:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:23: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 14:23: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 14:23: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 14:23: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 14:23: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 14:23: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 14:23:13 INFO - Downloading docopt-0.6.1.tar.gz 14:23:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:23:13 INFO - Installing collected packages: blobuploader, requests, docopt 14:23:13 INFO - Running setup.py install for blobuploader 14:23:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:23:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:23:13 INFO - Running setup.py install for requests 14:23:14 INFO - Running setup.py install for docopt 14:23:14 INFO - Successfully installed blobuploader requests docopt 14:23:14 INFO - Cleaning up... 14:23:14 INFO - Return code: 0 14:23:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:14 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 0x1eaa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2168570>, '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 0x2169470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2169900>, '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': 'c6927cf182745ad25b1d38b9000001fe-1471986918.139483-489443446', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:23:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:23:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:23:14 INFO - Using env: {'DISPLAY': ':0', 14:23:14 INFO - 'HOME': '/home/cltbld', 14:23:14 INFO - 'LANG': 'en_US.UTF-8', 14:23:14 INFO - 'LANGUAGE': 'en_US:en', 14:23:14 INFO - 'LOGNAME': 'cltbld', 14:23:14 INFO - 'MAIL': '/var/mail/cltbld', 14:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:14 INFO - 'MOZ_NO_REMOTE': '1', 14:23:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:14 INFO - 'NO_EM_RESTART': '1', 14:23:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:14 INFO - 'PWD': '/builds/slave/test', 14:23:14 INFO - 'SHELL': '/bin/bash', 14:23:14 INFO - 'SHLVL': '1', 14:23:14 INFO - 'TERM': 'linux', 14:23:14 INFO - 'TMOUT': '86400', 14:23:14 INFO - 'USER': 'cltbld', 14:23:14 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1471986918.139483-489443446', 14:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:14 INFO - '_': '/tools/buildbot/bin/python'} 14:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:23:14 INFO - Running setup.py (path:/tmp/pip-KE_Bw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:23:14 INFO - Running setup.py (path:/tmp/pip-nhL2az-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:23:14 INFO - Running setup.py (path:/tmp/pip-Gt24pJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:23:14 INFO - Running setup.py (path:/tmp/pip-kul0C_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:23:14 INFO - Running setup.py (path:/tmp/pip-qnUyTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:23:14 INFO - Running setup.py (path:/tmp/pip-Z6DMze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:23:14 INFO - Running setup.py (path:/tmp/pip-o9_b8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:23:14 INFO - Running setup.py (path:/tmp/pip-qv_Y0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:23:14 INFO - Running setup.py (path:/tmp/pip-RnCOJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:23:15 INFO - Running setup.py (path:/tmp/pip-Gkjxqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:23:15 INFO - Running setup.py (path:/tmp/pip-6J4iUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:23:15 INFO - Running setup.py (path:/tmp/pip-mExcP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:23:15 INFO - Running setup.py (path:/tmp/pip-NmIm9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:23:15 INFO - Running setup.py (path:/tmp/pip-TF6se5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:23:15 INFO - Running setup.py (path:/tmp/pip-9yK4OS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:23:15 INFO - Running setup.py (path:/tmp/pip-xzzWux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:23:15 INFO - Running setup.py (path:/tmp/pip-3M1Qnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:23:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:23:15 INFO - Running setup.py install for manifestparser 14:23:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:23:15 INFO - Running setup.py install for mozcrash 14:23:15 INFO - Running setup.py install for mozdebug 14:23:15 INFO - Running setup.py install for mozdevice 14:23:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:23:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:23:16 INFO - Running setup.py install for mozfile 14:23:16 INFO - Running setup.py install for mozhttpd 14:23:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:23:16 INFO - Running setup.py install for mozinfo 14:23:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:23:16 INFO - Running setup.py install for mozInstall 14:23:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:23:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:23:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:23:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:23:16 INFO - Running setup.py install for mozleak 14:23:16 INFO - Running setup.py install for mozlog 14:23:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:23:16 INFO - Running setup.py install for moznetwork 14:23:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:23:16 INFO - Running setup.py install for mozprocess 14:23:16 INFO - Running setup.py install for mozprofile 14:23:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:23:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:23:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:23:16 INFO - Running setup.py install for mozrunner 14:23:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:23:17 INFO - Running setup.py install for mozscreenshot 14:23:17 INFO - Running setup.py install for moztest 14:23:17 INFO - Running setup.py install for mozversion 14:23:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:23:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:23:17 INFO - Cleaning up... 14:23:17 INFO - Return code: 0 14:23:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:23: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')]} 14:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23: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')]} 14:23:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:17 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 0x1eaa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2168570>, '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 0x2169470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2169900>, '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': 'c6927cf182745ad25b1d38b9000001fe-1471986918.139483-489443446', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:23:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:23:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:23:17 INFO - Using env: {'DISPLAY': ':0', 14:23:17 INFO - 'HOME': '/home/cltbld', 14:23:17 INFO - 'LANG': 'en_US.UTF-8', 14:23:17 INFO - 'LANGUAGE': 'en_US:en', 14:23:17 INFO - 'LOGNAME': 'cltbld', 14:23:17 INFO - 'MAIL': '/var/mail/cltbld', 14:23:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:17 INFO - 'MOZ_NO_REMOTE': '1', 14:23:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:17 INFO - 'NO_EM_RESTART': '1', 14:23:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:17 INFO - 'PWD': '/builds/slave/test', 14:23:17 INFO - 'SHELL': '/bin/bash', 14:23:17 INFO - 'SHLVL': '1', 14:23:17 INFO - 'TERM': 'linux', 14:23:17 INFO - 'TMOUT': '86400', 14:23:17 INFO - 'USER': 'cltbld', 14:23:17 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1471986918.139483-489443446', 14:23:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:17 INFO - '_': '/tools/buildbot/bin/python'} 14:23:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:23:17 INFO - Running setup.py (path:/tmp/pip-OGAXez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:23:17 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:23:17 INFO - Running setup.py (path:/tmp/pip-QuPCTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:23:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:23:17 INFO - Running setup.py (path:/tmp/pip-2vzwZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:23:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:23:17 INFO - Running setup.py (path:/tmp/pip-m7Ks2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:23:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:23:17 INFO - Running setup.py (path:/tmp/pip-4_dTef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:23:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:23:17 INFO - Running setup.py (path:/tmp/pip-6Ix153-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:23:18 INFO - Running setup.py (path:/tmp/pip-TOWghw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:23:18 INFO - Running setup.py (path:/tmp/pip-OWQNFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:23:18 INFO - Running setup.py (path:/tmp/pip-Iebl5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:23:18 INFO - Running setup.py (path:/tmp/pip-OhI90V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:23:18 INFO - Running setup.py (path:/tmp/pip-6vqzpZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:23:18 INFO - Running setup.py (path:/tmp/pip-iF9hoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:23:18 INFO - Running setup.py (path:/tmp/pip-TSjvJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:23:18 INFO - Running setup.py (path:/tmp/pip-EkgPHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:23:18 INFO - Running setup.py (path:/tmp/pip-3laKmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:23:18 INFO - Running setup.py (path:/tmp/pip-VQpXtH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:23:18 INFO - Running setup.py (path:/tmp/pip-GcF9Mo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:23:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:20 INFO - Downloading blessings-1.6.tar.gz 14:23:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:23:20 INFO - Installing collected packages: blessings 14:23:20 INFO - Running setup.py install for blessings 14:23:20 INFO - Successfully installed blessings 14:23:20 INFO - Cleaning up... 14:23:20 INFO - Return code: 0 14:23:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:23:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:23:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:23:21 INFO - Reading from file tmpfile_stdout 14:23:21 INFO - Current package versions: 14:23:21 INFO - argparse == 1.2.1 14:23:21 INFO - blessings == 1.6 14:23:21 INFO - blobuploader == 1.2.4 14:23:21 INFO - docopt == 0.6.1 14:23:21 INFO - functools32 == 3.2.3-2 14:23:21 INFO - jsonschema == 2.5.1 14:23:21 INFO - manifestparser == 1.1 14:23:21 INFO - mozInstall == 1.12 14:23:21 INFO - mozcrash == 0.17 14:23:21 INFO - mozdebug == 0.1 14:23:21 INFO - mozdevice == 0.48 14:23:21 INFO - mozfile == 1.2 14:23:21 INFO - mozhttpd == 0.7 14:23:21 INFO - mozinfo == 0.9 14:23:21 INFO - mozleak == 0.1 14:23:21 INFO - mozlog == 3.3 14:23:21 INFO - moznetwork == 0.27 14:23:21 INFO - mozprocess == 0.23 14:23:21 INFO - mozprofile == 0.28 14:23:21 INFO - mozrunner == 6.12 14:23:21 INFO - mozscreenshot == 0.1 14:23:21 INFO - mozsystemmonitor == 0.3 14:23:21 INFO - moztest == 0.7 14:23:21 INFO - mozversion == 1.4 14:23:21 INFO - psutil == 3.1.1 14:23:21 INFO - requests == 1.2.3 14:23:21 INFO - wsgiref == 0.1.2 14:23:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:21 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 0x1eaa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2168570>, '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 0x2169470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2169900>, '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': 'c6927cf182745ad25b1d38b9000001fe-1471986918.139483-489443446', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:23:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:23:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:23:21 INFO - Using env: {'DISPLAY': ':0', 14:23:21 INFO - 'HOME': '/home/cltbld', 14:23:21 INFO - 'LANG': 'en_US.UTF-8', 14:23:21 INFO - 'LANGUAGE': 'en_US:en', 14:23:21 INFO - 'LOGNAME': 'cltbld', 14:23:21 INFO - 'MAIL': '/var/mail/cltbld', 14:23:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:21 INFO - 'MOZ_NO_REMOTE': '1', 14:23:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:21 INFO - 'NO_EM_RESTART': '1', 14:23:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:21 INFO - 'PWD': '/builds/slave/test', 14:23:21 INFO - 'SHELL': '/bin/bash', 14:23:21 INFO - 'SHLVL': '1', 14:23:21 INFO - 'TERM': 'linux', 14:23:21 INFO - 'TMOUT': '86400', 14:23:21 INFO - 'USER': 'cltbld', 14:23:21 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1471986918.139483-489443446', 14:23:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:21 INFO - '_': '/tools/buildbot/bin/python'} 14:23:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:23:21 INFO - Cleaning up... 14:23:21 INFO - Return code: 0 14:23:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:21 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 0x1eaa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2168570>, '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 0x2169470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2169900>, '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': 'c6927cf182745ad25b1d38b9000001fe-1471986918.139483-489443446', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:23:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:23:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:23:21 INFO - Using env: {'DISPLAY': ':0', 14:23:21 INFO - 'HOME': '/home/cltbld', 14:23:21 INFO - 'LANG': 'en_US.UTF-8', 14:23:21 INFO - 'LANGUAGE': 'en_US:en', 14:23:21 INFO - 'LOGNAME': 'cltbld', 14:23:21 INFO - 'MAIL': '/var/mail/cltbld', 14:23:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:21 INFO - 'MOZ_NO_REMOTE': '1', 14:23:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:21 INFO - 'NO_EM_RESTART': '1', 14:23:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:21 INFO - 'PWD': '/builds/slave/test', 14:23:21 INFO - 'SHELL': '/bin/bash', 14:23:21 INFO - 'SHLVL': '1', 14:23:21 INFO - 'TERM': 'linux', 14:23:21 INFO - 'TMOUT': '86400', 14:23:21 INFO - 'USER': 'cltbld', 14:23:21 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1471986918.139483-489443446', 14:23:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:21 INFO - '_': '/tools/buildbot/bin/python'} 14:23:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:23:21 INFO - Cleaning up... 14:23:21 INFO - Return code: 0 14:23:21 INFO - Running post-action listener: _resource_record_post_action 14:23:21 INFO - Running post-action listener: _start_resource_monitoring 14:23:21 INFO - Starting resource monitoring. 14:23:21 INFO - [mozharness: 2016-08-23 21:23:21.686182Z] Finished create-virtualenv step (success) 14:23:21 INFO - [mozharness: 2016-08-23 21:23:21.686607Z] Running install step. 14:23:21 INFO - Running pre-action listener: _resource_record_pre_action 14:23:21 INFO - Running main action method: install 14:23:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:23:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:23:21 INFO - Reading from file tmpfile_stdout 14:23:21 INFO - Detecting whether we're running mozinstall >=1.0... 14:23:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:23:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:23:21 INFO - Reading from file tmpfile_stdout 14:23:21 INFO - Output received: 14:23:21 INFO - Usage: mozinstall [options] installer 14:23:21 INFO - Options: 14:23:21 INFO - -h, --help show this help message and exit 14:23:21 INFO - -d DEST, --destination=DEST 14:23:21 INFO - Directory to install application into. [default: 14:23:21 INFO - "/builds/slave/test"] 14:23:21 INFO - --app=APP Application being installed. [default: firefox] 14:23:21 INFO - mkdir: /builds/slave/test/build/application 14:23:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:23:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:23:38 INFO - Reading from file tmpfile_stdout 14:23:38 INFO - Output received: 14:23:38 INFO - /builds/slave/test/build/application/firefox/firefox 14:23:38 INFO - Running post-action listener: _resource_record_post_action 14:23:38 INFO - [mozharness: 2016-08-23 21:23:38.793089Z] Finished install step (success) 14:23:38 INFO - [mozharness: 2016-08-23 21:23:38.793458Z] Running run-tests step. 14:23:38 INFO - Running pre-action listener: _resource_record_pre_action 14:23:38 INFO - Running main action method: run_tests 14:23:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:23:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:23:38 INFO - Python 2.7.3 14:23:38 INFO - Return code: 0 14:23:38 INFO - grabbing minidump binary from tooltool 14:23:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:38 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2168570>, '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 0x2169470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2169900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:23:38 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:23:38 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:23:38 INFO - Calling ['/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'] with output_timeout 600 14:23:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:23:38 INFO - Return code: 0 14:23:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:23:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:23:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:23:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:23:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:23:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:23:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:23:38 INFO - Using env: {'DISPLAY': ':0', 14:23:38 INFO - 'HOME': '/home/cltbld', 14:23:38 INFO - 'LANG': 'en_US.UTF-8', 14:23:38 INFO - 'LANGUAGE': 'en_US:en', 14:23:38 INFO - 'LOGNAME': 'cltbld', 14:23:38 INFO - 'MAIL': '/var/mail/cltbld', 14:23:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:23:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:23:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:38 INFO - 'MOZ_NO_REMOTE': '1', 14:23:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:23:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:38 INFO - 'NO_EM_RESTART': '1', 14:23:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:38 INFO - 'PWD': '/builds/slave/test', 14:23:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:23:38 INFO - 'SHELL': '/bin/bash', 14:23:38 INFO - 'SHLVL': '1', 14:23:38 INFO - 'TERM': 'linux', 14:23:38 INFO - 'TMOUT': '86400', 14:23:38 INFO - 'USER': 'cltbld', 14:23:38 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1471986918.139483-489443446', 14:23:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:38 INFO - '_': '/tools/buildbot/bin/python'} 14:23:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:23:39 INFO - mozversion application_buildid: 20160823121617 14:23:39 INFO - mozversion application_changeset: a72bfbdf5c9b36e68ca806a25944180f2652f0c9 14:23:39 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:23:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:23:39 INFO - mozversion application_name: Firefox 14:23:39 INFO - mozversion application_remotingname: firefox-dev 14:23:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:23:39 INFO - mozversion application_vendor: Mozilla 14:23:39 INFO - mozversion application_version: 50.0a2 14:23:39 INFO - mozversion platform_buildid: 20160823121617 14:23:39 INFO - mozversion platform_changeset: a72bfbdf5c9b36e68ca806a25944180f2652f0c9 14:23:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:23:39 INFO - mozversion platform_version: 50.0a2 14:23:39 INFO - using testdate: 1471987419 14:23:39 INFO - actual date: 1471987419 14:23:39 INFO - starting webserver on 'localhost:48101' 14:23:39 INFO - SUITE-START | Running 2 tests 14:23:39 INFO - TEST-START | dromaeo_css 14:23:39 INFO - operating with platform_type : linux_ 14:23:39 INFO - Initialising browser for dromaeo_css test... 14:23:39 INFO - TEST-INFO | started process 26063 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3gJdfm/profile http://localhost:48101/getInfo.html) 14:23:43 INFO - PROCESS | 26063 | __metrics Screen width/height:1600/1200 14:23:43 INFO - PROCESS | 26063 | colorDepth:24 14:23:43 INFO - PROCESS | 26063 | Browser inner width/height: 1024/697 14:23:43 INFO - PROCESS | 26063 | __metrics 14:23:44 ERROR - PROCESS | 26063 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 14:23:44 INFO - TEST-INFO | 26063: exit 0 14:23:44 INFO - Browser initialized. 14:23:44 INFO - Running cycle 1/1 for dromaeo_css test... 14:23:44 INFO - TEST-INFO | started process 26188 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3gJdfm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:23:56 INFO - PROCESS | 26188 | RSS: Main: 152416256 14:23:56 INFO - PROCESS | 26188 | 14:24:46 INFO - PROCESS | 26188 | 1471987486212 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:26:54 INFO - PROCESS | 26188 | Cycle 1(1): loaded http://localhost:48101/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48101/tests/dromaeo/cssquery-ext.html) 14:26:56 INFO - PROCESS | 26188 | RSS: Main: 157560832 14:26:56 INFO - PROCESS | 26188 | 14:29:58 INFO - PROCESS | 26188 | Cycle 1(1): loaded http://localhost:48101/tests/dromaeo/cssquery-ext.html (next: http://localhost:48101/tests/dromaeo/cssquery-jquery.html) 14:29:58 INFO - PROCESS | 26188 | RSS: Main: 153112576 14:29:58 INFO - PROCESS | 26188 | 14:33:00 INFO - PROCESS | 26188 | Cycle 1(1): loaded http://localhost:48101/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48101/tests/dromaeo/cssquery-mootools.html) 14:33:01 INFO - PROCESS | 26188 | RSS: Main: 155201536 14:33:01 INFO - PROCESS | 26188 | 14:36:02 INFO - PROCESS | 26188 | Cycle 1(1): loaded http://localhost:48101/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48101/tests/dromaeo/cssquery-prototype.html) 14:36:03 INFO - PROCESS | 26188 | RSS: Main: 152346624 14:36:03 INFO - PROCESS | 26188 | 14:39:05 INFO - PROCESS | 26188 | Cycle 1(1): loaded http://localhost:48101/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48101/tests/dromaeo/cssquery-yui.html) 14:39:06 INFO - PROCESS | 26188 | RSS: Main: 154947584 14:39:06 INFO - PROCESS | 26188 | 14:42:08 INFO - PROCESS | 26188 | Cycle 1(1): loaded http://localhost:48101/tests/dromaeo/cssquery-yui.html (next: http://localhost:48101/tests/dromaeo/cssquery-dojo.html) 14:42:09 INFO - PROCESS | 26188 | RSS: Main: 156106752 14:42:09 INFO - PROCESS | 26188 | 14:42:09 INFO - PROCESS | 26188 | __start_tp_report 14:42:09 INFO - PROCESS | 26188 | _x_x_mozilla_page_load 14:42:09 INFO - PROCESS | 26188 | _x_x_mozilla_page_load_details 14:42:09 INFO - PROCESS | 26188 | |i|pagename|runs| 14:42:09 INFO - PROCESS | 26188 | |0;dojo.html;3348.480985447256;3354.3459025490024;3380.847861846217;3388.542546756187;3414.180596656803;5885.617434866736;5948.286205655322;5990.970045149779;6015.368386319439;6059.848503787408;5936.554758393127;5986.760529578812;5997.160397544337;5997.31030931443;6018.217631707872;5374.355077390709;5411.567074634039;5471.37079235887;5488.451154884499;5490.313710786152;5293.391260005091;5316.3620365556;5348.117560602496;5371.59713021523;5391.838244852661;5361.758720857571;5388.541973932201;5401.513863752261;5402.324709411324;5403.297571315743;5452.263944367499;5461.69960652164;5469.124940009579;5471.753771080311;5494.423085575997;5144.717040562805;5211.661242019257;5239.711815850127;5342.412334643186;5345.278387417727;5845.415458454163;5883.0881213411985;5895.587308888379;5911.320198177222;5961.284645842483;6359.173307470046;6383.39357761012;6416.839579010562;6421.101045853584;6438.710258038353;6216.658083805389;6324.177856878622;6381.617102973836;6432.260290066655;6466.191726034246;5972.790952316648;5981.641101533922;6005.099235114768;6006.159137720722;6016.398360163992;6538.771143010067;6559.901601475982;6588.967055164693;6605.405513503808;6607.2071351438135;6139.522803442411;6216.720247588869;6221.564490485713;6336.58812177207;6351.460125889259;6427.357264273629;6462.773802916875;6472.546921715529;6478.967605161944;6490.610563366213;6398.712057957403;6414.294427612959;6415.358464153547;6427.164468619049;6435.388638079375;6109;6257.968710156511;6268.435840774261;6435.774747883802;6443.0335449682925;4826.396700412449;4849.345338379344;4854.927176092361;4862.659613827069;4882.170031094723;4288.013756835945;4310.31035034393;4310.331898555729;4319.6976211665515;4333.306670932699;5906.5570082244;6036.486898613667;6040.788572399945;6127.816165514952;6137.5703700741415;6461.127747753993;6471.7734879279;6498.122753428227;6532.771353002622;6534.313897040837;6131.877362452726;6153.8461538461;6156.815295541141;6159.722812473449;6184.567080304336;5394.73026348681;5397.865053373618;5422.593305502103;5503.174523821459;5534.889302213933;6647.966760166169;6648.368405001517;6650.301718319603;6652.401283884376;6654.6672666366485;6384.680765961591;6422.935770642233;6442.162518872517;6465.676716164267;6471.514636402195;6318.747250109944;6523.869522609616;6587.110740050032;6683.264840867598;6697.397234248941;6398.872022559616;6401.391867772554;6407.679616019087;6409.166808315075;6432.35676432353;6493.058506516623;6500.804975850732;6513.185851768529;6525.967370163119;6545.967270163619;6142.314611233224;6229.937700623117;6263.96868015657;6391.456726178141;6403.743850246125;6258.655773932295;6290;6304.148939893055;6328.145700330397;6344.619322840645;6300.117983482224;6305.148804911279;6308.211473565804;6310.211223597051;6325.430711236011;6041.75832966694;6224.875502489835;6255.155554000334;6356.841078973062;6365.172527571386;6153.507719382528;6164.229471316085;6165.907511387422;6170.290416602148;6184.072389141665 14:42:09 INFO - PROCESS | 26188 | |1;ext.html;578.3233616668498;632.3897438971393;651.0949779806069;668.4852663449147;698.8218004408875;42129.78935105324;46837.76581117098;47063;47188.29217561731;47209.52790472094;46242.30636540446;46324.53675463244;46581.30128048082;46860.297095543596;46917.29624055642;9071.092890710926;9270.21203197729;9276.443413395184;9287.071292870727;9320.487373194472;9117;9225.354225204239;9226.815463690722;9238.769030774218;9241.214496767783;9305.116013978695;9314.86027709585;9317;9337.906620933805;9344.53277336134;9220.585073671667;9287.907120928772;9296;9302;9323.533823308875;9214.815703685956;9217.354785165042;9223.492707901063;9280.907190928072;9291.674791382336;45645.54354456446;46005.309920351225;46129.308060379124;46346;46378.53621463776;3832.827522761482;3915;3936.76379417233;4037.354023356249;4060.4112403701592;35229.29541409183;35897.46153807695;36042.45936310958;36349.27301453956;36621.26757464863;4749.667523273372;4769;4792.496787837262;4833.3958255218095;4907.509249075064;355823;358398;359523;360615;360919;64054;64766.67616661887;64855.35144648493;64939;65065.67467162728;36689.81655091707;36967;37461.62538374636;37524.812375937945;37581.43627845585;18119.18463669138;18123.818761812214;18170.45488635343;18276.817231827776;18342.266309347742;13897.861021389657;13903.652408689864;13979.510717124851;13988.300584970711;14008.649783755487;21195.152193912378;21402;21426.464338391666;21568.137274508845;21755.891220543795;7697.576633285223;7862.960685196537;7883.763487095396;8013.278804907586;8019.639116239783;1033.503918119307;1097.4512743628186;1113.6826004588816;1132.2810015639964;1144.5978676121683;34653.48019779706;35021;35161;35245.47131793025;35441.46837797435;1162.3200427749691;1167.830664553635;1185.7213554814612;1254.956076537317;1283.9293838838767;17873.016984066002;18240.45278641643;18242.817571824377;18696.719549206773;18741.81258187428;609869;616410;616433;617463;617484;64952.67523662446;65778.34221657722;65839.67080164568;65848.34151658422;65859.67070164619;1425.2659880161725;1452.1795185720034;1457.628304782295;1464.3995961655883;1471.6615178509003;32148.83925580357;33872.49191262182;33882;33927.830360848035;34819.477707833896;57908.4209157903;58037.70981145067;58302.7084864573;58380;58640;493115;494891;494944;498003;498091;31128.22179445532;31619.683803162596;32020.67979320177;32062.519062213618;32067.839660801546;53046;53052.46947530475;53698;54188.45811541834;54689.453105468434;45904.45389391276;45927.77036114798;47125;47530;48638.27042594293;46020.76989615164;46120.538794611624;46763.53236467592;47464.88294314381;47517.76241118772;45813.77093114513;46265.53734462612;46838.765806172116;46919;49186.50813491819;40048.599514005655;41541.58458415498;41930;42771.358429624204;43232.13535729331;30100.849495753257;30387.544186836774;30396.240093997825;30834.229144271572;31130.688693112777 14:42:09 INFO - PROCESS | 26188 | |2;jquery.html;409.469736690985;414.81748030866396;420.99368509472356;434.58931309912134;447.68214567656963;19663.803361966377;21098.156073757033;21303.467413314655;21354.25260115896;21780.346589602337;20255;20560.588788224264;20771.688424673604;21021.159153633835;21121;5827.999999999989;6037.637741735488;6045.546584006195;6047.304559975593;6048;5602.2436971009;5892.852678683024;5931.584789064746;5947.434993675594;5996.790112346069;5880.4119588041285;5923.614965027259;5926.703664816763;5935.910961335583;5982.8504287392725;5752.165935939286;5833.533317334603;5859.033259512175;5905.822825315226;5933.821985340447;5883.61756485827;6017.608855424383;6048.183495228176;6054.727537260834;6058.091286307045;14574.927125364306;14789;15019.924900375538;15173.924130379277;15227.390904363812;2418.4316685578874;2480.6899137607797;2482.8013758899424;2526.4441822798954;2597.168905950097;10480;10635.840462393071;11154.498047587878;11416.086713062936;11546.94226528862;2052.6202652509332;2078.7297651305234;2082.6563617003176;2105.768365479796;2119.925802596917;87546.5622671889;87784.56107719484;88928.55535722345;92128.07871921262;93049.53475232581;11599.130065245141;11635.301881887113;11660.242084264495;11827.586034488751;11955.52177912891;16793.496195114167;16820.74768878468;16829.158542072848;16879.91560042192;16931;8292.917070829335;8298.04572474161;8338.124496927856;8505.064442911274;8631.050584435707;7819.257170568787;7827.569483678339;7969.442139050211;8013.839723205503;8024.438289319692;4968;5093.745312734349;5108.591312694975;5114.693118412907;5167.431582525919;2048.457158852905;2109.873407595549;2123.543438160772;2140.4541841830232;2167.837412194092;933.206774241889;990.64336838738;1034.3225187502198;1041.245097304448;1053.104860868271;20677;20744.58510829805;20787.06458209384;20806.375808725763;20908;1040.7294103532984;1069.9411532365639;1081.6971248050559;1108.6673997800629;1129.920905536621;11414.258073225214;11468.770624587461;11555.133364997491;11654.475548600334;11660.30038197711;410975;412950;415415;547807;547849;102204;102610.48694756627;102712.48643756734;106296;106739;1069.753956589973;1071.4000159910474;1101.9724506887392;1110.7945030169444;1116.1461481966303;18221.180046897658;18510;18795.436136915916;18986.633633693833;19108;43122;44185.861082595526;45648.08703825838;45705.31442028439;45872.08255834798;60143;60387.39612603818;63181;64167;64888.675556621914;9158.175764181256;9322.720318390458;9409;9450.385724927857;9452.905470945203;11942.164048516868;12292.201006934522;13967.51113711056;14234.430622774973;14722.411103555738;11776.234544754563;12356.505739770308;12386.75226495447;12587.181833180814;12820.166689165175;11655.125865559947;11693.356865372487;11798.174127810971;12178;12339.444724987217;11206.439678015904;11343.376114313793;11945;12191.51233950632;12485;8856;9197.218236449977;9231.261499079923;9286.6285348588;9385.671501497414;9028.413153145024;12154.270743755404;12273.631791046282;12390.938045309716;12676.112672112864 14:42:09 INFO - PROCESS | 26188 | |3;mootools.html;1548.7212301785678;1566.1934103936471;1750.3348727483562;1810.6378724255153;1846.9815301846977;8652.697155599555;9335.71992840215;9562.665306714267;10074.546645400957;10084.34451760635;9615.855762163574;9682.273829462802;9727.951360243207;9737.51312434379;9749.512524373771;2519.2568192383246;2543.5548778963607;2550.0692247329685;2550.3241640965066;2552.7830134438595;2487.3035550046015;2555.527227462916;2570.498752743216;2573.7812285955715;2574.124797568826;2458.029078513986;2489.800815934721;2520.117958714454;2540.5554028045112;2541.7712405883467;2494.226789695191;2498.4378514834107;2502.6621406110125;2516.874156292178;2522.205505265835;2454.5949918263464;2456.2140115163156;2459.7909177719916;2470.0613766768693;2486.415692312305;9689.660861869801;9735.464549449778;9746.171575416098;9780;9781;5625.8593535161535;5775.826725198251;5860.443257890493;5865.824025279248;5869.090291004901;3495.8426870790877;3609.819509024538;3663.377225871608;3665.2303016366595;3689.4281386385155;1217.9208351457128;1237.3486802937055;1240.975180496394;1244.234795600699;1269.8539667938212;13738.381772820147;13769.793453098211;13779.104358216784;13856.93071534636;13888.652783680387;4970.428400733889;5163.561097306771;5214.191800270964;5248.711320877312;5293.100172970604;11484.196106272648;11503.309801411942;11507.964283214551;11520.020798232244;11641.359725215194;5850.3564607893095;5882.441168089024;5885.588008839341;5885.676287804126;5885.941140588625;4731.716097034189;5364.544013758874;5380.488853558905;5403.378611459654;5477.20580515823;4345.413369195118;4353.673474489426;4468.039371535136;4469.262571675637;4472.619827314715;1355.0379230746084;1375.2985977151725;1375.8624137586162;1379.834419869622;1380.2615600653803;1017.4099022566893;1069.550788668761;1076.1229597877705;1083.7886612110563;1110.4503270880966;6520.413162815369;6787.5588086774205;6945.617991010442;7009.1939426966555;7093.184283807428;488.6994498383469;509.15480302697347;509.6967304453844;510.6884800271831;513.1328055586048;4720.433547974265;4785.401824771903;4786.832460863853;4834.323194752737;4834.540718631724;11674.883251167379;12249.755004899853;12254.203476774159;12274.754504909852;12291.508339666314;11418;11849;12104.75790484203;12207.938960305142;12240.326782027074;8982.640694372152;9019.143181397756;9162.083791620784;9171.81656366869;9200.631974720936;6653.135092437952;6695.564788288746;6797.218319893275;6800.489963252875;6933.583984960918;10859.457027148768;11161.051310638362;11203.383813890314;11278.830817537579;11397.829032564685;11403.657890263305;11557.47991340375;11560.306381616794;11603.5358585659;11673.766524669629;8422.073571906963;8476.618552165291;8668.78328041804;8682.218600326001;8725.476471411735;9693.466859322523;9698.660546881107;9701.6604418845;9738;9754.85367719499;8543;8560;8664;8712.520811355183;8755.299576034029;8505.95747021261;8598.140185981352;8600.22597966186;8672.869906951528;8715.389922705603;7688.538687678757;7769.961150194213;7808.648610812641;7810.609469526615;7814.6483408247905;5844.168754224867;5860.882782344244;5941.643501389931;5942.494887934574;5974.40255974399;5783.7975670853;5800.8259752207505;5818.6217895836635;5839.766409343579;5903.173555702119 14:42:09 INFO - PROCESS | 26188 | |4;prototype.html;354.6187848063331;366.24553419954896;368.65346574220223;373.5200267656061;380.74109605468306;5670.177824215486;5742.626729262595;5862.73617687204;5958.79144229952;6014.759409623615;5716;5819.4471525205145;5831.7958871439505;5838.2702162229725;5841.15303281024;4550.271956486963;4563.178627846986;4563.566461186182;4596.678232523725;4599.057193275387;4478.955210447886;4575.428071491064;4580.610648094916;4599.264117741145;4625.167469855424;4533.9546604534025;4549.590536851682;4550.749708766017;4586.72479651222;4598.2183028885;4563.566461186182;4575.307136359535;4586.220342541776;4594.770261486929;4610.723356598614;3845.1540661054523;3973.6821054315587;4009.5389030261604;4115.218108559364;4117.423560701504;5675.035244008487;5678.176664383641;5697.316322041382;5698.458646428583;5709.286339207599;5189.714565698885;5190.4186111582885;5239.528442440199;5253.9492101579835;5271.683698978073;5839.503642190419;6024.608400453956;6031.849203769897;6069.544784141163;6184.721687524072;4334.804933777988;4350.499692535367;4361.694681372305;4364.345348197764;4375.453068366454;6161.784337548209;6363.140975968277;6372.7132279047555;6394.680265986682;6398.520110991694;4436.6672499562665;4473.843415480507;4477.641788656965;4478.41780568524;4492.124035812985;4537.160625284333;4560.156371071363;4579.95420045802;4583.72497650142;4586.19741545235;5149.253358263031;5208.5312321891215;5231.163013917755;5231.503007214308;5262.421133675292;5950.958582248089;6111;6113.877722445526;6121.204243448323;6194.5044396448175;1560.9063456192437;1577.2350410051115;1590.363854458226;1592.371013449681;1594.9043057416593;961.5240455974338;1000.949952502372;1008.8890222075565;1012.5139932832135;1021.8211812932856;5216.58267338612;5270.683758974474;5273.947260527422;5277.683338999673;5362.65142765719;5473.698946557977;5509.724513774376;5540.9168862467095;5550.888982220414;5628.973569514971;4944.283078953532;5232.476752324737;5261.789528418897;5282.075636763551;5301.3373328333955;2915.5189393749793;2939.6325459317586;2960.378320552665;2964.5770030385106;2969.584258203853;5689.687067211343;5712.714364281769;5718.68547229898;5740.875875925934;5763.4812866842185;6025.909611355745;6457.903131453032;6493.31820158886;6527.3472652734345;6529.738810447624;6552.705128269239;6595.868082638416;6601;6601.3068627794355;6617.04052912325;6160.537959652955;6261.373862613702;6309.1167236587835;6361.936380636134;6381.085674297599;6296.779612713533;6303.432691057827;6316.242050953915;6366.427021568081;6368.808935731936;6363.236411630449;6458.870822583616;6504.317046710027;6518.641474718746;6612.305707900794;4502.3921770560555;4502.7523486207265;4522.479914809707;4532.592066714012;4544.272916333371;6115.296740874678;6115.785947491817;6391.744330226739;6425.421712045938;6428.5571482838095;6117.755289788537;6159.353267906805;6213.37866213375;6255.655938923403;6271.43557079865;6050.15297858309;6189.535784816067;6190.876182476415;6196.0705894116245;6256.968715156395;6035.39646035393;6043.8186854394435;6058.757649693963;6096.390360963868;6098.451139397475;6185.103160041679;6225.937740622536;6257.374262573706;6261.870963872305;6278.4035516625845;5897.321807992136;6020.314311992649;6048.213732214784;6049.001914684028;6102.993006154113 14:42:09 INFO - PROCESS | 26188 | |5;yui.html;850.8851305073813;857.8198578298557;861.0356400831071;881.6076845803618;918.9172974432299;16330.591735206612;17805.465836024923;18016.18927148278;18205.089745512705;18223.36218232362;15939.203039848018;16084.919575402108;16087.793415493856;16112;16152.83847161528;722.5809030762158;854.0647990450447;877.7805548612815;883.3110174064208;883.8453270677605;881.6561540999015;882.3117967984982;882.4749274181852;885.0883589902411;887.1040249348173;932.0818993291603;936.4381371177308;937.1378331934602;937.3063932689795;937.5546615357719;931.9301052421096;933.2580598424236;933.4539294512718;933.7152168588577;934.8223837470858;689.2246222999127;689.7896141676787;690.7340673840557;691.3086913086913;693.2582137113291;15295.15876626785;15393.461228857048;15440.073595584188;15450.613734656612;15455.61360965985;14509.92745036268;14563.271836408137;14588.197649129293;14991.325390357351;15210.391584336614;14597.416103355854;14632.341544630517;14845.851541484555;14884.330205140795;14905.180215088165;4772.2125849234835;4825.662203645747;5010.2735103409805;5013.949860501385;5022.874428139289;92594;93182;94019;94021.52989235078;94180.52909735407;12380;12484.625461236177;12615.621531354074;12639.653658925732;12879.678008049686;22466.55066898653;22511.32466026022;22635;22676.65985010226;22743.545129097325;9333.90666093344;9352.251819854395;9436.90563094374;9542.570584323723;9664.613415463302;5111.821086262037;5232.215167724796;5246.291750613618;5274.865903830695;5330.973345133327;3858.7298889077497;3912.041549820255;3952.5256969163884;3982.4623675803396;3997.2205419942834;680.7209044291817;683.6308393467572;693.8022663540867;694.2224708326706;707.0525495835604;744.244591739385;754.6792613139504;778.70020042283;793.5596891641652;801.7354273089867;10303.330283531546;10319.122874555596;10414.68755937308;10558.993791179651;10573.52419141125;707.3563057617544;741.1217707017202;748.6705849426235;770.3567521119816;792.6195426195343;5172.5344718975475;5212.50481204285;5256.474352564713;5329.520343169133;5426.403095659474;65931;114463;117547.41226293813;120795.39602301932;122262.38868805599;104330;106166.46916765522;106249;106637.46681266544;108392.45803770931;90436.5478172618;92202.99999999866;93210.53394733119;93798.53100734453;95319;9814.153895370262;10429.478526073817;10581.15350771921;10594.417307048187;10657;51450.74274628603;52902.735486323865;53012.73493632507;53997.49016313927;54992.45007549873;46216.30675539802;46417.76791116158;48861.26708099453;57619.71190144023;77483;12886.484540618645;13235.735285294433;13303.800442993557;13312;13555.254461004739;15018.549443516711;15088;15287.923560382127;15434.614134646723;15550.766738498705;14294.785578216128;14473.782893256399;14505.419783208554;14763.778543321643;15157.848421516084;13591.660208494866;13629.522966696119;13993.300334983007;14015.719685606435;14741.852581474048;13674.93162534181;13735.45058197661;13886.236257005961;14272.571822845332;14467.85532144665;11310.264832785842;11360.431978401211;11806;11977.461014254206;12300.446479908605;11797.705057373634;11857.288562686266;12052.28550428099;12287.44706488228;12311.753764924471 14:42:09 INFO - PROCESS | 26188 | __end_tp_report 14:42:09 INFO - PROCESS | 26188 | __start_cc_report 14:42:09 INFO - PROCESS | 26188 | _x_x_mozilla_cycle_collect,326 14:42:09 INFO - PROCESS | 26188 | __end_cc_report 14:42:09 INFO - PROCESS | 26188 | __startTimestamp1471988529107__endTimestamp 14:42:09 INFO - PROCESS | 26188 | 14:42:09 INFO - PROCESS | 26188 | ------- Summary: start ------- 14:42:09 INFO - PROCESS | 26188 | Number of tests: 6 14:42:09 INFO - PROCESS | 26188 | 14:42:09 INFO - PROCESS | 26188 | [#0] dojo.html Cycles:165 Average:5944.15 Median:6184.07 stddev:708.72 (11.5%) stddev-sans-first:681.01 14:42:09 INFO - PROCESS | 26188 | Values: 3348.5 3354.3 3380.8 3388.5 3414.2 5885.6 5948.3 5991.0 6015.4 6059.8 5936.6 5986.8 5997.2 5997.3 6018.2 5374.4 5411.6 5471.4 5488.5 5490.3 5293.4 5316.4 5348.1 5371.6 5391.8 5361.8 5388.5 5401.5 5402.3 5403.3 5452.3 5461.7 5469.1 5471.8 5494.4 5144.7 5211.7 5239.7 5342.4 5345.3 5845.4 5883.1 5895.6 5911.3 5961.3 6359.2 6383.4 6416.8 6421.1 6438.7 6216.7 6324.2 6381.6 6432.3 6466.2 5972.8 5981.6 6005.1 6006.2 6016.4 6538.8 6559.9 6589.0 6605.4 6607.2 6139.5 6216.7 6221.6 6336.6 6351.5 6427.4 6462.8 6472.5 6479.0 6490.6 6398.7 6414.3 6415.4 6427.2 6435.4 6109.0 6258.0 6268.4 6435.8 6443.0 4826.4 4849.3 4854.9 4862.7 4882.2 4288.0 4310.3 4310.3 4319.7 4333.3 5906.6 6036.5 6040.8 6127.8 6137.6 6461.1 6471.8 6498.1 6532.8 6534.3 6131.9 6153.8 6156.8 6159.7 6184.6 5394.7 5397.9 5422.6 5503.2 5534.9 6648.0 6648.4 6650.3 6652.4 6654.7 6384.7 6422.9 6442.2 6465.7 6471.5 6318.7 6523.9 6587.1 6683.3 6697.4 6398.9 6401.4 6407.7 6409.2 6432.4 6493.1 6500.8 6513.2 6526.0 6546.0 6142.3 6229.9 6264.0 6391.5 6403.7 6258.7 6290.0 6304.1 6328.1 6344.6 6300.1 6305.1 6308.2 6310.2 6325.4 6041.8 6224.9 6255.2 6356.8 6365.2 6153.5 6164.2 6165.9 6170.3 6184.1 14:42:09 INFO - PROCESS | 26188 | 14:42:09 INFO - PROCESS | 26188 | [#1] ext.html Cycles:180 Average:66058.23 Median:46295.04 stddev:133180.44 (287.7%) stddev-sans-first:133463.30 14:42:09 INFO - PROCESS | 26188 | Values: 578.3 632.4 651.1 668.5 698.8 42129.8 46837.8 47063.0 47188.3 47209.5 46242.3 46324.5 46581.3 46860.3 46917.3 9071.1 9270.2 9276.4 9287.1 9320.5 9117.0 9225.4 9226.8 9238.8 9241.2 9305.1 9314.9 9317.0 9337.9 9344.5 9220.6 9287.9 9296.0 9302.0 9323.5 9214.8 9217.4 9223.5 9280.9 9291.7 45645.5 46005.3 46129.3 46346.0 46378.5 3832.8 3915.0 3936.8 4037.4 4060.4 35229.3 35897.5 36042.5 36349.3 36621.3 4749.7 4769.0 4792.5 4833.4 4907.5 355823.0 358398.0 359523.0 360615.0 360919.0 64054.0 64766.7 64855.4 64939.0 65065.7 36689.8 36967.0 37461.6 37524.8 37581.4 18119.2 18123.8 18170.5 18276.8 18342.3 13897.9 13903.7 13979.5 13988.3 14008.6 21195.2 21402.0 21426.5 21568.1 21755.9 7697.6 7863.0 7883.8 8013.3 8019.6 1033.5 1097.5 1113.7 1132.3 1144.6 34653.5 35021.0 35161.0 35245.5 35441.5 1162.3 1167.8 1185.7 1255.0 1283.9 17873.0 18240.5 18242.8 18696.7 18741.8 609869.0 616410.0 616433.0 617463.0 617484.0 64952.7 65778.3 65839.7 65848.3 65859.7 1425.3 1452.2 1457.6 1464.4 1471.7 32148.8 33872.5 33882.0 33927.8 34819.5 57908.4 58037.7 58302.7 58380.0 58640.0 493115.0 494891.0 494944.0 498003.0 498091.0 31128.2 31619.7 32020.7 32062.5 32067.8 53046.0 53052.5 53698.0 54188.5 54689.5 45904.5 45927.8 47125.0 47530.0 48638.3 46020.8 46120.5 46763.5 47464.9 47517.8 45813.8 46265.5 46838.8 46919.0 49186.5 40048.6 41541.6 41930.0 42771.4 43232.1 30100.8 30387.5 30396.2 30834.2 31130.7 14:42:09 INFO - PROCESS | 26188 | 14:42:09 INFO - PROCESS | 26188 | [#2] jquery.html Cycles:180 Average:29365.72 Median:2121.73 stddev:78410.33 (3695.6%) stddev-sans-first:78600.15 14:42:09 INFO - PROCESS | 26188 | Values: 409.5 414.8 421.0 434.6 447.7 19663.8 21098.2 21303.5 21354.3 21780.3 20255.0 20560.6 20771.7 21021.2 21121.0 5828.0 6037.6 6045.5 6047.3 6048.0 5602.2 5892.9 5931.6 5947.4 5996.8 5880.4 5923.6 5926.7 5935.9 5982.9 5752.2 5833.5 5859.0 5905.8 5933.8 5883.6 6017.6 6048.2 6054.7 6058.1 14574.9 14789.0 15019.9 15173.9 15227.4 2418.4 2480.7 2482.8 2526.4 2597.2 10480.0 10635.8 11154.5 11416.1 11546.9 2052.6 2078.7 2082.7 2105.8 2119.9 87546.6 87784.6 88928.6 92128.1 93049.5 11599.1 11635.3 11660.2 11827.6 11955.5 16793.5 16820.7 16829.2 16879.9 16931.0 8292.9 8298.0 8338.1 8505.1 8631.1 7819.3 7827.6 7969.4 8013.8 8024.4 4968.0 5093.7 5108.6 5114.7 5167.4 2048.5 2109.9 2123.5 2140.5 2167.8 933.2 990.6 1034.3 1041.2 1053.1 20677.0 20744.6 20787.1 20806.4 20908.0 1040.7 1069.9 1081.7 1108.7 1129.9 11414.3 11468.8 11555.1 11654.5 11660.3 410975.0 412950.0 415415.0 547807.0 547849.0 102204.0 102610.5 102712.5 106296.0 106739.0 1069.8 1071.4 1102.0 1110.8 1116.1 18221.2 18510.0 18795.4 18986.6 19108.0 43122.0 44185.9 45648.1 45705.3 45872.1 60143.0 60387.4 63181.0 64167.0 64888.7 9158.2 9322.7 9409.0 9450.4 9452.9 11942.2 12292.2 13967.5 14234.4 14722.4 11776.2 12356.5 12386.8 12587.2 12820.2 11655.1 11693.4 11798.2 12178.0 12339.4 11206.4 11343.4 11945.0 12191.5 12485.0 8856.0 9197.2 9231.3 9286.6 9385.7 9028.4 12154.3 12273.6 12390.9 12676.1 14:42:09 INFO - PROCESS | 26188 | 14:42:09 INFO - PROCESS | 26188 | [#3] mootools.html Cycles:180 Average:6457.66 Median:4810.58 stddev:3711.96 (77.2%) stddev-sans-first:3704.04 14:42:09 INFO - PROCESS | 26188 | Values: 1548.7 1566.2 1750.3 1810.6 1847.0 8652.7 9335.7 9562.7 10074.5 10084.3 9615.9 9682.3 9728.0 9737.5 9749.5 2519.3 2543.6 2550.1 2550.3 2552.8 2487.3 2555.5 2570.5 2573.8 2574.1 2458.0 2489.8 2520.1 2540.6 2541.8 2494.2 2498.4 2502.7 2516.9 2522.2 2454.6 2456.2 2459.8 2470.1 2486.4 9689.7 9735.5 9746.2 9780.0 9781.0 5625.9 5775.8 5860.4 5865.8 5869.1 3495.8 3609.8 3663.4 3665.2 3689.4 1217.9 1237.3 1241.0 1244.2 1269.9 13738.4 13769.8 13779.1 13856.9 13888.7 4970.4 5163.6 5214.2 5248.7 5293.1 11484.2 11503.3 11508.0 11520.0 11641.4 5850.4 5882.4 5885.6 5885.7 5885.9 4731.7 5364.5 5380.5 5403.4 5477.2 4345.4 4353.7 4468.0 4469.3 4472.6 1355.0 1375.3 1375.9 1379.8 1380.3 1017.4 1069.6 1076.1 1083.8 1110.5 6520.4 6787.6 6945.6 7009.2 7093.2 488.7 509.2 509.7 510.7 513.1 4720.4 4785.4 4786.8 4834.3 4834.5 11674.9 12249.8 12254.2 12274.8 12291.5 11418.0 11849.0 12104.8 12207.9 12240.3 8982.6 9019.1 9162.1 9171.8 9200.6 6653.1 6695.6 6797.2 6800.5 6933.6 10859.5 11161.1 11203.4 11278.8 11397.8 11403.7 11557.5 11560.3 11603.5 11673.8 8422.1 8476.6 8668.8 8682.2 8725.5 9693.5 9698.7 9701.7 9738.0 9754.9 8543.0 8560.0 8664.0 8712.5 8755.3 8506.0 8598.1 8600.2 8672.9 8715.4 7688.5 7770.0 7808.6 7810.6 7814.6 5844.2 5860.9 5941.6 5942.5 5974.4 5783.8 5800.8 5818.6 5839.8 5903.2 14:42:09 INFO - PROCESS | 26188 | 14:42:09 INFO - PROCESS | 26188 | [#4] prototype.html Cycles:180 Average:5090.81 Median:5676.61 stddev:1507.73 (26.6%) stddev-sans-first:1469.46 14:42:09 INFO - PROCESS | 26188 | Values: 354.6 366.2 368.7 373.5 380.7 5670.2 5742.6 5862.7 5958.8 6014.8 5716.0 5819.4 5831.8 5838.3 5841.2 4550.3 4563.2 4563.6 4596.7 4599.1 4479.0 4575.4 4580.6 4599.3 4625.2 4534.0 4549.6 4550.7 4586.7 4598.2 4563.6 4575.3 4586.2 4594.8 4610.7 3845.2 3973.7 4009.5 4115.2 4117.4 5675.0 5678.2 5697.3 5698.5 5709.3 5189.7 5190.4 5239.5 5253.9 5271.7 5839.5 6024.6 6031.8 6069.5 6184.7 4334.8 4350.5 4361.7 4364.3 4375.5 6161.8 6363.1 6372.7 6394.7 6398.5 4436.7 4473.8 4477.6 4478.4 4492.1 4537.2 4560.2 4580.0 4583.7 4586.2 5149.3 5208.5 5231.2 5231.5 5262.4 5951.0 6111.0 6113.9 6121.2 6194.5 1560.9 1577.2 1590.4 1592.4 1594.9 961.5 1000.9 1008.9 1012.5 1021.8 5216.6 5270.7 5273.9 5277.7 5362.7 5473.7 5509.7 5540.9 5550.9 5629.0 4944.3 5232.5 5261.8 5282.1 5301.3 2915.5 2939.6 2960.4 2964.6 2969.6 5689.7 5712.7 5718.7 5740.9 5763.5 6025.9 6457.9 6493.3 6527.3 6529.7 6552.7 6595.9 6601.0 6601.3 6617.0 6160.5 6261.4 6309.1 6361.9 6381.1 6296.8 6303.4 6316.2 6366.4 6368.8 6363.2 6458.9 6504.3 6518.6 6612.3 4502.4 4502.8 4522.5 4532.6 4544.3 6115.3 6115.8 6391.7 6425.4 6428.6 6117.8 6159.4 6213.4 6255.7 6271.4 6050.2 6189.5 6190.9 6196.1 6257.0 6035.4 6043.8 6058.8 6096.4 6098.5 6185.1 6225.9 6257.4 6261.9 6278.4 5897.3 6020.3 6048.2 6049.0 6103.0 14:42:09 INFO - PROCESS | 26188 | 14:42:09 INFO - PROCESS | 26188 | [#5] yui.html Cycles:180 Average:21548.94 Median:3967.49 stddev:30741.88 (774.8%) stddev-sans-first:30788.83 14:42:09 INFO - PROCESS | 26188 | Values: 850.9 857.8 861.0 881.6 918.9 16330.6 17805.5 18016.2 18205.1 18223.4 15939.2 16084.9 16087.8 16112.0 16152.8 722.6 854.1 877.8 883.3 883.8 881.7 882.3 882.5 885.1 887.1 932.1 936.4 937.1 937.3 937.6 931.9 933.3 933.5 933.7 934.8 689.2 689.8 690.7 691.3 693.3 15295.2 15393.5 15440.1 15450.6 15455.6 14509.9 14563.3 14588.2 14991.3 15210.4 14597.4 14632.3 14845.9 14884.3 14905.2 4772.2 4825.7 5010.3 5013.9 5022.9 92594.0 93182.0 94019.0 94021.5 94180.5 12380.0 12484.6 12615.6 12639.7 12879.7 22466.6 22511.3 22635.0 22676.7 22743.5 9333.9 9352.3 9436.9 9542.6 9664.6 5111.8 5232.2 5246.3 5274.9 5331.0 3858.7 3912.0 3952.5 3982.5 3997.2 680.7 683.6 693.8 694.2 707.1 744.2 754.7 778.7 793.6 801.7 10303.3 10319.1 10414.7 10559.0 10573.5 707.4 741.1 748.7 770.4 792.6 5172.5 5212.5 5256.5 5329.5 5426.4 65931.0 114463.0 117547.4 120795.4 122262.4 104330.0 106166.5 106249.0 106637.5 108392.5 90436.5 92203.0 93210.5 93798.5 95319.0 9814.2 10429.5 10581.2 10594.4 10657.0 51450.7 52902.7 53012.7 53997.5 54992.5 46216.3 46417.8 48861.3 57619.7 77483.0 12886.5 13235.7 13303.8 13312.0 13555.3 15018.5 15088.0 15287.9 15434.6 15550.8 14294.8 14473.8 14505.4 14763.8 15157.8 13591.7 13629.5 13993.3 14015.7 14741.9 13674.9 13735.5 13886.2 14272.6 14467.9 11310.3 11360.4 11806.0 11977.5 12300.4 11797.7 11857.3 12052.3 12287.4 12311.8 14:42:09 INFO - PROCESS | 26188 | -------- Summary: end -------- 14:42:09 INFO - PROCESS | 26188 | 14:42:09 INFO - TEST-INFO | 26188: exit 0 14:42:09 INFO - TEST-OK | dromaeo_css | took 1110846ms 14:42:09 INFO - TEST-START | kraken 14:42:09 INFO - operating with platform_type : linux_ 14:42:09 INFO - Initialising browser for kraken test... 14:42:09 INFO - TEST-INFO | started process 26451 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDgDxmZ/profile http://localhost:48101/getInfo.html) 14:42:14 INFO - PROCESS | 26451 | __metrics Screen width/height:1600/1200 14:42:14 INFO - PROCESS | 26451 | colorDepth:24 14:42:14 INFO - PROCESS | 26451 | Browser inner width/height: 1024/697 14:42:14 INFO - PROCESS | 26451 | __metrics 14:42:14 ERROR - PROCESS | 26451 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 14:42:15 INFO - TEST-INFO | 26451: exit 0 14:42:15 INFO - Browser initialized. 14:42:15 INFO - Running cycle 1/1 for kraken test... 14:42:15 INFO - TEST-INFO | started process 26575 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDgDxmZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:42:27 INFO - PROCESS | 26575 | RSS: Main: 152940544 14:42:27 INFO - PROCESS | 26575 | 14:42:30 INFO - PROCESS | 26575 | Cycle 1(1): loaded http://localhost:48101/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48101/tests/kraken/driver.html?testName=audio-beat-detection) 14:42:30 INFO - PROCESS | 26575 | RSS: Main: 158109696 14:42:30 INFO - PROCESS | 26575 | 14:42:33 INFO - PROCESS | 26575 | Cycle 1(1): loaded http://localhost:48101/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48101/tests/kraken/driver.html?testName=audio-dft) 14:42:34 INFO - PROCESS | 26575 | RSS: Main: 156499968 14:42:34 INFO - PROCESS | 26575 | 14:42:36 INFO - PROCESS | 26575 | Cycle 1(1): loaded http://localhost:48101/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48101/tests/kraken/driver.html?testName=audio-fft) 14:42:37 INFO - PROCESS | 26575 | RSS: Main: 157085696 14:42:37 INFO - PROCESS | 26575 | 14:42:39 INFO - PROCESS | 26575 | Cycle 1(1): loaded http://localhost:48101/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48101/tests/kraken/driver.html?testName=audio-oscillator) 14:42:40 INFO - PROCESS | 26575 | RSS: Main: 156909568 14:42:40 INFO - PROCESS | 26575 | 14:42:42 INFO - PROCESS | 26575 | Cycle 1(1): loaded http://localhost:48101/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48101/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:42:43 INFO - PROCESS | 26575 | RSS: Main: 156741632 14:42:43 INFO - PROCESS | 26575 | 14:42:46 INFO - PROCESS | 26575 | Cycle 1(1): loaded http://localhost:48101/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48101/tests/kraken/driver.html?testName=imaging-darkroom) 14:42:46 INFO - PROCESS | 26575 | RSS: Main: 155676672 14:42:46 INFO - PROCESS | 26575 | 14:42:50 INFO - PROCESS | 26575 | Cycle 1(1): loaded http://localhost:48101/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48101/tests/kraken/driver.html?testName=imaging-desaturate) 14:42:50 INFO - PROCESS | 26575 | RSS: Main: 156733440 14:42:50 INFO - PROCESS | 26575 | 14:42:53 INFO - PROCESS | 26575 | Cycle 1(1): loaded http://localhost:48101/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48101/tests/kraken/driver.html?testName=json-parse-financial) 14:42:54 INFO - PROCESS | 26575 | RSS: Main: 157945856 14:42:54 INFO - PROCESS | 26575 | 14:42:55 INFO - PROCESS | 26575 | Cycle 1(1): loaded http://localhost:48101/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48101/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:42:56 INFO - PROCESS | 26575 | RSS: Main: 156971008 14:42:56 INFO - PROCESS | 26575 | 14:42:58 INFO - PROCESS | 26575 | Cycle 1(1): loaded http://localhost:48101/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48101/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:42:58 INFO - PROCESS | 26575 | RSS: Main: 156884992 14:42:58 INFO - PROCESS | 26575 | 14:43:00 INFO - PROCESS | 26575 | Cycle 1(1): loaded http://localhost:48101/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48101/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:43:01 INFO - PROCESS | 26575 | RSS: Main: 156823552 14:43:01 INFO - PROCESS | 26575 | 14:43:04 INFO - PROCESS | 26575 | Cycle 1(1): loaded http://localhost:48101/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48101/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:43:04 INFO - PROCESS | 26575 | RSS: Main: 157683712 14:43:04 INFO - PROCESS | 26575 | 14:43:07 INFO - PROCESS | 26575 | Cycle 1(1): loaded http://localhost:48101/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48101/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:43:08 INFO - PROCESS | 26575 | RSS: Main: 157708288 14:43:08 INFO - PROCESS | 26575 | 14:43:09 INFO - PROCESS | 26575 | Cycle 1(1): loaded http://localhost:48101/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48101/tests/kraken/driver.html?testName=ai-astar) 14:43:09 INFO - PROCESS | 26575 | RSS: Main: 158728192 14:43:09 INFO - PROCESS | 26575 | 14:43:09 INFO - PROCESS | 26575 | __start_tp_report 14:43:09 INFO - PROCESS | 26575 | _x_x_mozilla_page_load 14:43:09 INFO - PROCESS | 26575 | _x_x_mozilla_page_load_details 14:43:09 INFO - PROCESS | 26575 | |i|pagename|runs| 14:43:09 INFO - PROCESS | 26575 | |0;ai-astar;100;111;113;111;110;111;110;111;109;110 14:43:09 INFO - PROCESS | 26575 | |1;audio-beat-detection;152;116;148;158;119;142;141;117;174;116 14:43:09 INFO - PROCESS | 26575 | |2;audio-dft;162;161;172;162;162;163;166;161;162;163 14:43:09 INFO - PROCESS | 26575 | |3;audio-fft;75;75;75;181;75;79;76;75;162;76 14:43:09 INFO - PROCESS | 26575 | |4;audio-oscillator;85;87;153;85;85;84;146;83;84;142 14:43:09 INFO - PROCESS | 26575 | |5;imaging-gaussian-blur;118;118;118;117;118;118;118;117;117;117 14:43:09 INFO - PROCESS | 26575 | |6;imaging-darkroom;147;147;148;147;147;147;147;147;148;147 14:43:09 INFO - PROCESS | 26575 | |7;imaging-desaturate;95;95;96;96;95;95;96;96;96;100 14:43:09 INFO - PROCESS | 26575 | |8;json-parse-financial;52;57;51;51;63;52;52;51;54;50 14:43:09 INFO - PROCESS | 26575 | |9;json-stringify-tinderbox;61;59;58;59;58;58;58;59;58;58 14:43:09 INFO - PROCESS | 26575 | |10;stanford-crypto-aes;75;73;73;72;74;82;72;74;72;72 14:43:09 INFO - PROCESS | 26575 | |11;stanford-crypto-ccm;133;121;120;131;121;123;118;117;156;128 14:43:09 INFO - PROCESS | 26575 | |12;stanford-crypto-pbkdf2;156;155;160;161;155;150;156;152;167;151 14:43:09 INFO - PROCESS | 26575 | |13;stanford-crypto-sha256-iterative;62;63;64;62;61;63;61;64;62;61 14:43:09 INFO - PROCESS | 26575 | __end_tp_report 14:43:09 INFO - PROCESS | 26575 | __start_cc_report 14:43:09 INFO - PROCESS | 26575 | _x_x_mozilla_cycle_collect,876 14:43:09 INFO - PROCESS | 26575 | __end_cc_report 14:43:09 INFO - PROCESS | 26575 | __startTimestamp1471988589934__endTimestamp 14:43:09 INFO - PROCESS | 26575 | 14:43:09 INFO - PROCESS | 26575 | ------- Summary: start ------- 14:43:09 INFO - PROCESS | 26575 | Number of tests: 14 14:43:09 INFO - PROCESS | 26575 | 14:43:09 INFO - PROCESS | 26575 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.00 stddev:3.53 (3.2%) stddev-sans-first:1.12 14:43:09 INFO - PROCESS | 26575 | Values: 100.0 111.0 113.0 111.0 110.0 111.0 110.0 111.0 109.0 110.0 14:43:09 INFO - PROCESS | 26575 | 14:43:09 INFO - PROCESS | 26575 | [#1] audio-beat-detection Cycles:10 Average:138.30 Median:145.00 stddev:20.51 (14.1%) stddev-sans-first:21.15 14:43:09 INFO - PROCESS | 26575 | Values: 152.0 116.0 148.0 158.0 119.0 142.0 141.0 117.0 174.0 116.0 14:43:09 INFO - PROCESS | 26575 | 14:43:09 INFO - PROCESS | 26575 | [#2] audio-dft Cycles:10 Average:163.40 Median:162.50 stddev:3.34 (2.1%) stddev-sans-first:3.50 14:43:09 INFO - PROCESS | 26575 | Values: 162.0 161.0 172.0 162.0 162.0 163.0 166.0 161.0 162.0 163.0 14:43:09 INFO - PROCESS | 26575 | 14:43:09 INFO - PROCESS | 26575 | [#3] audio-fft Cycles:10 Average:94.90 Median:75.00 stddev:40.64 (54.2%) stddev-sans-first:42.46 14:43:09 INFO - PROCESS | 26575 | Values: 75.0 75.0 75.0 181.0 75.0 79.0 76.0 75.0 162.0 76.0 14:43:09 INFO - PROCESS | 26575 | 14:43:09 INFO - PROCESS | 26575 | [#4] audio-oscillator Cycles:10 Average:103.40 Median:84.50 stddev:30.22 (35.8%) stddev-sans-first:31.31 14:43:09 INFO - PROCESS | 26575 | Values: 85.0 87.0 153.0 85.0 85.0 84.0 146.0 83.0 84.0 142.0 14:43:09 INFO - PROCESS | 26575 | 14:43:09 INFO - PROCESS | 26575 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 14:43:09 INFO - PROCESS | 26575 | Values: 118.0 118.0 118.0 117.0 118.0 118.0 118.0 117.0 117.0 117.0 14:43:09 INFO - PROCESS | 26575 | 14:43:09 INFO - PROCESS | 26575 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 14:43:09 INFO - PROCESS | 26575 | Values: 147.0 147.0 148.0 147.0 147.0 147.0 147.0 147.0 148.0 147.0 14:43:09 INFO - PROCESS | 26575 | 14:43:09 INFO - PROCESS | 26575 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:1.49 (1.6%) stddev-sans-first:1.54 14:43:09 INFO - PROCESS | 26575 | Values: 95.0 95.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 100.0 14:43:09 INFO - PROCESS | 26575 | 14:43:09 INFO - PROCESS | 26575 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:52.00 stddev:3.95 (7.6%) stddev-sans-first:4.16 14:43:09 INFO - PROCESS | 26575 | Values: 52.0 57.0 51.0 51.0 63.0 52.0 52.0 51.0 54.0 50.0 14:43:09 INFO - PROCESS | 26575 | 14:43:09 INFO - PROCESS | 26575 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:58.50 stddev:0.97 (1.7%) stddev-sans-first:0.50 14:43:09 INFO - PROCESS | 26575 | Values: 61.0 59.0 58.0 59.0 58.0 58.0 58.0 59.0 58.0 58.0 14:43:09 INFO - PROCESS | 26575 | 14:43:09 INFO - PROCESS | 26575 | [#10] stanford-crypto-aes Cycles:10 Average:73.90 Median:73.50 stddev:3.03 (4.1%) stddev-sans-first:3.19 14:43:09 INFO - PROCESS | 26575 | Values: 75.0 73.0 73.0 72.0 74.0 82.0 72.0 74.0 72.0 72.0 14:43:09 INFO - PROCESS | 26575 | 14:43:09 INFO - PROCESS | 26575 | [#11] stanford-crypto-ccm Cycles:10 Average:126.80 Median:125.50 stddev:11.60 (9.2%) stddev-sans-first:12.09 14:43:09 INFO - PROCESS | 26575 | Values: 133.0 121.0 120.0 131.0 121.0 123.0 118.0 117.0 156.0 128.0 14:43:09 INFO - PROCESS | 26575 | 14:43:09 INFO - PROCESS | 26575 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.30 Median:156.00 stddev:5.17 (3.3%) stddev-sans-first:5.48 14:43:09 INFO - PROCESS | 26575 | Values: 156.0 155.0 160.0 161.0 155.0 150.0 156.0 152.0 167.0 151.0 14:43:09 INFO - PROCESS | 26575 | 14:43:09 INFO - PROCESS | 26575 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.50 stddev:1.16 (1.9%) stddev-sans-first:1.22 14:43:09 INFO - PROCESS | 26575 | Values: 62.0 63.0 64.0 62.0 61.0 63.0 61.0 64.0 62.0 61.0 14:43:09 INFO - PROCESS | 26575 | -------- Summary: end -------- 14:43:09 INFO - PROCESS | 26575 | 14:43:10 INFO - TEST-INFO | 26575: exit 0 14:43:10 INFO - TEST-OK | kraken | took 60958ms 14:43:10 INFO - SUITE-END | took 1171s 14:43:11 INFO - Completed test suite (00:19:32) 14:43:11 INFO - javascript benchmark 14:43:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7847.020480041203, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3348.480985447256, 3354.3459025490024, 3380.847861846217, 3388.542546756187, 3414.180596656803, 5885.617434866736, 5948.286205655322, 5990.970045149779, 6015.368386319439, 6059.848503787408, 5936.554758393127, 5986.760529578812, 5997.160397544337, 5997.31030931443, 6018.217631707872, 5374.355077390709, 5411.567074634039, 5471.37079235887, 5488.451154884499, 5490.313710786152, 5293.391260005091, 5316.3620365556, 5348.117560602496, 5371.59713021523, 5391.838244852661, 5361.758720857571, 5388.541973932201, 5401.513863752261, 5402.324709411324, 5403.297571315743, 5452.263944367499, 5461.69960652164, 5469.124940009579, 5471.753771080311, 5494.423085575997, 5144.717040562805, 5211.661242019257, 5239.711815850127, 5342.412334643186, 5345.278387417727, 5845.415458454163, 5883.0881213411985, 5895.587308888379, 5911.320198177222, 5961.284645842483, 6359.173307470046, 6383.39357761012, 6416.839579010562, 6421.101045853584, 6438.710258038353, 6216.658083805389, 6324.177856878622, 6381.617102973836, 6432.260290066655, 6466.191726034246, 5972.790952316648, 5981.641101533922, 6005.099235114768, 6006.159137720722, 6016.398360163992, 6538.771143010067, 6559.901601475982, 6588.967055164693, 6605.405513503808, 6607.2071351438135, 6139.522803442411, 6216.720247588869, 6221.564490485713, 6336.58812177207, 6351.460125889259, 6427.357264273629, 6462.773802916875, 6472.546921715529, 6478.967605161944, 6490.610563366213, 6398.712057957403, 6414.294427612959, 6415.358464153547, 6427.164468619049, 6435.388638079375, 6109.0, 6257.968710156511, 6268.435840774261, 6435.774747883802, 6443.0335449682925, 4826.396700412449, 4849.345338379344, 4854.927176092361, 4862.659613827069, 4882.170031094723, 4288.013756835945, 4310.31035034393, 4310.331898555729, 4319.6976211665515, 4333.306670932699, 5906.5570082244, 6036.486898613667, 6040.788572399945, 6127.816165514952, 6137.5703700741415, 6461.127747753993, 6471.7734879279, 6498.122753428227, 6532.771353002622, 6534.313897040837, 6131.877362452726, 6153.8461538461, 6156.815295541141, 6159.722812473449, 6184.567080304336, 5394.73026348681, 5397.865053373618, 5422.593305502103, 5503.174523821459, 5534.889302213933, 6647.966760166169, 6648.368405001517, 6650.301718319603, 6652.401283884376, 6654.6672666366485, 6384.680765961591, 6422.935770642233, 6442.162518872517, 6465.676716164267, 6471.514636402195, 6318.747250109944, 6523.869522609616, 6587.110740050032, 6683.264840867598, 6697.397234248941, 6398.872022559616, 6401.391867772554, 6407.679616019087, 6409.166808315075, 6432.35676432353, 6493.058506516623, 6500.804975850732, 6513.185851768529, 6525.967370163119, 6545.967270163619, 6142.314611233224, 6229.937700623117, 6263.96868015657, 6391.456726178141, 6403.743850246125, 6258.655773932295, 6290.0, 6304.148939893055, 6328.145700330397, 6344.619322840645, 6300.117983482224, 6305.148804911279, 6308.211473565804, 6310.211223597051, 6325.430711236011, 6041.75832966694, 6224.875502489835, 6255.155554000334, 6356.841078973062, 6365.172527571386, 6153.507719382528, 6164.229471316085, 6165.907511387422, 6170.290416602148, 6184.072389141665], "value": 5893.634684380712, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.3233616668498, 632.3897438971393, 651.0949779806069, 668.4852663449147, 698.8218004408875, 42129.78935105324, 46837.76581117098, 47063.0, 47188.29217561731, 47209.52790472094, 46242.30636540446, 46324.53675463244, 46581.30128048082, 46860.297095543596, 46917.29624055642, 9071.092890710926, 9270.21203197729, 9276.443413395184, 9287.071292870727, 9320.487373194472, 9117.0, 9225.354225204239, 9226.815463690722, 9238.769030774218, 9241.214496767783, 9305.116013978695, 9314.86027709585, 9317.0, 9337.906620933805, 9344.53277336134, 9220.585073671667, 9287.907120928772, 9296.0, 9302.0, 9323.533823308875, 9214.815703685956, 9217.354785165042, 9223.492707901063, 9280.907190928072, 9291.674791382336, 45645.54354456446, 46005.309920351225, 46129.308060379124, 46346.0, 46378.53621463776, 3832.827522761482, 3915.0, 3936.76379417233, 4037.354023356249, 4060.4112403701592, 35229.29541409183, 35897.46153807695, 36042.45936310958, 36349.27301453956, 36621.26757464863, 4749.667523273372, 4769.0, 4792.496787837262, 4833.3958255218095, 4907.509249075064, 355823.0, 358398.0, 359523.0, 360615.0, 360919.0, 64054.0, 64766.67616661887, 64855.35144648493, 64939.0, 65065.67467162728, 36689.81655091707, 36967.0, 37461.62538374636, 37524.812375937945, 37581.43627845585, 18119.18463669138, 18123.818761812214, 18170.45488635343, 18276.817231827776, 18342.266309347742, 13897.861021389657, 13903.652408689864, 13979.510717124851, 13988.300584970711, 14008.649783755487, 21195.152193912378, 21402.0, 21426.464338391666, 21568.137274508845, 21755.891220543795, 7697.576633285223, 7862.960685196537, 7883.763487095396, 8013.278804907586, 8019.639116239783, 1033.503918119307, 1097.4512743628186, 1113.6826004588816, 1132.2810015639964, 1144.5978676121683, 34653.48019779706, 35021.0, 35161.0, 35245.47131793025, 35441.46837797435, 1162.3200427749691, 1167.830664553635, 1185.7213554814612, 1254.956076537317, 1283.9293838838767, 17873.016984066002, 18240.45278641643, 18242.817571824377, 18696.719549206773, 18741.81258187428, 609869.0, 616410.0, 616433.0, 617463.0, 617484.0, 64952.67523662446, 65778.34221657722, 65839.67080164568, 65848.34151658422, 65859.67070164619, 1425.2659880161725, 1452.1795185720034, 1457.628304782295, 1464.3995961655883, 1471.6615178509003, 32148.83925580357, 33872.49191262182, 33882.0, 33927.830360848035, 34819.477707833896, 57908.4209157903, 58037.70981145067, 58302.7084864573, 58380.0, 58640.0, 493115.0, 494891.0, 494944.0, 498003.0, 498091.0, 31128.22179445532, 31619.683803162596, 32020.67979320177, 32062.519062213618, 32067.839660801546, 53046.0, 53052.46947530475, 53698.0, 54188.45811541834, 54689.453105468434, 45904.45389391276, 45927.77036114798, 47125.0, 47530.0, 48638.27042594293, 46020.76989615164, 46120.538794611624, 46763.53236467592, 47464.88294314381, 47517.76241118772, 45813.77093114513, 46265.53734462612, 46838.765806172116, 46919.0, 49186.50813491819, 40048.599514005655, 41541.58458415498, 41930.0, 42771.358429624204, 43232.13535729331, 30100.849495753257, 30387.544186836774, 30396.240093997825, 30834.229144271572, 31130.688693112777], "value": 21677.47827662913, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.469736690985, 414.81748030866396, 420.99368509472356, 434.58931309912134, 447.68214567656963, 19663.803361966377, 21098.156073757033, 21303.467413314655, 21354.25260115896, 21780.346589602337, 20255.0, 20560.588788224264, 20771.688424673604, 21021.159153633835, 21121.0, 5827.999999999989, 6037.637741735488, 6045.546584006195, 6047.304559975593, 6048.0, 5602.2436971009, 5892.852678683024, 5931.584789064746, 5947.434993675594, 5996.790112346069, 5880.4119588041285, 5923.614965027259, 5926.703664816763, 5935.910961335583, 5982.8504287392725, 5752.165935939286, 5833.533317334603, 5859.033259512175, 5905.822825315226, 5933.821985340447, 5883.61756485827, 6017.608855424383, 6048.183495228176, 6054.727537260834, 6058.091286307045, 14574.927125364306, 14789.0, 15019.924900375538, 15173.924130379277, 15227.390904363812, 2418.4316685578874, 2480.6899137607797, 2482.8013758899424, 2526.4441822798954, 2597.168905950097, 10480.0, 10635.840462393071, 11154.498047587878, 11416.086713062936, 11546.94226528862, 2052.6202652509332, 2078.7297651305234, 2082.6563617003176, 2105.768365479796, 2119.925802596917, 87546.5622671889, 87784.56107719484, 88928.55535722345, 92128.07871921262, 93049.53475232581, 11599.130065245141, 11635.301881887113, 11660.242084264495, 11827.586034488751, 11955.52177912891, 16793.496195114167, 16820.74768878468, 16829.158542072848, 16879.91560042192, 16931.0, 8292.917070829335, 8298.04572474161, 8338.124496927856, 8505.064442911274, 8631.050584435707, 7819.257170568787, 7827.569483678339, 7969.442139050211, 8013.839723205503, 8024.438289319692, 4968.0, 5093.745312734349, 5108.591312694975, 5114.693118412907, 5167.431582525919, 2048.457158852905, 2109.873407595549, 2123.543438160772, 2140.4541841830232, 2167.837412194092, 933.206774241889, 990.64336838738, 1034.3225187502198, 1041.245097304448, 1053.104860868271, 20677.0, 20744.58510829805, 20787.06458209384, 20806.375808725763, 20908.0, 1040.7294103532984, 1069.9411532365639, 1081.6971248050559, 1108.6673997800629, 1129.920905536621, 11414.258073225214, 11468.770624587461, 11555.133364997491, 11654.475548600334, 11660.30038197711, 410975.0, 412950.0, 415415.0, 547807.0, 547849.0, 102204.0, 102610.48694756627, 102712.48643756734, 106296.0, 106739.0, 1069.753956589973, 1071.4000159910474, 1101.9724506887392, 1110.7945030169444, 1116.1461481966303, 18221.180046897658, 18510.0, 18795.436136915916, 18986.633633693833, 19108.0, 43122.0, 44185.861082595526, 45648.08703825838, 45705.31442028439, 45872.08255834798, 60143.0, 60387.39612603818, 63181.0, 64167.0, 64888.675556621914, 9158.175764181256, 9322.720318390458, 9409.0, 9450.385724927857, 9452.905470945203, 11942.164048516868, 12292.201006934522, 13967.51113711056, 14234.430622774973, 14722.411103555738, 11776.234544754563, 12356.505739770308, 12386.75226495447, 12587.181833180814, 12820.166689165175, 11655.125865559947, 11693.356865372487, 11798.174127810971, 12178.0, 12339.444724987217, 11206.439678015904, 11343.376114313793, 11945.0, 12191.51233950632, 12485.0, 8856.0, 9197.218236449977, 9231.261499079923, 9286.6285348588, 9385.671501497414, 9028.413153145024, 12154.270743755404, 12273.631791046282, 12390.938045309716, 12676.112672112864], "value": 9637.279574858838, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1548.7212301785678, 1566.1934103936471, 1750.3348727483562, 1810.6378724255153, 1846.9815301846977, 8652.697155599555, 9335.71992840215, 9562.665306714267, 10074.546645400957, 10084.34451760635, 9615.855762163574, 9682.273829462802, 9727.951360243207, 9737.51312434379, 9749.512524373771, 2519.2568192383246, 2543.5548778963607, 2550.0692247329685, 2550.3241640965066, 2552.7830134438595, 2487.3035550046015, 2555.527227462916, 2570.498752743216, 2573.7812285955715, 2574.124797568826, 2458.029078513986, 2489.800815934721, 2520.117958714454, 2540.5554028045112, 2541.7712405883467, 2494.226789695191, 2498.4378514834107, 2502.6621406110125, 2516.874156292178, 2522.205505265835, 2454.5949918263464, 2456.2140115163156, 2459.7909177719916, 2470.0613766768693, 2486.415692312305, 9689.660861869801, 9735.464549449778, 9746.171575416098, 9780.0, 9781.0, 5625.8593535161535, 5775.826725198251, 5860.443257890493, 5865.824025279248, 5869.090291004901, 3495.8426870790877, 3609.819509024538, 3663.377225871608, 3665.2303016366595, 3689.4281386385155, 1217.9208351457128, 1237.3486802937055, 1240.975180496394, 1244.234795600699, 1269.8539667938212, 13738.381772820147, 13769.793453098211, 13779.104358216784, 13856.93071534636, 13888.652783680387, 4970.428400733889, 5163.561097306771, 5214.191800270964, 5248.711320877312, 5293.100172970604, 11484.196106272648, 11503.309801411942, 11507.964283214551, 11520.020798232244, 11641.359725215194, 5850.3564607893095, 5882.441168089024, 5885.588008839341, 5885.676287804126, 5885.941140588625, 4731.716097034189, 5364.544013758874, 5380.488853558905, 5403.378611459654, 5477.20580515823, 4345.413369195118, 4353.673474489426, 4468.039371535136, 4469.262571675637, 4472.619827314715, 1355.0379230746084, 1375.2985977151725, 1375.8624137586162, 1379.834419869622, 1380.2615600653803, 1017.4099022566893, 1069.550788668761, 1076.1229597877705, 1083.7886612110563, 1110.4503270880966, 6520.413162815369, 6787.5588086774205, 6945.617991010442, 7009.1939426966555, 7093.184283807428, 488.6994498383469, 509.15480302697347, 509.6967304453844, 510.6884800271831, 513.1328055586048, 4720.433547974265, 4785.401824771903, 4786.832460863853, 4834.323194752737, 4834.540718631724, 11674.883251167379, 12249.755004899853, 12254.203476774159, 12274.754504909852, 12291.508339666314, 11418.0, 11849.0, 12104.75790484203, 12207.938960305142, 12240.326782027074, 8982.640694372152, 9019.143181397756, 9162.083791620784, 9171.81656366869, 9200.631974720936, 6653.135092437952, 6695.564788288746, 6797.218319893275, 6800.489963252875, 6933.583984960918, 10859.457027148768, 11161.051310638362, 11203.383813890314, 11278.830817537579, 11397.829032564685, 11403.657890263305, 11557.47991340375, 11560.306381616794, 11603.5358585659, 11673.766524669629, 8422.073571906963, 8476.618552165291, 8668.78328041804, 8682.218600326001, 8725.476471411735, 9693.466859322523, 9698.660546881107, 9701.6604418845, 9738.0, 9754.85367719499, 8543.0, 8560.0, 8664.0, 8712.520811355183, 8755.299576034029, 8505.95747021261, 8598.140185981352, 8600.22597966186, 8672.869906951528, 8715.389922705603, 7688.538687678757, 7769.961150194213, 7808.648610812641, 7810.609469526615, 7814.6483408247905, 5844.168754224867, 5860.882782344244, 5941.643501389931, 5942.494887934574, 5974.40255974399, 5783.7975670853, 5800.8259752207505, 5818.6217895836635, 5839.766409343579, 5903.173555702119], "value": 5056.128165793934, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.6187848063331, 366.24553419954896, 368.65346574220223, 373.5200267656061, 380.74109605468306, 5670.177824215486, 5742.626729262595, 5862.73617687204, 5958.79144229952, 6014.759409623615, 5716.0, 5819.4471525205145, 5831.7958871439505, 5838.2702162229725, 5841.15303281024, 4550.271956486963, 4563.178627846986, 4563.566461186182, 4596.678232523725, 4599.057193275387, 4478.955210447886, 4575.428071491064, 4580.610648094916, 4599.264117741145, 4625.167469855424, 4533.9546604534025, 4549.590536851682, 4550.749708766017, 4586.72479651222, 4598.2183028885, 4563.566461186182, 4575.307136359535, 4586.220342541776, 4594.770261486929, 4610.723356598614, 3845.1540661054523, 3973.6821054315587, 4009.5389030261604, 4115.218108559364, 4117.423560701504, 5675.035244008487, 5678.176664383641, 5697.316322041382, 5698.458646428583, 5709.286339207599, 5189.714565698885, 5190.4186111582885, 5239.528442440199, 5253.9492101579835, 5271.683698978073, 5839.503642190419, 6024.608400453956, 6031.849203769897, 6069.544784141163, 6184.721687524072, 4334.804933777988, 4350.499692535367, 4361.694681372305, 4364.345348197764, 4375.453068366454, 6161.784337548209, 6363.140975968277, 6372.7132279047555, 6394.680265986682, 6398.520110991694, 4436.6672499562665, 4473.843415480507, 4477.641788656965, 4478.41780568524, 4492.124035812985, 4537.160625284333, 4560.156371071363, 4579.95420045802, 4583.72497650142, 4586.19741545235, 5149.253358263031, 5208.5312321891215, 5231.163013917755, 5231.503007214308, 5262.421133675292, 5950.958582248089, 6111.0, 6113.877722445526, 6121.204243448323, 6194.5044396448175, 1560.9063456192437, 1577.2350410051115, 1590.363854458226, 1592.371013449681, 1594.9043057416593, 961.5240455974338, 1000.949952502372, 1008.8890222075565, 1012.5139932832135, 1021.8211812932856, 5216.58267338612, 5270.683758974474, 5273.947260527422, 5277.683338999673, 5362.65142765719, 5473.698946557977, 5509.724513774376, 5540.9168862467095, 5550.888982220414, 5628.973569514971, 4944.283078953532, 5232.476752324737, 5261.789528418897, 5282.075636763551, 5301.3373328333955, 2915.5189393749793, 2939.6325459317586, 2960.378320552665, 2964.5770030385106, 2969.584258203853, 5689.687067211343, 5712.714364281769, 5718.68547229898, 5740.875875925934, 5763.4812866842185, 6025.909611355745, 6457.903131453032, 6493.31820158886, 6527.3472652734345, 6529.738810447624, 6552.705128269239, 6595.868082638416, 6601.0, 6601.3068627794355, 6617.04052912325, 6160.537959652955, 6261.373862613702, 6309.1167236587835, 6361.936380636134, 6381.085674297599, 6296.779612713533, 6303.432691057827, 6316.242050953915, 6366.427021568081, 6368.808935731936, 6363.236411630449, 6458.870822583616, 6504.317046710027, 6518.641474718746, 6612.305707900794, 4502.3921770560555, 4502.7523486207265, 4522.479914809707, 4532.592066714012, 4544.272916333371, 6115.296740874678, 6115.785947491817, 6391.744330226739, 6425.421712045938, 6428.5571482838095, 6117.755289788537, 6159.353267906805, 6213.37866213375, 6255.655938923403, 6271.43557079865, 6050.15297858309, 6189.535784816067, 6190.876182476415, 6196.0705894116245, 6256.968715156395, 6035.39646035393, 6043.8186854394435, 6058.757649693963, 6096.390360963868, 6098.451139397475, 6185.103160041679, 6225.937740622536, 6257.374262573706, 6261.870963872305, 6278.4035516625845, 5897.321807992136, 6020.314311992649, 6048.213732214784, 6049.001914684028, 6102.993006154113], "value": 4610.932454747638, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [850.8851305073813, 857.8198578298557, 861.0356400831071, 881.6076845803618, 918.9172974432299, 16330.591735206612, 17805.465836024923, 18016.18927148278, 18205.089745512705, 18223.36218232362, 15939.203039848018, 16084.919575402108, 16087.793415493856, 16112.0, 16152.83847161528, 722.5809030762158, 854.0647990450447, 877.7805548612815, 883.3110174064208, 883.8453270677605, 881.6561540999015, 882.3117967984982, 882.4749274181852, 885.0883589902411, 887.1040249348173, 932.0818993291603, 936.4381371177308, 937.1378331934602, 937.3063932689795, 937.5546615357719, 931.9301052421096, 933.2580598424236, 933.4539294512718, 933.7152168588577, 934.8223837470858, 689.2246222999127, 689.7896141676787, 690.7340673840557, 691.3086913086913, 693.2582137113291, 15295.15876626785, 15393.461228857048, 15440.073595584188, 15450.613734656612, 15455.61360965985, 14509.92745036268, 14563.271836408137, 14588.197649129293, 14991.325390357351, 15210.391584336614, 14597.416103355854, 14632.341544630517, 14845.851541484555, 14884.330205140795, 14905.180215088165, 4772.2125849234835, 4825.662203645747, 5010.2735103409805, 5013.949860501385, 5022.874428139289, 92594.0, 93182.0, 94019.0, 94021.52989235078, 94180.52909735407, 12380.0, 12484.625461236177, 12615.621531354074, 12639.653658925732, 12879.678008049686, 22466.55066898653, 22511.32466026022, 22635.0, 22676.65985010226, 22743.545129097325, 9333.90666093344, 9352.251819854395, 9436.90563094374, 9542.570584323723, 9664.613415463302, 5111.821086262037, 5232.215167724796, 5246.291750613618, 5274.865903830695, 5330.973345133327, 3858.7298889077497, 3912.041549820255, 3952.5256969163884, 3982.4623675803396, 3997.2205419942834, 680.7209044291817, 683.6308393467572, 693.8022663540867, 694.2224708326706, 707.0525495835604, 744.244591739385, 754.6792613139504, 778.70020042283, 793.5596891641652, 801.7354273089867, 10303.330283531546, 10319.122874555596, 10414.68755937308, 10558.993791179651, 10573.52419141125, 707.3563057617544, 741.1217707017202, 748.6705849426235, 770.3567521119816, 792.6195426195343, 5172.5344718975475, 5212.50481204285, 5256.474352564713, 5329.520343169133, 5426.403095659474, 65931.0, 114463.0, 117547.41226293813, 120795.39602301932, 122262.38868805599, 104330.0, 106166.46916765522, 106249.0, 106637.46681266544, 108392.45803770931, 90436.5478172618, 92202.99999999866, 93210.53394733119, 93798.53100734453, 95319.0, 9814.153895370262, 10429.478526073817, 10581.15350771921, 10594.417307048187, 10657.0, 51450.74274628603, 52902.735486323865, 53012.73493632507, 53997.49016313927, 54992.45007549873, 46216.30675539802, 46417.76791116158, 48861.26708099453, 57619.71190144023, 77483.0, 12886.484540618645, 13235.735285294433, 13303.800442993557, 13312.0, 13555.254461004739, 15018.549443516711, 15088.0, 15287.923560382127, 15434.614134646723, 15550.766738498705, 14294.785578216128, 14473.782893256399, 14505.419783208554, 14763.778543321643, 15157.848421516084, 13591.660208494866, 13629.522966696119, 13993.300334983007, 14015.719685606435, 14741.852581474048, 13674.93162534181, 13735.45058197661, 13886.236257005961, 14272.571822845332, 14467.85532144665, 11310.264832785842, 11360.431978401211, 11806.0, 11977.461014254206, 12300.446479908605, 11797.705057373634, 11857.288562686266, 12052.28550428099, 12287.44706488228, 12311.753764924471], "value": 8132.709539297523, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1501.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 111.0, 113.0, 111.0, 110.0, 111.0, 110.0, 111.0, 109.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 116.0, 148.0, 158.0, 119.0, 142.0, 141.0, 117.0, 174.0, 116.0], "value": 138.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 172.0, 162.0, 162.0, 163.0, 166.0, 161.0, 162.0, 163.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 181.0, 75.0, 79.0, 76.0, 75.0, 162.0, 76.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 153.0, 85.0, 85.0, 84.0, 146.0, 83.0, 84.0, 142.0], "value": 103.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 100.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 57.0, 51.0, 51.0, 63.0, 52.0, 52.0, 51.0, 54.0, 50.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 58.0, 59.0, 58.0, 58.0, 58.0, 59.0, 58.0, 58.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 73.0, 72.0, 74.0, 82.0, 72.0, 74.0, 72.0, 72.0], "value": 73.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 121.0, 120.0, 131.0, 121.0, 123.0, 118.0, 117.0, 156.0, 128.0], "value": 126.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 155.0, 160.0, 161.0, 155.0, 150.0, 156.0, 152.0, 167.0, 151.0], "value": 156.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 64.0, 62.0, 61.0, 63.0, 61.0, 64.0, 62.0, 61.0], "value": 62.3, "unit": "score"}]}]} 14:43:11 INFO - Return code: 0 14:43:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:43:11 ERROR - # TBPL SUCCESS # 14:43:11 INFO - Running post-action listener: _resource_record_post_action 14:43:11 INFO - [mozharness: 2016-08-23 21:43:11.228127Z] Finished run-tests step (success) 14:43:11 INFO - Running post-run listener: _resource_record_post_run 14:43:11 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 270336; Write bytes: 326930432; Read time: 48; Write time: 221776 14:43:11 INFO - TinderboxPrint: CPU usage
13.3% 14:43:11 INFO - TinderboxPrint: I/O read bytes / time
270,336 / 48 14:43:11 INFO - TinderboxPrint: I/O write bytes / time
326,930,432 / 221,776 14:43:11 INFO - TinderboxPrint: CPU idle
8,227.6 (86.7%) 14:43:11 INFO - TinderboxPrint: CPU user
1,200.9 (12.7%) 14:43:11 INFO - TinderboxPrint: Swap in / out
0 / 0 14:43:11 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 77332480; Read time: 0; Write time: 54252 14:43:11 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 266240; Write bytes: 247017472; Read time: 28; Write time: 167188 14:43:11 INFO - Running post-run listener: _upload_blobber_files 14:43:11 INFO - Blob upload gear active. 14:43:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:43:11 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 14:43:11 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:43:11 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:43:12 INFO - (blobuploader) - INFO - Open directory for files ... 14:43:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:43:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:43:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:43:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:43:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:43:12 INFO - (blobuploader) - INFO - Done attempting. 14:43:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:43:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:43:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:43:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:43:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:43:13 INFO - (blobuploader) - INFO - Done attempting. 14:43:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:43:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:43:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:43:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:43:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:43:17 INFO - (blobuploader) - INFO - Done attempting. 14:43:17 INFO - (blobuploader) - INFO - Iteration through files over. 14:43:17 INFO - Return code: 0 14:43:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:43:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:43:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b31b6de63002464e3dd6765a3c38f456eb4fd71f3a90c7f6ba06b4b52027445f4e7dfa460d2b27d5be02cfcb0572206855808670c4cf71bbfbcf81cc9b45408d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/969dde4a00f35c2a65f5440b9233b8e8d5f0180836752c10da59ad26cd809b82d39737739a163cc67e3f938a0f572d73040bd9cb53dacb10ec1eef6083fee91a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7383c0c8441944351632372a773447b030dbbee37ecc4e79b411253212fa9579d06c252ae34de7050fd2aa7c1f46bc2f32c10850e52a04ebfe3696c783c9da45"} 14:43:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:43:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:43:17 INFO - Contents: 14:43:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b31b6de63002464e3dd6765a3c38f456eb4fd71f3a90c7f6ba06b4b52027445f4e7dfa460d2b27d5be02cfcb0572206855808670c4cf71bbfbcf81cc9b45408d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/969dde4a00f35c2a65f5440b9233b8e8d5f0180836752c10da59ad26cd809b82d39737739a163cc67e3f938a0f572d73040bd9cb53dacb10ec1eef6083fee91a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7383c0c8441944351632372a773447b030dbbee37ecc4e79b411253212fa9579d06c252ae34de7050fd2aa7c1f46bc2f32c10850e52a04ebfe3696c783c9da45"} 14:43:17 INFO - Running post-run listener: copy_logs_to_upload_dir 14:43:17 INFO - Copying logs to upload dir... 14:43:17 INFO - mkdir: /builds/slave/test/build/upload/logs 14:43:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1676.714689 ========= master_lag: 0.14 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 56 secs) (at 2016-08-23 14:43:17.153871) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-08-23 14:43:17.157396) ========= 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=c6927cf182745ad25b1d38b9000001fe-1471986918.139483-489443446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b31b6de63002464e3dd6765a3c38f456eb4fd71f3a90c7f6ba06b4b52027445f4e7dfa460d2b27d5be02cfcb0572206855808670c4cf71bbfbcf81cc9b45408d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/969dde4a00f35c2a65f5440b9233b8e8d5f0180836752c10da59ad26cd809b82d39737739a163cc67e3f938a0f572d73040bd9cb53dacb10ec1eef6083fee91a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7383c0c8441944351632372a773447b030dbbee37ecc4e79b411253212fa9579d06c252ae34de7050fd2aa7c1f46bc2f32c10850e52a04ebfe3696c783c9da45"} build_url:https://queue.taskcluster.net/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011232 build_url: 'https://queue.taskcluster.net/v1/task/VpHdSUSORsyv12rwXfivJg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b31b6de63002464e3dd6765a3c38f456eb4fd71f3a90c7f6ba06b4b52027445f4e7dfa460d2b27d5be02cfcb0572206855808670c4cf71bbfbcf81cc9b45408d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/969dde4a00f35c2a65f5440b9233b8e8d5f0180836752c10da59ad26cd809b82d39737739a163cc67e3f938a0f572d73040bd9cb53dacb10ec1eef6083fee91a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7383c0c8441944351632372a773447b030dbbee37ecc4e79b411253212fa9579d06c252ae34de7050fd2aa7c1f46bc2f32c10850e52a04ebfe3696c783c9da45"}' ========= master_lag: 1.37 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-08-23 14:43:18.542526) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-08-23 14:43:18.542895) ========= 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=c6927cf182745ad25b1d38b9000001fe-1471986918.139483-489443446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004130 ========= master_lag: 1.90 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-08-23 14:43:20.450614) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 14:43:20.451008) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 14:43:20.451616) ========= ========= Total master_lag: 3.48 =========