builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-061 starttime: 1473072430.09 results: success (0) buildid: 20160905004005 builduid: 3a1616e5d74b4eb0b9c280f2cbfa2dbb revision: 2231ab09a51c3b21dae6fa1627c1a64cfd43b3b0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-05 03:47:10.087292) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-05 03:47:10.087708) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-05 03:47:10.087977) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-05 03:47:10.121837) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-05 03:47:10.122240) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1473050667.566228-638762353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-05 03:47:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.2M=0s 2016-09-05 03:47:11 (40.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116121 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-05 03:47:10.251738) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-05 03:47:10.252017) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1473050667.566228-638762353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014780 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-05 03:47:10.301183) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-05 03:47:10.301524) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2231ab09a51c3b21dae6fa1627c1a64cfd43b3b0 --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 2231ab09a51c3b21dae6fa1627c1a64cfd43b3b0 --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=516f8d7ca085b4d087ab0a71000001a4-1473050667.566228-638762353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-05 03:47:11,891 truncating revision to first 12 chars 2016-09-05 03:47:11,891 Setting DEBUG logging. 2016-09-05 03:47:11,891 attempt 1/10 2016-09-05 03:47:11,891 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2231ab09a51c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-05 03:47:12,242 unpacking tar archive at: mozilla-aurora-2231ab09a51c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.699650 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-05 03:47:11.013995) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-05 03:47:11.014284) ========= script_repo_revision: 2231ab09a51c3b21dae6fa1627c1a64cfd43b3b0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-05 03:47:11.014644) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-05 03:47:11.014900) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-05 03:47:11.024187) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 0 secs) (at 2016-09-05 03:47:11.024443) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1473050667.566228-638762353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:47:12 INFO - MultiFileLogger online at 20160905 03:47:12 in /builds/slave/test 03:47:12 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 03:47:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:47:12 INFO - {'append_to_log': False, 03:47:12 INFO - 'base_work_dir': '/builds/slave/test', 03:47:12 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:47:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:47:12 INFO - 'branch': 'Mozilla-Aurora', 03:47:12 INFO - 'buildbot_json_path': 'buildprops.json', 03:47:12 INFO - 'config_files': ('talos/linux_config.py',), 03:47:12 INFO - 'default_actions': ('clobber', 03:47:12 INFO - 'read-buildbot-config', 03:47:12 INFO - 'download-and-extract', 03:47:12 INFO - 'populate-webroot', 03:47:12 INFO - 'create-virtualenv', 03:47:12 INFO - 'install', 03:47:12 INFO - 'run-tests'), 03:47:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:47:12 INFO - 'download_minidump_stackwalk': True, 03:47:12 INFO - 'download_symbols': 'ondemand', 03:47:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:47:12 INFO - 'tooltool.py': '/tools/tooltool.py', 03:47:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:47:12 INFO - '/tools/misc-python/virtualenv.py')}, 03:47:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:47:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:47:12 INFO - 'installer_path': 'installer.exe', 03:47:12 INFO - 'log_level': 'info', 03:47:12 INFO - 'log_name': 'talos', 03:47:12 INFO - 'log_to_console': True, 03:47:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:47:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:47:12 INFO - 'opt_config_files': (), 03:47:12 INFO - 'pip_index': False, 03:47:12 INFO - 'sps_profile': False, 03:47:12 INFO - 'sps_profile_interval': 0, 03:47:12 INFO - 'suite': 'dromaeojs-e10s', 03:47:12 INFO - 'system_bits': '32', 03:47:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:47:12 INFO - 'title': 'talos-linux64-ix-061', 03:47:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:47:12 INFO - 'use_talos_json': True, 03:47:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:47:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:47:12 INFO - 'work_dir': 'build'} 03:47:12 INFO - [mozharness: 2016-09-05 10:47:12.709689Z] Running clobber step. 03:47:12 INFO - Running pre-action listener: _resource_record_pre_action 03:47:12 INFO - Running main action method: clobber 03:47:12 INFO - rmtree: /builds/slave/test/build 03:47:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:47:13 INFO - Running post-action listener: _resource_record_post_action 03:47:13 INFO - [mozharness: 2016-09-05 10:47:13.174726Z] Finished clobber step (success) 03:47:13 INFO - [mozharness: 2016-09-05 10:47:13.174827Z] Running read-buildbot-config step. 03:47:13 INFO - Running pre-action listener: _resource_record_pre_action 03:47:13 INFO - Running main action method: read_buildbot_config 03:47:13 INFO - Using buildbot properties: 03:47:13 INFO - { 03:47:13 INFO - "project": "", 03:47:13 INFO - "product": "firefox", 03:47:13 INFO - "script_repo_revision": "production", 03:47:13 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:47:13 INFO - "repository": "", 03:47:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:47:13 INFO - "buildid": "20160905004005", 03:47:13 INFO - "stage_platform": "linux64-pgo", 03:47:13 INFO - "basedir": "/builds/slave/test", 03:47:13 INFO - "nightly_build": "True", 03:47:13 INFO - "buildnumber": 535, 03:47:13 INFO - "slavename": "talos-linux64-ix-061", 03:47:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:47:13 INFO - "platform": "ubuntu64_hw", 03:47:13 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:47:13 INFO - "branch": "mozilla-aurora", 03:47:13 INFO - "repo_path": "releases/mozilla-aurora", 03:47:13 INFO - "revision": "2231ab09a51c3b21dae6fa1627c1a64cfd43b3b0", 03:47:13 INFO - "pgo_build": "True", 03:47:13 INFO - "builduid": "3a1616e5d74b4eb0b9c280f2cbfa2dbb", 03:47:13 INFO - "slavebuilddir": "test" 03:47:13 INFO - } 03:47:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 03:47:13 INFO - Running post-action listener: _resource_record_post_action 03:47:13 INFO - [mozharness: 2016-09-05 10:47:13.177338Z] Finished read-buildbot-config step (success) 03:47:13 INFO - [mozharness: 2016-09-05 10:47:13.177497Z] Running download-and-extract step. 03:47:13 INFO - Running pre-action listener: _resource_record_pre_action 03:47:13 INFO - Running main action method: download_and_extract 03:47:13 INFO - mkdir: /builds/slave/test/build/tests 03:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:13 INFO - https://queue.taskcluster.net/v1/task/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:47:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:47:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:47:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/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 03:47:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/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 03:47:13 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:47:13 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:47:13 INFO - retry: Failed, sleeping 30 seconds before retrying 03:47:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/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 03:47:43 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:47:43 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:47:43 INFO - retry: Failed, sleeping 60 seconds before retrying 03:48:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/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 03:48:43 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:48:43 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:48:43 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/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! 03:48:43 INFO - Caught exception: HTTP Error 404: Not Found 03:48:43 INFO - Caught exception: HTTP Error 404: Not Found 03:48:43 INFO - Caught exception: HTTP Error 404: Not Found 03:48:43 INFO - trying https://queue.taskcluster.net/v1/task/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:48:43 INFO - Downloading https://queue.taskcluster.net/v1/task/P5W6lwchRVCbF2--E2Ac5g/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 03:48:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P5W6lwchRVCbF2--E2Ac5g/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 03:48:43 INFO - Downloaded 1361 bytes. 03:48:43 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:48:43 INFO - Using the following test package requirements: 03:48:43 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:48:43 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:48:43 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:48:43 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:48:43 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:48:43 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:48:43 INFO - u'jsshell-linux-x86_64.zip'], 03:48:43 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:48:43 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:48:43 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:48:43 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:48:43 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:48:43 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:48:43 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:48:43 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:48:43 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:48:43 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:48:43 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:48:43 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:48:43 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')]} 03:48:43 INFO - https://queue.taskcluster.net/v1/task/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:48:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:48:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:48:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/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 03:48:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/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 03:48:43 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:48:43 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:48:43 INFO - retry: Failed, sleeping 30 seconds before retrying 03:49:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/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 03:49:13 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:49:13 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:49:13 INFO - retry: Failed, sleeping 60 seconds before retrying 03:50:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/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 03:50:13 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:50:13 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:50:13 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/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! 03:50:13 INFO - Caught exception: HTTP Error 404: Not Found 03:50:13 INFO - Caught exception: HTTP Error 404: Not Found 03:50:13 INFO - Caught exception: HTTP Error 404: Not Found 03:50:13 INFO - trying https://queue.taskcluster.net/v1/task/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:50:13 INFO - Downloading https://queue.taskcluster.net/v1/task/P5W6lwchRVCbF2--E2Ac5g/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 03:50:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P5W6lwchRVCbF2--E2Ac5g/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 03:50:16 INFO - Downloaded 21770712 bytes. 03:50:16 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'] 03:50:16 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 03:50:17 INFO - Return code: 0 03:50:17 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 03:50: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')]} 03:50:17 INFO - https://queue.taskcluster.net/v1/task/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:50:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:50:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:50:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/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 03:50:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/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 03:50:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:50:17 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:50:17 INFO - retry: Failed, sleeping 30 seconds before retrying 03:50:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/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 03:50:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:50:47 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:50:47 INFO - retry: Failed, sleeping 60 seconds before retrying 03:51:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/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 03:51:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:51:47 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:51:47 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/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! 03:51:47 INFO - Caught exception: HTTP Error 404: Not Found 03:51:47 INFO - Caught exception: HTTP Error 404: Not Found 03:51:47 INFO - Caught exception: HTTP Error 404: Not Found 03:51:47 INFO - trying https://queue.taskcluster.net/v1/task/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:51:47 INFO - Downloading https://queue.taskcluster.net/v1/task/P5W6lwchRVCbF2--E2Ac5g/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 03:51:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P5W6lwchRVCbF2--E2Ac5g/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 03:51:48 INFO - Downloaded 21770712 bytes. 03:51:48 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'] 03:51:48 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 03:51:49 INFO - Return code: 0 03:51:49 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')]} 03:51:49 INFO - https://queue.taskcluster.net/v1/task/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:51:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:51:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:51:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/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 03:51:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/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 03:51:49 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:51:49 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:51:49 INFO - retry: Failed, sleeping 30 seconds before retrying 03:52:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/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 03:52:19 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:52:19 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:52:19 INFO - retry: Failed, sleeping 60 seconds before retrying 03:53:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/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 03:53:19 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:53:19 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:53:19 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/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! 03:53:19 INFO - Caught exception: HTTP Error 404: Not Found 03:53:19 INFO - Caught exception: HTTP Error 404: Not Found 03:53:19 INFO - Caught exception: HTTP Error 404: Not Found 03:53:19 INFO - trying https://queue.taskcluster.net/v1/task/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:53:19 INFO - Downloading https://queue.taskcluster.net/v1/task/P5W6lwchRVCbF2--E2Ac5g/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 03:53:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P5W6lwchRVCbF2--E2Ac5g/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 03:53:21 INFO - Downloaded 14413740 bytes. 03:53:21 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'] 03:53:21 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 03:53:21 INFO - Return code: 0 03:53: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')]} 03:53:21 INFO - https://queue.taskcluster.net/v1/task/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:53:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:53:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:53:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/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 03:53:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/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 03:53:21 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:53:21 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:53:21 INFO - retry: Failed, sleeping 30 seconds before retrying 03:53:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/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 03:53:51 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:53:51 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:53:51 INFO - retry: Failed, sleeping 60 seconds before retrying 03:54:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/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 03:54:52 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:54:52 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:54:52 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5W6lwchRVCbF2--E2Ac5g/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! 03:54:52 INFO - Caught exception: HTTP Error 404: Not Found 03:54:52 INFO - Caught exception: HTTP Error 404: Not Found 03:54:52 INFO - Caught exception: HTTP Error 404: Not Found 03:54:52 INFO - trying https://queue.taskcluster.net/v1/task/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:54:52 INFO - Downloading https://queue.taskcluster.net/v1/task/P5W6lwchRVCbF2--E2Ac5g/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 03:54:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P5W6lwchRVCbF2--E2Ac5g/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 03:54:53 INFO - Downloaded 63883986 bytes. 03:54:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:54:53 INFO - mkdir: /builds/slave/test/properties 03:54:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:54:53 INFO - Writing to file /builds/slave/test/properties/build_url 03:54:53 INFO - Contents: 03:54:53 INFO - build_url:https://queue.taskcluster.net/v1/task/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:54:54 INFO - Running post-action listener: _resource_record_post_action 03:54:54 INFO - Running post-action listener: set_extra_try_arguments 03:54:54 INFO - [mozharness: 2016-09-05 10:54:54.088872Z] Finished download-and-extract step (success) 03:54:54 INFO - [mozharness: 2016-09-05 10:54:54.089104Z] Running populate-webroot step. 03:54:54 INFO - Running pre-action listener: _resource_record_pre_action 03:54:54 INFO - Running main action method: populate_webroot 03:54:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:54:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:54:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:54:54 INFO - '--tppagecycles', 03:54:54 INFO - '7'], 03:54:54 INFO - 'tests': ['tsvgm']}}, 03:54:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:54:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:54:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:54:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:54:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:54:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:54:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:54:54 INFO - 'talos_options': ['--disable-e10s'], 03:54:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:54:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:54:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:54:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:54:54 INFO - 'talos_options': ['--disable-e10s'], 03:54:54 INFO - 'tests': ['damp', 'tps']}, 03:54:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:54:54 INFO - 'tests': ['damp', 'tps']}, 03:54:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:54:54 INFO - 'tests': ['dromaeo_dom']}, 03:54:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:54:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:54:54 INFO - 'tests': ['basic_compositor_video']}, 03:54:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:54:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:54:54 INFO - 'tests': ['a11yr', 03:54:54 INFO - 'ts_paint', 03:54:54 INFO - 'tpaint', 03:54:54 INFO - 'sessionrestore', 03:54:54 INFO - 'sessionrestore_no_auto_restore', 03:54:54 INFO - 'tabpaint']}, 03:54:54 INFO - 'other-e10s': {'tests': ['a11yr', 03:54:54 INFO - 'ts_paint', 03:54:54 INFO - 'tpaint', 03:54:54 INFO - 'sessionrestore', 03:54:54 INFO - 'sessionrestore_no_auto_restore', 03:54:54 INFO - 'tabpaint']}, 03:54:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:54:54 INFO - 'ts_paint', 03:54:54 INFO - 'tpaint', 03:54:54 INFO - 'sessionrestore', 03:54:54 INFO - 'sessionrestore_no_auto_restore', 03:54:54 INFO - 'tabpaint']}, 03:54:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:54:54 INFO - 'ts_paint', 03:54:54 INFO - 'tpaint', 03:54:54 INFO - 'sessionrestore', 03:54:54 INFO - 'sessionrestore_no_auto_restore', 03:54:54 INFO - 'tabpaint']}, 03:54:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:54:54 INFO - 'tests': ['a11yr', 03:54:54 INFO - 'ts_paint', 03:54:54 INFO - 'tpaint', 03:54:54 INFO - 'sessionrestore', 03:54:54 INFO - 'sessionrestore_no_auto_restore', 03:54:54 INFO - 'tabpaint']}, 03:54:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:54:54 INFO - 'tests': ['a11yr', 03:54:54 INFO - 'ts_paint', 03:54:54 INFO - 'tpaint', 03:54:54 INFO - 'sessionrestore', 03:54:54 INFO - 'sessionrestore_no_auto_restore', 03:54:54 INFO - 'tabpaint']}, 03:54:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:54:54 INFO - 'tests': ['tsvgx', 03:54:54 INFO - 'tsvgr_opacity', 03:54:54 INFO - 'tart', 03:54:54 INFO - 'tscrollx', 03:54:54 INFO - 'cart']}, 03:54:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:54:54 INFO - 'tsvgr_opacity', 03:54:54 INFO - 'tart', 03:54:54 INFO - 'tscrollx', 03:54:54 INFO - 'cart']}, 03:54:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:54:54 INFO - 'talos_options': ['--disable-e10s'], 03:54:54 INFO - 'tests': ['tp5o']}, 03:54:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:54:54 INFO - 'tests': ['tp5o']}, 03:54:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:54:54 INFO - 'talos_options': ['--disable-e10s', 03:54:54 INFO - '--xperf_path', 03:54:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:54:54 INFO - 'tests': ['tp5n']}, 03:54:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:54:54 INFO - 'talos_options': ['--xperf_path', 03:54:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:54:54 INFO - 'tests': ['tp5n']}}, 03:54:54 INFO - 'talos.zip': {'path': '', 03:54:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:54:54 INFO - Running post-action listener: _resource_record_post_action 03:54:54 INFO - [mozharness: 2016-09-05 10:54:54.107666Z] Finished populate-webroot step (success) 03:54:54 INFO - [mozharness: 2016-09-05 10:54:54.107755Z] Running create-virtualenv step. 03:54:54 INFO - Running pre-action listener: _resource_record_pre_action 03:54:54 INFO - Running main action method: create_virtualenv 03:54:54 INFO - Creating virtualenv /builds/slave/test/build/venv 03:54:54 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 03:54:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:54:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:54:54 INFO - Using real prefix '/usr' 03:54:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:54:54 INFO - Installing distribute.............................................................................................................................................................................................done. 03:54:56 INFO - Installing pip.................done. 03:54:56 INFO - Return code: 0 03:54:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:54: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')]} 03:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54: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')]} 03:54:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54:56 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 0x182f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a5e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aed570>, '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 0x1aee470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aee900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1473050667.566228-638762353', '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 03:54:56 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 03:54:56 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 03:54:56 INFO - Using env: {'DISPLAY': ':0', 03:54:56 INFO - 'HOME': '/home/cltbld', 03:54:56 INFO - 'LANG': 'en_US.UTF-8', 03:54:56 INFO - 'LANGUAGE': 'en_US:en', 03:54:56 INFO - 'LOGNAME': 'cltbld', 03:54:56 INFO - 'MAIL': '/var/mail/cltbld', 03:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:56 INFO - 'MOZ_NO_REMOTE': '1', 03:54:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:54:56 INFO - 'NO_EM_RESTART': '1', 03:54:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:56 INFO - 'PWD': '/builds/slave/test', 03:54:56 INFO - 'SHELL': '/bin/bash', 03:54:56 INFO - 'SHLVL': '1', 03:54:56 INFO - 'TERM': 'linux', 03:54:56 INFO - 'TMOUT': '86400', 03:54:56 INFO - 'USER': 'cltbld', 03:54:56 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1473050667.566228-638762353', 03:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:56 INFO - '_': '/tools/buildbot/bin/python'} 03:54:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:56 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 03:54:56 INFO - Cleaning up... 03:54:56 INFO - Return code: 0 03:54:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:54: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')]} 03:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54: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')]} 03:54:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54:56 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 0x182f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a5e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aed570>, '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 0x1aee470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aee900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1473050667.566228-638762353', '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 03:54:56 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 03:54:56 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 03:54:56 INFO - Using env: {'DISPLAY': ':0', 03:54:56 INFO - 'HOME': '/home/cltbld', 03:54:56 INFO - 'LANG': 'en_US.UTF-8', 03:54:56 INFO - 'LANGUAGE': 'en_US:en', 03:54:56 INFO - 'LOGNAME': 'cltbld', 03:54:56 INFO - 'MAIL': '/var/mail/cltbld', 03:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:56 INFO - 'MOZ_NO_REMOTE': '1', 03:54:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:54:56 INFO - 'NO_EM_RESTART': '1', 03:54:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:56 INFO - 'PWD': '/builds/slave/test', 03:54:56 INFO - 'SHELL': '/bin/bash', 03:54:56 INFO - 'SHLVL': '1', 03:54:56 INFO - 'TERM': 'linux', 03:54:56 INFO - 'TMOUT': '86400', 03:54:56 INFO - 'USER': 'cltbld', 03:54:56 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1473050667.566228-638762353', 03:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:56 INFO - '_': '/tools/buildbot/bin/python'} 03:54:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:57 INFO - Downloading/unpacking psutil>=3.1.1 03:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:54:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:54:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:54:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:54:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:54:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:54:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:54:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:54:59 INFO - Installing collected packages: psutil 03:54:59 INFO - Running setup.py install for psutil 03:54:59 INFO - building 'psutil._psutil_linux' extension 03:54:59 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 03:54:59 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 03:54:59 INFO - building 'psutil._psutil_posix' extension 03:54:59 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 03:54:59 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 03:54:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:54:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:54:59 INFO - Successfully installed psutil 03:54:59 INFO - Cleaning up... 03:54:59 INFO - Return code: 0 03:54:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54:59 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 0x182f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a5e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aed570>, '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 0x1aee470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aee900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1473050667.566228-638762353', '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 03:54:59 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 03:54:59 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 03:54:59 INFO - Using env: {'DISPLAY': ':0', 03:54:59 INFO - 'HOME': '/home/cltbld', 03:54:59 INFO - 'LANG': 'en_US.UTF-8', 03:54:59 INFO - 'LANGUAGE': 'en_US:en', 03:54:59 INFO - 'LOGNAME': 'cltbld', 03:54:59 INFO - 'MAIL': '/var/mail/cltbld', 03:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:59 INFO - 'MOZ_NO_REMOTE': '1', 03:54:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:54:59 INFO - 'NO_EM_RESTART': '1', 03:54:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:59 INFO - 'PWD': '/builds/slave/test', 03:54:59 INFO - 'SHELL': '/bin/bash', 03:54:59 INFO - 'SHLVL': '1', 03:54:59 INFO - 'TERM': 'linux', 03:54:59 INFO - 'TMOUT': '86400', 03:54:59 INFO - 'USER': 'cltbld', 03:54:59 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1473050667.566228-638762353', 03:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:59 INFO - '_': '/tools/buildbot/bin/python'} 03:54:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:54:59 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 03:54:59 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 03:54:59 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 03:54:59 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 03:54:59 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 03:54:59 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 03:55:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:55:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:55:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:55:01 INFO - Installing collected packages: mozsystemmonitor 03:55:01 INFO - Running setup.py install for mozsystemmonitor 03:55:01 INFO - Successfully installed mozsystemmonitor 03:55:01 INFO - Cleaning up... 03:55:01 INFO - Return code: 0 03:55:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:55:01 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')]} 03:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:01 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')]} 03:55:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:01 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 0x182f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a5e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aed570>, '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 0x1aee470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aee900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1473050667.566228-638762353', '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 03:55:01 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 03:55:01 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 03:55:01 INFO - Using env: {'DISPLAY': ':0', 03:55:01 INFO - 'HOME': '/home/cltbld', 03:55:01 INFO - 'LANG': 'en_US.UTF-8', 03:55:01 INFO - 'LANGUAGE': 'en_US:en', 03:55:01 INFO - 'LOGNAME': 'cltbld', 03:55:01 INFO - 'MAIL': '/var/mail/cltbld', 03:55:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:01 INFO - 'MOZ_NO_REMOTE': '1', 03:55:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:01 INFO - 'NO_EM_RESTART': '1', 03:55:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:01 INFO - 'PWD': '/builds/slave/test', 03:55:01 INFO - 'SHELL': '/bin/bash', 03:55:01 INFO - 'SHLVL': '1', 03:55:01 INFO - 'TERM': 'linux', 03:55:01 INFO - 'TMOUT': '86400', 03:55:01 INFO - 'USER': 'cltbld', 03:55:01 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1473050667.566228-638762353', 03:55:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:01 INFO - '_': '/tools/buildbot/bin/python'} 03:55:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:02 INFO - Downloading/unpacking jsonschema==2.5.1 03:55: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 03:55: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 03:55: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 03:55: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 03:55: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 03:55: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 03:55:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:55:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:55:04 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 03:55:04 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 03:55:04 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 03:55:04 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 03:55:04 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 03:55:04 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 03:55:04 INFO - Downloading functools32-3.2.3-2.tar.gz 03:55:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:55:04 INFO - warning: no files found matching '*.txt' 03:55:04 INFO - no previously-included directories found matching 'build' 03:55:04 INFO - no previously-included directories found matching 'dist' 03:55:04 INFO - no previously-included directories found matching '.git*' 03:55:04 INFO - Installing collected packages: jsonschema, functools32 03:55:04 INFO - Running setup.py install for functools32 03:55:04 INFO - warning: no files found matching '*.txt' 03:55:04 INFO - no previously-included directories found matching 'build' 03:55:04 INFO - no previously-included directories found matching 'dist' 03:55:04 INFO - no previously-included directories found matching '.git*' 03:55:04 INFO - Successfully installed jsonschema functools32 03:55:04 INFO - Cleaning up... 03:55:04 INFO - Return code: 0 03:55:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:55:04 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')]} 03:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:04 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')]} 03:55:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:04 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 0x182f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a5e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aed570>, '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 0x1aee470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aee900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1473050667.566228-638762353', '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 03:55:04 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 03:55:04 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 03:55:04 INFO - Using env: {'DISPLAY': ':0', 03:55:04 INFO - 'HOME': '/home/cltbld', 03:55:04 INFO - 'LANG': 'en_US.UTF-8', 03:55:04 INFO - 'LANGUAGE': 'en_US:en', 03:55:04 INFO - 'LOGNAME': 'cltbld', 03:55:04 INFO - 'MAIL': '/var/mail/cltbld', 03:55:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:04 INFO - 'MOZ_NO_REMOTE': '1', 03:55:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:04 INFO - 'NO_EM_RESTART': '1', 03:55:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:04 INFO - 'PWD': '/builds/slave/test', 03:55:04 INFO - 'SHELL': '/bin/bash', 03:55:04 INFO - 'SHLVL': '1', 03:55:04 INFO - 'TERM': 'linux', 03:55:04 INFO - 'TMOUT': '86400', 03:55:04 INFO - 'USER': 'cltbld', 03:55:04 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1473050667.566228-638762353', 03:55:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:04 INFO - '_': '/tools/buildbot/bin/python'} 03:55:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:55:04 INFO - Cleaning up... 03:55:04 INFO - Return code: 0 03:55:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:55:04 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')]} 03:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:04 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')]} 03:55:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:04 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 0x182f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a5e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aed570>, '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 0x1aee470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aee900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1473050667.566228-638762353', '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 03:55:04 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 03:55:04 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 03:55:04 INFO - Using env: {'DISPLAY': ':0', 03:55:04 INFO - 'HOME': '/home/cltbld', 03:55:04 INFO - 'LANG': 'en_US.UTF-8', 03:55:04 INFO - 'LANGUAGE': 'en_US:en', 03:55:04 INFO - 'LOGNAME': 'cltbld', 03:55:04 INFO - 'MAIL': '/var/mail/cltbld', 03:55:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:04 INFO - 'MOZ_NO_REMOTE': '1', 03:55:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:04 INFO - 'NO_EM_RESTART': '1', 03:55:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:04 INFO - 'PWD': '/builds/slave/test', 03:55:04 INFO - 'SHELL': '/bin/bash', 03:55:04 INFO - 'SHLVL': '1', 03:55:04 INFO - 'TERM': 'linux', 03:55:04 INFO - 'TMOUT': '86400', 03:55:04 INFO - 'USER': 'cltbld', 03:55:04 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1473050667.566228-638762353', 03:55:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:04 INFO - '_': '/tools/buildbot/bin/python'} 03:55:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:04 INFO - Downloading/unpacking blobuploader==1.2.4 03:55:04 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 03:55:04 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 03:55:04 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 03:55:04 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 03:55:04 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 03:55:04 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 03:55:07 INFO - Downloading blobuploader-1.2.4.tar.gz 03:55:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:55:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:55: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 03:55: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 03:55: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 03:55: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 03:55: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 03:55: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 03:55:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:55:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:08 INFO - Downloading docopt-0.6.1.tar.gz 03:55:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:55:08 INFO - Installing collected packages: blobuploader, requests, docopt 03:55:08 INFO - Running setup.py install for blobuploader 03:55:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:55:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:55:08 INFO - Running setup.py install for requests 03:55:09 INFO - Running setup.py install for docopt 03:55:09 INFO - Successfully installed blobuploader requests docopt 03:55:09 INFO - Cleaning up... 03:55:09 INFO - Return code: 0 03:55:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:55:09 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')]} 03:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:09 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')]} 03:55:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:09 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 0x182f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a5e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aed570>, '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 0x1aee470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aee900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1473050667.566228-638762353', '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 03:55:09 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 03:55:09 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 03:55:09 INFO - Using env: {'DISPLAY': ':0', 03:55:09 INFO - 'HOME': '/home/cltbld', 03:55:09 INFO - 'LANG': 'en_US.UTF-8', 03:55:09 INFO - 'LANGUAGE': 'en_US:en', 03:55:09 INFO - 'LOGNAME': 'cltbld', 03:55:09 INFO - 'MAIL': '/var/mail/cltbld', 03:55:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:09 INFO - 'MOZ_NO_REMOTE': '1', 03:55:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:09 INFO - 'NO_EM_RESTART': '1', 03:55:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:09 INFO - 'PWD': '/builds/slave/test', 03:55:09 INFO - 'SHELL': '/bin/bash', 03:55:09 INFO - 'SHLVL': '1', 03:55:09 INFO - 'TERM': 'linux', 03:55:09 INFO - 'TMOUT': '86400', 03:55:09 INFO - 'USER': 'cltbld', 03:55:09 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1473050667.566228-638762353', 03:55:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:09 INFO - '_': '/tools/buildbot/bin/python'} 03:55:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:55:09 INFO - Running setup.py (path:/tmp/pip-s3qP30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:55:09 INFO - Running setup.py (path:/tmp/pip-DrCLBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:55:09 INFO - Running setup.py (path:/tmp/pip-GonW0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:55:09 INFO - Running setup.py (path:/tmp/pip-6OeNHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:55:09 INFO - Running setup.py (path:/tmp/pip-ttBZhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:55:09 INFO - Running setup.py (path:/tmp/pip-x2KDhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:55:09 INFO - Running setup.py (path:/tmp/pip-vTgwJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:55:09 INFO - Running setup.py (path:/tmp/pip-B70e1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:55:09 INFO - Running setup.py (path:/tmp/pip-7wyje6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:55:10 INFO - Running setup.py (path:/tmp/pip-urhRaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:55:10 INFO - Running setup.py (path:/tmp/pip-6noQ6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:55:10 INFO - Running setup.py (path:/tmp/pip-j03QYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:55:10 INFO - Running setup.py (path:/tmp/pip-M5sbNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:55:10 INFO - Running setup.py (path:/tmp/pip-wfEEQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:55:10 INFO - Running setup.py (path:/tmp/pip-_vadkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:55:10 INFO - Running setup.py (path:/tmp/pip-aChFlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:55:10 INFO - Running setup.py (path:/tmp/pip-FIdYqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:55:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:55:10 INFO - Running setup.py install for manifestparser 03:55:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:55:10 INFO - Running setup.py install for mozcrash 03:55:10 INFO - Running setup.py install for mozdebug 03:55:10 INFO - Running setup.py install for mozdevice 03:55:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:55:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:55:11 INFO - Running setup.py install for mozfile 03:55:11 INFO - Running setup.py install for mozhttpd 03:55:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:55:11 INFO - Running setup.py install for mozinfo 03:55:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:55:11 INFO - Running setup.py install for mozInstall 03:55:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:55:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:55:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:55:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:55:11 INFO - Running setup.py install for mozleak 03:55:11 INFO - Running setup.py install for mozlog 03:55:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:55:11 INFO - Running setup.py install for moznetwork 03:55:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:55:11 INFO - Running setup.py install for mozprocess 03:55:11 INFO - Running setup.py install for mozprofile 03:55:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:55:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:55:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:55:12 INFO - Running setup.py install for mozrunner 03:55:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:55:12 INFO - Running setup.py install for mozscreenshot 03:55:12 INFO - Running setup.py install for moztest 03:55:12 INFO - Running setup.py install for mozversion 03:55:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:55:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:55:12 INFO - Cleaning up... 03:55:12 INFO - Return code: 0 03:55:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:55:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:55:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:12 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 0x182f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a5e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aed570>, '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 0x1aee470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aee900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1473050667.566228-638762353', '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 03:55:12 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 03:55:12 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 03:55:12 INFO - Using env: {'DISPLAY': ':0', 03:55:12 INFO - 'HOME': '/home/cltbld', 03:55:12 INFO - 'LANG': 'en_US.UTF-8', 03:55:12 INFO - 'LANGUAGE': 'en_US:en', 03:55:12 INFO - 'LOGNAME': 'cltbld', 03:55:12 INFO - 'MAIL': '/var/mail/cltbld', 03:55:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:12 INFO - 'MOZ_NO_REMOTE': '1', 03:55:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:12 INFO - 'NO_EM_RESTART': '1', 03:55:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:12 INFO - 'PWD': '/builds/slave/test', 03:55:12 INFO - 'SHELL': '/bin/bash', 03:55:12 INFO - 'SHLVL': '1', 03:55:12 INFO - 'TERM': 'linux', 03:55:12 INFO - 'TMOUT': '86400', 03:55:12 INFO - 'USER': 'cltbld', 03:55:12 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1473050667.566228-638762353', 03:55:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:12 INFO - '_': '/tools/buildbot/bin/python'} 03:55:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:55:12 INFO - Running setup.py (path:/tmp/pip-mIxoO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:55:12 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)) 03:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:55:12 INFO - Running setup.py (path:/tmp/pip-khY_ym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:55:12 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)) 03:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:55:12 INFO - Running setup.py (path:/tmp/pip-ANElrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:55:12 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)) 03:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:55:12 INFO - Running setup.py (path:/tmp/pip-kznqJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:55:12 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)) 03:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:55:12 INFO - Running setup.py (path:/tmp/pip-kJhH1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:55:13 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)) 03:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:55:13 INFO - Running setup.py (path:/tmp/pip-McARYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:55:13 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)) 03:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:55:13 INFO - Running setup.py (path:/tmp/pip-NGOldF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:55:13 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)) 03:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:55:13 INFO - Running setup.py (path:/tmp/pip-uDy4Z6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:55:13 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)) 03:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:55:13 INFO - Running setup.py (path:/tmp/pip-xveBAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:55:13 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)) 03:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:55:13 INFO - Running setup.py (path:/tmp/pip-59GeiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:55:13 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)) 03:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:55:13 INFO - Running setup.py (path:/tmp/pip-rWAnAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:55:13 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)) 03:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:55:13 INFO - Running setup.py (path:/tmp/pip-XW080T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:55:13 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)) 03:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:55:13 INFO - Running setup.py (path:/tmp/pip-HwvzUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:55:13 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)) 03:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:55:13 INFO - Running setup.py (path:/tmp/pip-1b0j0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:55:13 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)) 03:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:55:13 INFO - Running setup.py (path:/tmp/pip-Hn7Vx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:55:13 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)) 03:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:55:13 INFO - Running setup.py (path:/tmp/pip-agh8e9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:55:13 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)) 03:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:55:13 INFO - Running setup.py (path:/tmp/pip-83WNL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:55:13 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)) 03:55:13 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)) 03:55:13 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)) 03:55:13 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)) 03:55:13 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)) 03:55:13 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)) 03:55:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:55: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 03:55: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 03:55: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 03:55: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 03:55: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 03:55: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 03:55:15 INFO - Downloading blessings-1.6.tar.gz 03:55:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:55:15 INFO - Installing collected packages: blessings 03:55:15 INFO - Running setup.py install for blessings 03:55:15 INFO - Successfully installed blessings 03:55:15 INFO - Cleaning up... 03:55:16 INFO - Return code: 0 03:55:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:55:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:55:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:55:16 INFO - Reading from file tmpfile_stdout 03:55:16 INFO - Current package versions: 03:55:16 INFO - argparse == 1.2.1 03:55:16 INFO - blessings == 1.6 03:55:16 INFO - blobuploader == 1.2.4 03:55:16 INFO - docopt == 0.6.1 03:55:16 INFO - functools32 == 3.2.3-2 03:55:16 INFO - jsonschema == 2.5.1 03:55:16 INFO - manifestparser == 1.1 03:55:16 INFO - mozInstall == 1.12 03:55:16 INFO - mozcrash == 0.17 03:55:16 INFO - mozdebug == 0.1 03:55:16 INFO - mozdevice == 0.48 03:55:16 INFO - mozfile == 1.2 03:55:16 INFO - mozhttpd == 0.7 03:55:16 INFO - mozinfo == 0.9 03:55:16 INFO - mozleak == 0.1 03:55:16 INFO - mozlog == 3.3 03:55:16 INFO - moznetwork == 0.27 03:55:16 INFO - mozprocess == 0.23 03:55:16 INFO - mozprofile == 0.28 03:55:16 INFO - mozrunner == 6.12 03:55:16 INFO - mozscreenshot == 0.1 03:55:16 INFO - mozsystemmonitor == 0.3 03:55:16 INFO - moztest == 0.7 03:55:16 INFO - mozversion == 1.4 03:55:16 INFO - psutil == 3.1.1 03:55:16 INFO - requests == 1.2.3 03:55:16 INFO - wsgiref == 0.1.2 03:55:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:55:16 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')]} 03:55:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:16 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')]} 03:55:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:16 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 0x182f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a5e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aed570>, '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 0x1aee470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aee900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1473050667.566228-638762353', '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 03:55:16 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 03:55:16 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 03:55:16 INFO - Using env: {'DISPLAY': ':0', 03:55:16 INFO - 'HOME': '/home/cltbld', 03:55:16 INFO - 'LANG': 'en_US.UTF-8', 03:55:16 INFO - 'LANGUAGE': 'en_US:en', 03:55:16 INFO - 'LOGNAME': 'cltbld', 03:55:16 INFO - 'MAIL': '/var/mail/cltbld', 03:55:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:16 INFO - 'MOZ_NO_REMOTE': '1', 03:55:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:16 INFO - 'NO_EM_RESTART': '1', 03:55:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:16 INFO - 'PWD': '/builds/slave/test', 03:55:16 INFO - 'SHELL': '/bin/bash', 03:55:16 INFO - 'SHLVL': '1', 03:55:16 INFO - 'TERM': 'linux', 03:55:16 INFO - 'TMOUT': '86400', 03:55:16 INFO - 'USER': 'cltbld', 03:55:16 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1473050667.566228-638762353', 03:55:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:16 INFO - '_': '/tools/buildbot/bin/python'} 03:55:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:16 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)) 03:55:16 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)) 03:55:16 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)) 03:55:16 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)) 03:55:16 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)) 03:55:16 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)) 03:55:16 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)) 03:55:16 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)) 03:55:16 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)) 03:55:16 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)) 03:55:16 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)) 03:55:16 INFO - Cleaning up... 03:55:16 INFO - Return code: 0 03:55:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:55:16 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')]} 03:55:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:16 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')]} 03:55:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:16 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 0x182f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a5e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aed570>, '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 0x1aee470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aee900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1473050667.566228-638762353', '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 03:55:16 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 03:55:16 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 03:55:16 INFO - Using env: {'DISPLAY': ':0', 03:55:16 INFO - 'HOME': '/home/cltbld', 03:55:16 INFO - 'LANG': 'en_US.UTF-8', 03:55:16 INFO - 'LANGUAGE': 'en_US:en', 03:55:16 INFO - 'LOGNAME': 'cltbld', 03:55:16 INFO - 'MAIL': '/var/mail/cltbld', 03:55:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:16 INFO - 'MOZ_NO_REMOTE': '1', 03:55:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:16 INFO - 'NO_EM_RESTART': '1', 03:55:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:16 INFO - 'PWD': '/builds/slave/test', 03:55:16 INFO - 'SHELL': '/bin/bash', 03:55:16 INFO - 'SHLVL': '1', 03:55:16 INFO - 'TERM': 'linux', 03:55:16 INFO - 'TMOUT': '86400', 03:55:16 INFO - 'USER': 'cltbld', 03:55:16 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1473050667.566228-638762353', 03:55:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:16 INFO - '_': '/tools/buildbot/bin/python'} 03:55:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:55:16 INFO - Cleaning up... 03:55:16 INFO - Return code: 0 03:55:16 INFO - Running post-action listener: _resource_record_post_action 03:55:16 INFO - Running post-action listener: _start_resource_monitoring 03:55:16 INFO - Starting resource monitoring. 03:55:16 INFO - [mozharness: 2016-09-05 10:55:16.734608Z] Finished create-virtualenv step (success) 03:55:16 INFO - [mozharness: 2016-09-05 10:55:16.735086Z] Running install step. 03:55:16 INFO - Running pre-action listener: _resource_record_pre_action 03:55:16 INFO - Running main action method: install 03:55:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:55:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:55:16 INFO - Reading from file tmpfile_stdout 03:55:16 INFO - Detecting whether we're running mozinstall >=1.0... 03:55:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:55:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:55:17 INFO - Reading from file tmpfile_stdout 03:55:17 INFO - Output received: 03:55:17 INFO - Usage: mozinstall [options] installer 03:55:17 INFO - Options: 03:55:17 INFO - -h, --help show this help message and exit 03:55:17 INFO - -d DEST, --destination=DEST 03:55:17 INFO - Directory to install application into. [default: 03:55:17 INFO - "/builds/slave/test"] 03:55:17 INFO - --app=APP Application being installed. [default: firefox] 03:55:17 INFO - mkdir: /builds/slave/test/build/application 03:55:17 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'] 03:55:17 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 03:55:33 INFO - Reading from file tmpfile_stdout 03:55:33 INFO - Output received: 03:55:33 INFO - /builds/slave/test/build/application/firefox/firefox 03:55:33 INFO - Running post-action listener: _resource_record_post_action 03:55:33 INFO - [mozharness: 2016-09-05 10:55:33.378494Z] Finished install step (success) 03:55:33 INFO - [mozharness: 2016-09-05 10:55:33.378772Z] Running run-tests step. 03:55:33 INFO - Running pre-action listener: _resource_record_pre_action 03:55:33 INFO - Running main action method: run_tests 03:55:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:55:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:55:33 INFO - Python 2.7.3 03:55:33 INFO - Return code: 0 03:55:33 INFO - grabbing minidump binary from tooltool 03:55:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:55:33 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 0x1aed570>, '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 0x1aee470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aee900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:55:33 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 03:55:33 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 03:55:33 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 03:55:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:55:33 INFO - Return code: 0 03:55:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:55:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:55:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:55:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:55:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:55:33 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/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 03:55:33 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/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 03:55:33 INFO - Using env: {'DISPLAY': ':0', 03:55:33 INFO - 'HOME': '/home/cltbld', 03:55:33 INFO - 'LANG': 'en_US.UTF-8', 03:55:33 INFO - 'LANGUAGE': 'en_US:en', 03:55:33 INFO - 'LOGNAME': 'cltbld', 03:55:33 INFO - 'MAIL': '/var/mail/cltbld', 03:55:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:55:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:55:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:33 INFO - 'MOZ_NO_REMOTE': '1', 03:55:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:55:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:33 INFO - 'NO_EM_RESTART': '1', 03:55:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:33 INFO - 'PWD': '/builds/slave/test', 03:55:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:55:33 INFO - 'SHELL': '/bin/bash', 03:55:33 INFO - 'SHLVL': '1', 03:55:33 INFO - 'TERM': 'linux', 03:55:33 INFO - 'TMOUT': '86400', 03:55:33 INFO - 'USER': 'cltbld', 03:55:33 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1473050667.566228-638762353', 03:55:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:33 INFO - '_': '/tools/buildbot/bin/python'} 03:55:33 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/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 03:55:33 INFO - mozversion application_buildid: 20160905004005 03:55:33 INFO - mozversion application_changeset: 2231ab09a51c3b21dae6fa1627c1a64cfd43b3b0 03:55:33 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:55:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:55:33 INFO - mozversion application_name: Firefox 03:55:33 INFO - mozversion application_remotingname: firefox-dev 03:55:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:55:33 INFO - mozversion application_vendor: Mozilla 03:55:33 INFO - mozversion application_version: 50.0a2 03:55:33 INFO - mozversion platform_buildid: 20160905004005 03:55:33 INFO - mozversion platform_changeset: 2231ab09a51c3b21dae6fa1627c1a64cfd43b3b0 03:55:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:55:33 INFO - mozversion platform_version: 50.0a2 03:55:33 INFO - using testdate: 1473072933 03:55:33 INFO - actual date: 1473072933 03:55:33 INFO - starting webserver on 'localhost:58173' 03:55:33 INFO - SUITE-START | Running 2 tests 03:55:33 INFO - TEST-START | dromaeo_css 03:55:33 INFO - operating with platform_type : linux_ 03:55:33 INFO - Initialising browser for dromaeo_css test... 03:55:33 INFO - TEST-INFO | started process 6700 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMj8khk/profile http://localhost:58173/getInfo.html) 03:55:38 INFO - PROCESS | 6700 | __metrics Screen width/height:1600/1200 03:55:38 INFO - PROCESS | 6700 | colorDepth:24 03:55:38 INFO - PROCESS | 6700 | Browser inner width/height: 1024/697 03:55:38 INFO - PROCESS | 6700 | __metrics 03:55:39 ERROR - PROCESS | 6700 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 03:55:40 INFO - TEST-INFO | 6700: exit 0 03:55:40 INFO - Browser initialized. 03:55:40 INFO - Running cycle 1/1 for dromaeo_css test... 03:55:40 INFO - TEST-INFO | started process 6825 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMj8khk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:55:51 INFO - PROCESS | 6825 | RSS: Main: 152670208 03:55:51 INFO - PROCESS | 6825 | 03:56:41 INFO - PROCESS | 6825 | 1473073001383 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] 03:58:49 INFO - PROCESS | 6825 | Cycle 1(1): loaded http://localhost:58173/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58173/tests/dromaeo/cssquery-ext.html) 03:58:51 INFO - PROCESS | 6825 | RSS: Main: 157741056 03:58:51 INFO - PROCESS | 6825 | 04:01:53 INFO - PROCESS | 6825 | Cycle 1(1): loaded http://localhost:58173/tests/dromaeo/cssquery-ext.html (next: http://localhost:58173/tests/dromaeo/cssquery-jquery.html) 04:01:53 INFO - PROCESS | 6825 | RSS: Main: 153702400 04:01:53 INFO - PROCESS | 6825 | 04:04:55 INFO - PROCESS | 6825 | Cycle 1(1): loaded http://localhost:58173/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58173/tests/dromaeo/cssquery-mootools.html) 04:04:55 INFO - PROCESS | 6825 | RSS: Main: 154292224 04:04:55 INFO - PROCESS | 6825 | 04:07:57 INFO - PROCESS | 6825 | Cycle 1(1): loaded http://localhost:58173/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58173/tests/dromaeo/cssquery-prototype.html) 04:07:58 INFO - PROCESS | 6825 | RSS: Main: 153018368 04:07:58 INFO - PROCESS | 6825 | 04:11:00 INFO - PROCESS | 6825 | Cycle 1(1): loaded http://localhost:58173/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58173/tests/dromaeo/cssquery-yui.html) 04:11:01 INFO - PROCESS | 6825 | RSS: Main: 155570176 04:11:01 INFO - PROCESS | 6825 | 04:14:03 INFO - PROCESS | 6825 | Cycle 1(1): loaded http://localhost:58173/tests/dromaeo/cssquery-yui.html (next: http://localhost:58173/tests/dromaeo/cssquery-dojo.html) 04:14:03 INFO - PROCESS | 6825 | RSS: Main: 156106752 04:14:03 INFO - PROCESS | 6825 | 04:14:03 INFO - PROCESS | 6825 | __start_tp_report 04:14:03 INFO - PROCESS | 6825 | _x_x_mozilla_page_load 04:14:03 INFO - PROCESS | 6825 | _x_x_mozilla_page_load_details 04:14:03 INFO - PROCESS | 6825 | |i|pagename|runs| 04:14:03 INFO - PROCESS | 6825 | |0;dojo.html;3272.6563710810365;3299.752518561107;3314.9337013259737;3321.883734069308;3326.6174389945163;5736.827895163146;5758.280214973129;5786.623869448483;5814.6801925894115;5828.213191219184;5752.942470575293;5806.7096645167785;5829.242198514198;5846.883062338761;5856.47291743743;5251.55361794248;5252.3697156341295;5272.472752724716;5281.392639846409;5313.070212712779;5126.641135120543;5135.3837539495125;5218.895622087556;5229.686218826863;5326;5183.818566350178;5207.7916883324815;5223.895522089556;5239.52844244018;5296.073187192245;5285.8942821143555;5293.947060529384;5300.708461034642;5310.256564081032;5339.119045357511;5020.623453241022;5030.748462576857;5047.217681259374;5189.974050129726;5193.246979188034;5645.999999999959;5686.3744988051285;5709.314882214119;5712.628679135884;5761.827145185651;6095.817125486243;6127.877442451126;6128.693565321716;6145.4161854623735;6156.6613836238985;5983.58114931955;6146;6194.473469755077;6201.286852012031;6219.50243980485;5850.76596936122;5854.941450585482;5862.882742345215;5882.088276317135;5911.29064512257;6392.232932048091;6414.358564143642;6414.61512309263;6421.74313027483;6422.100905873182;5916.408359164136;6030.819075427744;6055.333913269536;6158.568900176944;6166.969165154145;6153.630782152995;6173.104899789505;6186.133941248228;6189.164462797555;6192.566520343533;6182.28903676074;6182.907256391158;6194.907076393858;6198.690065496798;6198.9151898417595;5947.49446297061;6049.122877182784;6083.270007599116;6126.23422072241;6195.938040619536;4655.4180727409075;4686.695364801277;4695.2252878275385;4698.506656801055;4742.051589682077;4180.184863951561;4187.225363307798;4218;4231.407602935591;4244.3209086546;5679.204911312419;5828.329742079631;5860.09168578871;5943.078822782476;5968.582199246011;6246.718897649616;6250.499960003189;6270.122182894398;6271.905921411182;6280.434760871452;5864.2083318752275;5961.493273071751;5962.8968640801595;5964.493018093423;5984.970075149597;5013.573846223039;5118.283440318359;5136.922946155736;5155.484451554815;5179.689218646893;6363.61818290904;6371.840703982438;6383.744650214032;6390.137331460193;6390.616563006234;6165;6215.378462153749;6220.160278362544;6221.09794079865;6239.875202496016;6071.301800292847;6304.842378940563;6311.842203944938;6399.392057754506;6410.391012853772;6125.186363432229;6192.752289908353;6205.875882482415;6209.782657606962;6217.098520714561;6207.6275423474735;6211.81364559064;6211.9068213975925;6213.502919766498;6215.689215539295;5868.38381969887;6045.395460453919;6079.422454866781;6094.481969032682;6094.542909281733;6129.172561704113;6129.172561704113;6133.172021777003;6134.478569321479;6142.385761423822;6012.368701286302;6026.15633811258;6080.574359794949;6090.299615544269;6091.634501929899;5809.2738407699035;6004.099385092097;6043.7884674036195;6105.572609917263;6158.969205153946;5941.435563621449;5950.761969521171;5963.0459126539545;5978.581499295182;5993.951058564647 04:14:03 INFO - PROCESS | 6825 | |1;ext.html;581.6103210848731;628.1519948070105;653.5392548253485;656.7471523463465;686.7596341280549;41876.37185442221;46908.2963755544;46933.530664693346;47051.76474117633;47207.76396118015;46830.76584617072;47055.52944470554;47495;47562;47584.286235706495;9048.185663290318;9209.769755756126;9212.124848139449;9297.209737172348;9324.766880827965;9180.495072771027;9198.2181514571;9226.815463690722;9235.076492350778;9246.35275530713;9294.02412746662;9349.81300373992;9369.203617692505;9378.765530861714;9405.858912116324;9200.35597508178;9249.213816825579;9261.44431334122;9274.211692006187;9283;9196.540172991323;9224.907750922539;9228.769280767967;9272.582733776997;9279.072092790735;44472;44560;44727.77636111831;44912.326315104976;44998.55001450009;4091.345384738457;4122.42286079949;4417.006173610912;4508.346289787963;4704;35605;35694.10764730877;36258.456123158176;36843.26313473716;37195.442068369;4750.572448479654;4774.28385742138;4797.30439086334;4844.612431005511;5003.124453220672;369303;373178.99999999726;375619;375855;377183;67426.32573674299;67454.66272668606;67490.66254668696;67701.3229867705;67889.66055169693;40394.79802601027;40944.181116377506;41136.79431602823;43459.13081738348;70985;18684.439466816017;18835.77567458111;19000.429987100408;19005.714914276297;19036.143373548224;14336.21150836714;14427.639309017359;14507.92746036263;14510.274486275644;14565.41738330455;21265.468363291042;21539.461513462287;21557.137714491557;21684.45788855291;21716.89141554282;7618.733344332922;7626.4661473697415;7687.884681729778;7734.265244801735;7810.648520816577;1050.406520316019;1062.4687656171914;1083.8753543342616;1120.025577747365;1156.9074474042056;34081.82959085238;34349.65650343464;34593.308133837185;34668;34784;1094.2668412163869;1122.1527746551465;1153.9249948753304;1205.9155859089956;1246.0716766009382;17379.913100434416;17709.645807083787;17743.911280443772;17779.377721779674;17814.57483401325;584704;587105;588105;588938;591284;64182.679086604265;64738.35261647418;64862;65019.34980650133;65100;1424.0956992309957;1464.7876057971534;1471.6835880285576;1484.8366679665228;1488.8362280149174;31523.36953260876;32196.678033219367;32486.83756581202;32581.34837303193;32824.343513129126;55382;55888.720556396955;56106.438935610124;56167.71916140393;56194.15708764453;532718;535836;536361;539326;541473;28637.713622863506;29435;31376;31621.683783162793;31766;49420;49467.59720837488;49562.25656615226;49923.75038124786;50258.497415025384;40670;41487.792561037;41771.7911410441;42967;43056.78471607622;42381;42568.57431425646;42796.786016069724;43582.56417435785;43786;39149;42639.36040959326;44612.776936115115;44930.32604511001;44981.55018449773;38464.07679615952;38770.80614596909;39299;39569.406458903715;39880.20239595134;29536.704632953395;30633.846830765702;30832;32592.837035814668;32615.347693046482 04:14:03 INFO - PROCESS | 6825 | |2;jquery.html;424.8045898886512;436.6245029274823;436.7161345125668;437.3330670727141;443.99334009989843;19206.327778527753;20503.384898453052;21030.474238144056;21091.789082109175;21133.788662113395;19424.320148794795;20283.594328113428;20371.49071273219;20566.177352905903;20688.27591034314;6041.546883983708;6252.374762523734;6258.718357673893;6258.906116408258;6269.404406581368;6049.727762250687;6065.7573697052285;6089.208402907616;6094.878102437949;6105.877882442349;5967.820965371024;6034.5172386209;6056.969715151418;6058.575899687024;6061.181740465025;5930.16977623131;5984.132300816357;5985.341612422651;6005.129256257818;6032.487238584726;5269.341332333458;5377.838664840061;5385.542228910508;5417.51242388183;5425.782968681248;17369.565760855952;17432.21555030027;21953.890230548746;24942.87528562364;25132.748672513222;2614.4248265381584;2649.3509090272814;2662.547366947604;2712.91861244163;2965.4069186162856;15194.468193613171;15312.234388280653;15478.380864765395;15956.840431595652;16056.036637801653;1898.411492437335;1979.2281010405952;2055.5046054467957;2066.71066050753;2191.495955930129;81776;83337.58331208366;83509;84797.57601212016;85463.57268213682;10862.239643225057;11191.496382662799;11367.602133925438;11480.081593472501;11480.712982175512;15925.920370398075;15956.76064859028;16049.598760031093;16062.75905861413;16073.115978621054;8580.356473264404;8596.054434012254;8621.094785047606;8716.477011379338;8790.91209087901;8294.543800091053;8377.371697122619;8381.03618083928;8556.957215214008;8623.275344931038;6879.277675843964;6959.617221052789;6977.546459480118;7073.151221853308;7140.393066589294;2040.0207900207984;2049.098396705445;2098.727165468479;2099.98950005249;2130.5738852229306;997.850322451638;1039.3140527251978;1039.7296702857311;1116.2353787655481;1166.5916929074926;21108.76114846655;21136.260230891847;21177.470563235733;21257.68113478299;21458.356249312546;1055.335138862527;1083.4691001409253;1112.2825777373548;1112.6272698645882;1127.261643623428;11791.410429478492;11882;11978.64064078079;12080.395980200954;12126;520055;525180;526921;539257;544036;79339.23964562145;84902.15097849067;85294.57352713197;86131.56934215414;87025.56487217524;1060.867391576053;1080.3841810168285;1092.7049696581878;1115.7489564847845;1121.388843080523;18047.819521804613;18228.635427291116;18498.537536561693;18812.341568045053;19015.42953711391;37151.256974860895;40273.59726402698;41036.58963410447;41692.79153604334;42290.154196915275;53553.4644653564;54222.45777542174;54852.72573637106;56163.71918140383;56238.1564276528;9017.594208260774;9050.321225907952;9184.632614695605;9195.908040919772;9215.81418974435;14340.56978290653;14393.28033598295;14448.277586120863;14465.421383144556;14513.78229326582;12035.939820300842;12079.094067944763;12747.61757147287;13052.869471305165;13060.934695326463;11504.712382190512;11520.596779112691;11579.88420115788;11806.881931180578;12227.572034979088;12338.444769985193;12407.751844963232;12795.232286062866;12871.099023068295;12881.742365152832;8734.519601421984;8816.735497935073;8953.194212520904;9061.048589897966;9139.817203656023;11626;12181.147319687538;12228.510859565873;12292.877071229173;12529.373531323216 04:14:03 INFO - PROCESS | 6825 | |3;mootools.html;1529.655827438826;1542.2828384801069;1707.5560354307877;1773.5477453249418;1800.19891148439;8083.151269116732;8617.698380556682;8770.736877893658;9354.438733675976;9391.154796068353;8887.377883548153;9208.49353285569;9225.630974761018;9229.307801914867;9241.76895577611;2421.576224160778;2452.889619967106;2471.7404672509397;2477.380654836291;2478.8388754730977;2417.347316224618;2457.066314800373;2512.246326102171;2513.49730053989;2520.8865601047996;2450.7181674107437;2457.9631305530434;2482;2491.402063504755;2492.3395300245447;2374.3470545599926;2428.283656321372;2439.292605144506;2446.302803700946;2452.558539462896;2383.988080059606;2405.951880962371;2424.3211900667666;2427.4295540547955;2437.390652336916;9197.310201734897;9290.814183716288;9310.627574896997;9311.255099592016;9344.205742511895;5500.80747173847;5586.24585680932;5649.49154576086;5656.095024796054;5660.773569057233;3310.8013519188926;3332.983335083309;3445.4831775233665;3473.3053389322235;3480.7215422766117;1126.1047467263545;1146.621614867092;1164.057113737875;1173.3312012152992;1177.6937996120985;12380.75238495234;12401.62795116148;12411.06916981221;12411.813822792576;12432.005439564904;4495.527969563214;4680;4798.160321943716;4805.255185446262;4855.077535268288;10474.947625261824;10556.947215263874;10571.418571978615;10575.101116405038;10577.048065674126;5459.69971651563;5475.315585551806;5503.091989821714;5504.2018907258225;5507.807226747044;4400.889977750582;5054.368203974504;5087.084324821568;5179.223116532475;5225.320708307896;4033.979830100831;4036.59634036594;4136.234796562646;4160.812763425653;4183;1323.358171286925;1329.7872340425486;1333.2667033131738;1340.7653660609353;1350.8581598932167;949.7008442340641;971.5967873332488;1022.2690776095128;1030.9484525773682;1073.4471747050275;6292.653904035231;6424.903626445607;6506.121673574007;6618.437432818265;6643.966780166165;969.8254314223508;984.5274268351232;986.6891929042329;994.5574219472265;1044.3159730376615;4456.68803183774;4623.190941585276;4639.489656137822;4686.461056978491;4695.906081878412;11282.097432205404;11624.070074394029;11641.359725215025;11642.301461912313;11642.417879106011;10798.838017429745;11247.83128253077;11265.436728163559;11559.36423496699;11589.420528973518;8478.491290522588;8576.1423857615;8640.740777776551;8672.56637168139;8690.174433428814;6297.937020629735;6323.6838158090995;6585.769498067544;6632.502562307943;6644.634545099872;10421.374717516974;10574.048335649828;10588.205884558534;10731.40977246259;10888.45557722095;10909.727256818644;10913.618023369145;10983.39591322485;11035.613753518588;11046.281991670516;7949.920500794918;8159.510429374256;8208.09710931785;8306.460080094774;8319;8798.208161265517;8857.158569935846;8886.155815197546;8903.19871211594;8908.331875109523;7664.846703066019;7761.72833950809;7780.49426787257;7803.453758236869;7851.097123830604;7804.453688241769;7837.059552853694;7852.41106916995;7962.363010959225;7978.84042319162;7496.550206987598;7531.435142364454;7610.048743907012;7614.428917831074;7672.80817979555;5476.945230547803;5492.835214943558;5552.278203833475;5555.138953462219;5601.971990140186;5442.346918369821;5469.124940009579;5495.780168793203;5518.089515229942;5615.775368985195 04:14:03 INFO - PROCESS | 6825 | |4;prototype.html;326.6929086658541;349.5368636556563;352.3235388054934;354.8899841049274;355.4046971323034;5719.656820590768;5753.769849206032;5793.594448388614;5804.767809287623;5879.206307148534;5632.7746890124345;5672.602917795756;5694.202811606378;5702.631368471558;5738.282714660668;4386.912261754763;4537.795799189044;4541.4105063227935;4553.2942393928915;4563.429571303587;4518.932216016762;4531.116432295704;4542.295944128648;4545.159145558066;4557.339185818055;4509.436320459942;4515.548445155491;4522.66080043998;4525.909481810362;4553.4763502197175;4453.732776033448;4544.431946006733;4547.226971414867;4558.225101732697;4576.558384108995;4008.178323443687;4013.779242141681;4017.3973903914352;4020.557738648746;4021.477207962975;5614.63504872182;5646;5669.886602267931;5677.858053548653;5682.943170568283;5054.7472626368535;5210.739463026834;5229.398619158807;5236.842894713165;5245.606579506514;6024.638521688713;6045.274567051982;6060.515158787286;6064.151018857364;6087.482563982023;4407.250767369523;4451.176532341495;4464.910701785946;4470.687051906368;4479.686421950465;6070.726817293233;6257.468115210213;6273.937260627381;6288.465480434169;6291.7168727406915;4509.1658043262105;4520.570545798144;4532.116237333754;4537.8184872604725;4550.294704320836;4575.313702944585;4586.197415452282;4593.356930029799;4609.976950115228;4612.861614151514;5075.137226671474;5141;5171.01750667372;5188.714620695822;5217.660852044605;6060.15165374565;6075.605085669417;6110.908336374958;6112.144299798032;6118.235220597426;1591.6657501924726;1602.6394061336339;1609.6136927137402;1612.5081850035851;1620.0846521715193;1015.8374660054355;1034.6533911139702;1035.8239099352977;1044.6604853422668;1054.4411461925192;5098.719570423588;5131.512506311894;5147.562457191106;5173.327467429285;5178.922316165261;5464.562834973192;5486.91769623456;5516.3380394352935;5520.282363292827;5520.834374968757;4983.928455382038;5117.897642047213;5196.9740151299;5209.12471510256;5213.530782229617;2881.429620856638;2918.7373136417823;2922.430126125385;2936.54955427372;2942.3820997590747;5384.9230153969365;5626.43735626434;5693.658380497183;5697.686627235542;5744.328887067533;5572.498475137257;5601.579881508822;5605.299337582802;5613.186088017214;5613.522850557667;6272.177520115966;6520.869582608321;6522.902156467657;6524.608523488606;6568.934310656928;6289.811305660837;6315.968420158054;6328.873422531616;6356;6366.840828979312;6043.8186854394435;6200.410960958701;6220.253569571681;6226.844328891814;6246.812595622138;6454.903176452263;6485.189351331083;6506.4469520091325;6508.642024688687;6532.150820393508;4369.584889435626;4431.224535706174;4440.555944405533;4452.376667266521;4459.509453960127;6228.380621038472;6284.874302513833;6287.748490060347;6291.433770960635;6307.738452309464;6156.353582873734;6157.815265542041;6170.598911070766;6177.413145751147;6228.719707613078;5955.166276721349;6123.540734445023;6131.325554188947;6158.384161583985;6165.784197553064;6136;6148.631082135086;6166.568340216142;6166.722497487534;6170.043643235305;5998.25021872266;6113.938860611337;6175.814725558241;6191.318954915046;6214.9689251553455;5928.229330187048;5981.790637327673;5986.521078313637;5996.70016499182;6004.489618382487 04:14:03 INFO - PROCESS | 6825 | |5;yui.html;739.2644318902693;784.8626490364186;792.2196636313231;835.6364981233164;899.4288626722033;16506.587335316624;16517.91741041293;16565.33738650454;16586.917065414687;17180;16349.34602615897;16465.25906334215;16573.08848013359;16578.58553536162;16618.169091545435;730.8867125595541;860.1785295043219;875.1292463998315;875.9255463285629;886.6674996876171;876.5310558851016;877.298161470824;879.3888247667842;880.4893161966077;881.2465342132481;928.7910220200469;934.5794392523358;938.3947353956694;938.591712605019;938.7418459923507;928.512530921265;930.6137952749668;931.585444477208;933.1554942776764;934.1685899549407;687.814290141659;688.198249039873;689.0972825598432;690.8963655451722;691.3155975584186;15799.447019354382;15843;15847.60380990473;15875.36498540057;15881.36474541017;15595.064296142154;15838.287277072444;16062.518124456285;16084.115373654444;16168.514944551682;14089.859101408958;14202.57392278223;14502.927485362612;14877.925610371878;15043.097414155076;5054.1407960646775;5058.570021548136;5069.746512674352;5129.666571672829;5133.204353325241;94374.52812735892;94549.5272523633;95038.04961950361;96234;97643.51178244063;12682.746345073232;13408.597742067754;13433;13685.86314136846;13880;25563;25966.610500842504;25973.740262597134;26003.479930401663;26083;9414.105659962293;10056.547455364525;10217.386956782468;10436.686899393031;10576.101031412261;5081.2378143278065;5275.947240527622;5331.31223479312;5409.83770486886;5488.56091512678;3985.9003524911527;4167.770772607475;4169.1661667666585;4174.937375939303;4179.895502612459;690.9585424874524;693.5803838677629;705.263000164829;710.3393843725385;721.0158134146957;816.542736067804;821.2239433735062;828.3538839704919;839.1440730455024;840.7771940435789;10589.470526473646;10860.782784344427;10933.125349971982;10933.835992460119;10944.781104377867;713.0765658472291;717.7389733255227;787.9763607091796;795.7135431244748;806.435495153395;4794.424669039738;5127.512886275797;5166.483351664879;5191;5213.931144115447;120568;132952;135544;138334.3083284577;141089;110250.44874775736;110727;111540.44229778962;114112.42943785393;119094;84457.57771211104;95671.52164239134;95874.52062739641;96266.51866740621;98086;9826.361286516354;10147.441890696082;10182.134518566005;10210.642627508001;10331.741706457398;58026.419735802105;58685.70657146687;59054.70472647609;59548;59659;76901.61549192219;84155;88007.55996219978;88037;89375;13595.592132236048;13613.591592252249;13686.794698079337;13957.3719182635;14072.296385180496;15082.24588770579;15260.236988150325;15652.373905044125;15955.361785528448;16080.115593642462;15605.609859753144;16279.918600406922;16844.747328789832;17200.65598687994;17271.618270538576;14233.430662773373;14388.28058597087;14895.47865824691;15362;15443.922780386027;14773.335199916244;14888.181150036418;15396.307166177772;15697.729106742127;15725.44960926362;12531.185472944595;13173.407196676364;13207.339633018502;13258.801117983045;13313.400896959467;12521.49914003466;12987.935060325015;13010.21938683682;13050.673733156367;13121.934390327988 04:14:03 INFO - PROCESS | 6825 | __end_tp_report 04:14:03 INFO - PROCESS | 6825 | __start_cc_report 04:14:03 INFO - PROCESS | 6825 | _x_x_mozilla_cycle_collect,319 04:14:03 INFO - PROCESS | 6825 | __end_cc_report 04:14:03 INFO - PROCESS | 6825 | __startTimestamp1473074043965__endTimestamp 04:14:03 INFO - PROCESS | 6825 | 04:14:03 INFO - PROCESS | 6825 | ------- Summary: start ------- 04:14:03 INFO - PROCESS | 6825 | Number of tests: 6 04:14:03 INFO - PROCESS | 6825 | 04:14:03 INFO - PROCESS | 6825 | [#0] dojo.html Cycles:165 Average:5740.00 Median:5983.58 stddev:671.44 (11.2%) stddev-sans-first:645.00 04:14:03 INFO - PROCESS | 6825 | Values: 3272.7 3299.8 3314.9 3321.9 3326.6 5736.8 5758.3 5786.6 5814.7 5828.2 5752.9 5806.7 5829.2 5846.9 5856.5 5251.6 5252.4 5272.5 5281.4 5313.1 5126.6 5135.4 5218.9 5229.7 5326.0 5183.8 5207.8 5223.9 5239.5 5296.1 5285.9 5293.9 5300.7 5310.3 5339.1 5020.6 5030.7 5047.2 5190.0 5193.2 5646.0 5686.4 5709.3 5712.6 5761.8 6095.8 6127.9 6128.7 6145.4 6156.7 5983.6 6146.0 6194.5 6201.3 6219.5 5850.8 5854.9 5862.9 5882.1 5911.3 6392.2 6414.4 6414.6 6421.7 6422.1 5916.4 6030.8 6055.3 6158.6 6167.0 6153.6 6173.1 6186.1 6189.2 6192.6 6182.3 6182.9 6194.9 6198.7 6198.9 5947.5 6049.1 6083.3 6126.2 6195.9 4655.4 4686.7 4695.2 4698.5 4742.1 4180.2 4187.2 4218.0 4231.4 4244.3 5679.2 5828.3 5860.1 5943.1 5968.6 6246.7 6250.5 6270.1 6271.9 6280.4 5864.2 5961.5 5962.9 5964.5 5985.0 5013.6 5118.3 5136.9 5155.5 5179.7 6363.6 6371.8 6383.7 6390.1 6390.6 6165.0 6215.4 6220.2 6221.1 6239.9 6071.3 6304.8 6311.8 6399.4 6410.4 6125.2 6192.8 6205.9 6209.8 6217.1 6207.6 6211.8 6211.9 6213.5 6215.7 5868.4 6045.4 6079.4 6094.5 6094.5 6129.2 6129.2 6133.2 6134.5 6142.4 6012.4 6026.2 6080.6 6090.3 6091.6 5809.3 6004.1 6043.8 6105.6 6159.0 5941.4 5950.8 5963.0 5978.6 5994.0 04:14:03 INFO - PROCESS | 6825 | 04:14:03 INFO - PROCESS | 6825 | [#1] ext.html Cycles:180 Average:66540.52 Median:44516.00 stddev:135000.58 (303.3%) stddev-sans-first:135288.46 04:14:03 INFO - PROCESS | 6825 | Values: 581.6 628.2 653.5 656.7 686.8 41876.4 46908.3 46933.5 47051.8 47207.8 46830.8 47055.5 47495.0 47562.0 47584.3 9048.2 9209.8 9212.1 9297.2 9324.8 9180.5 9198.2 9226.8 9235.1 9246.4 9294.0 9349.8 9369.2 9378.8 9405.9 9200.4 9249.2 9261.4 9274.2 9283.0 9196.5 9224.9 9228.8 9272.6 9279.1 44472.0 44560.0 44727.8 44912.3 44998.6 4091.3 4122.4 4417.0 4508.3 4704.0 35605.0 35694.1 36258.5 36843.3 37195.4 4750.6 4774.3 4797.3 4844.6 5003.1 369303.0 373179.0 375619.0 375855.0 377183.0 67426.3 67454.7 67490.7 67701.3 67889.7 40394.8 40944.2 41136.8 43459.1 70985.0 18684.4 18835.8 19000.4 19005.7 19036.1 14336.2 14427.6 14507.9 14510.3 14565.4 21265.5 21539.5 21557.1 21684.5 21716.9 7618.7 7626.5 7687.9 7734.3 7810.6 1050.4 1062.5 1083.9 1120.0 1156.9 34081.8 34349.7 34593.3 34668.0 34784.0 1094.3 1122.2 1153.9 1205.9 1246.1 17379.9 17709.6 17743.9 17779.4 17814.6 584704.0 587105.0 588105.0 588938.0 591284.0 64182.7 64738.4 64862.0 65019.3 65100.0 1424.1 1464.8 1471.7 1484.8 1488.8 31523.4 32196.7 32486.8 32581.3 32824.3 55382.0 55888.7 56106.4 56167.7 56194.2 532718.0 535836.0 536361.0 539326.0 541473.0 28637.7 29435.0 31376.0 31621.7 31766.0 49420.0 49467.6 49562.3 49923.8 50258.5 40670.0 41487.8 41771.8 42967.0 43056.8 42381.0 42568.6 42796.8 43582.6 43786.0 39149.0 42639.4 44612.8 44930.3 44981.6 38464.1 38770.8 39299.0 39569.4 39880.2 29536.7 30633.8 30832.0 32592.8 32615.3 04:14:03 INFO - PROCESS | 6825 | 04:14:03 INFO - PROCESS | 6825 | [#2] jquery.html Cycles:180 Average:30493.01 Median:12072.69 stddev:87124.25 (721.7%) stddev-sans-first:87339.40 04:14:03 INFO - PROCESS | 6825 | Values: 424.8 436.6 436.7 437.3 444.0 19206.3 20503.4 21030.5 21091.8 21133.8 19424.3 20283.6 20371.5 20566.2 20688.3 6041.5 6252.4 6258.7 6258.9 6269.4 6049.7 6065.8 6089.2 6094.9 6105.9 5967.8 6034.5 6057.0 6058.6 6061.2 5930.2 5984.1 5985.3 6005.1 6032.5 5269.3 5377.8 5385.5 5417.5 5425.8 17369.6 17432.2 21953.9 24942.9 25132.7 2614.4 2649.4 2662.5 2712.9 2965.4 15194.5 15312.2 15478.4 15956.8 16056.0 1898.4 1979.2 2055.5 2066.7 2191.5 81776.0 83337.6 83509.0 84797.6 85463.6 10862.2 11191.5 11367.6 11480.1 11480.7 15925.9 15956.8 16049.6 16062.8 16073.1 8580.4 8596.1 8621.1 8716.5 8790.9 8294.5 8377.4 8381.0 8557.0 8623.3 6879.3 6959.6 6977.5 7073.2 7140.4 2040.0 2049.1 2098.7 2100.0 2130.6 997.9 1039.3 1039.7 1116.2 1166.6 21108.8 21136.3 21177.5 21257.7 21458.4 1055.3 1083.5 1112.3 1112.6 1127.3 11791.4 11882.0 11978.6 12080.4 12126.0 520055.0 525180.0 526921.0 539257.0 544036.0 79339.2 84902.2 85294.6 86131.6 87025.6 1060.9 1080.4 1092.7 1115.7 1121.4 18047.8 18228.6 18498.5 18812.3 19015.4 37151.3 40273.6 41036.6 41692.8 42290.2 53553.5 54222.5 54852.7 56163.7 56238.2 9017.6 9050.3 9184.6 9195.9 9215.8 14340.6 14393.3 14448.3 14465.4 14513.8 12035.9 12079.1 12747.6 13052.9 13060.9 11504.7 11520.6 11579.9 11806.9 12227.6 12338.4 12407.8 12795.2 12871.1 12881.7 8734.5 8816.7 8953.2 9061.0 9139.8 11626.0 12181.1 12228.5 12292.9 12529.4 04:14:03 INFO - PROCESS | 6825 | 04:14:03 INFO - PROCESS | 6825 | [#3] mootools.html Cycles:180 Average:6085.30 Median:4691.18 stddev:3418.65 (72.9%) stddev-sans-first:3411.10 04:14:03 INFO - PROCESS | 6825 | Values: 1529.7 1542.3 1707.6 1773.5 1800.2 8083.2 8617.7 8770.7 9354.4 9391.2 8887.4 9208.5 9225.6 9229.3 9241.8 2421.6 2452.9 2471.7 2477.4 2478.8 2417.3 2457.1 2512.2 2513.5 2520.9 2450.7 2458.0 2482.0 2491.4 2492.3 2374.3 2428.3 2439.3 2446.3 2452.6 2384.0 2406.0 2424.3 2427.4 2437.4 9197.3 9290.8 9310.6 9311.3 9344.2 5500.8 5586.2 5649.5 5656.1 5660.8 3310.8 3333.0 3445.5 3473.3 3480.7 1126.1 1146.6 1164.1 1173.3 1177.7 12380.8 12401.6 12411.1 12411.8 12432.0 4495.5 4680.0 4798.2 4805.3 4855.1 10474.9 10556.9 10571.4 10575.1 10577.0 5459.7 5475.3 5503.1 5504.2 5507.8 4400.9 5054.4 5087.1 5179.2 5225.3 4034.0 4036.6 4136.2 4160.8 4183.0 1323.4 1329.8 1333.3 1340.8 1350.9 949.7 971.6 1022.3 1030.9 1073.4 6292.7 6424.9 6506.1 6618.4 6644.0 969.8 984.5 986.7 994.6 1044.3 4456.7 4623.2 4639.5 4686.5 4695.9 11282.1 11624.1 11641.4 11642.3 11642.4 10798.8 11247.8 11265.4 11559.4 11589.4 8478.5 8576.1 8640.7 8672.6 8690.2 6297.9 6323.7 6585.8 6632.5 6644.6 10421.4 10574.0 10588.2 10731.4 10888.5 10909.7 10913.6 10983.4 11035.6 11046.3 7949.9 8159.5 8208.1 8306.5 8319.0 8798.2 8857.2 8886.2 8903.2 8908.3 7664.8 7761.7 7780.5 7803.5 7851.1 7804.5 7837.1 7852.4 7962.4 7978.8 7496.6 7531.4 7610.0 7614.4 7672.8 5476.9 5492.8 5552.3 5555.1 5602.0 5442.3 5469.1 5495.8 5518.1 5615.8 04:14:03 INFO - PROCESS | 6825 | 04:14:03 INFO - PROCESS | 6825 | [#4] prototype.html Cycles:180 Average:5036.05 Median:5546.67 stddev:1476.50 (26.6%) stddev-sans-first:1437.71 04:14:03 INFO - PROCESS | 6825 | Values: 326.7 349.5 352.3 354.9 355.4 5719.7 5753.8 5793.6 5804.8 5879.2 5632.8 5672.6 5694.2 5702.6 5738.3 4386.9 4537.8 4541.4 4553.3 4563.4 4518.9 4531.1 4542.3 4545.2 4557.3 4509.4 4515.5 4522.7 4525.9 4553.5 4453.7 4544.4 4547.2 4558.2 4576.6 4008.2 4013.8 4017.4 4020.6 4021.5 5614.6 5646.0 5669.9 5677.9 5682.9 5054.7 5210.7 5229.4 5236.8 5245.6 6024.6 6045.3 6060.5 6064.2 6087.5 4407.3 4451.2 4464.9 4470.7 4479.7 6070.7 6257.5 6273.9 6288.5 6291.7 4509.2 4520.6 4532.1 4537.8 4550.3 4575.3 4586.2 4593.4 4610.0 4612.9 5075.1 5141.0 5171.0 5188.7 5217.7 6060.2 6075.6 6110.9 6112.1 6118.2 1591.7 1602.6 1609.6 1612.5 1620.1 1015.8 1034.7 1035.8 1044.7 1054.4 5098.7 5131.5 5147.6 5173.3 5178.9 5464.6 5486.9 5516.3 5520.3 5520.8 4983.9 5117.9 5197.0 5209.1 5213.5 2881.4 2918.7 2922.4 2936.5 2942.4 5384.9 5626.4 5693.7 5697.7 5744.3 5572.5 5601.6 5605.3 5613.2 5613.5 6272.2 6520.9 6522.9 6524.6 6568.9 6289.8 6316.0 6328.9 6356.0 6366.8 6043.8 6200.4 6220.3 6226.8 6246.8 6454.9 6485.2 6506.4 6508.6 6532.2 4369.6 4431.2 4440.6 4452.4 4459.5 6228.4 6284.9 6287.7 6291.4 6307.7 6156.4 6157.8 6170.6 6177.4 6228.7 5955.2 6123.5 6131.3 6158.4 6165.8 6136.0 6148.6 6166.6 6166.7 6170.0 5998.3 6113.9 6175.8 6191.3 6215.0 5928.2 5981.8 5986.5 5996.7 6004.5 04:14:03 INFO - PROCESS | 6825 | 04:14:03 INFO - PROCESS | 6825 | [#5] yui.html Cycles:180 Average:23889.67 Median:25988.61 stddev:34668.96 (133.4%) stddev-sans-first:34722.64 04:14:03 INFO - PROCESS | 6825 | Values: 739.3 784.9 792.2 835.6 899.4 16506.6 16517.9 16565.3 16586.9 17180.0 16349.3 16465.3 16573.1 16578.6 16618.2 730.9 860.2 875.1 875.9 886.7 876.5 877.3 879.4 880.5 881.2 928.8 934.6 938.4 938.6 938.7 928.5 930.6 931.6 933.2 934.2 687.8 688.2 689.1 690.9 691.3 15799.4 15843.0 15847.6 15875.4 15881.4 15595.1 15838.3 16062.5 16084.1 16168.5 14089.9 14202.6 14502.9 14877.9 15043.1 5054.1 5058.6 5069.7 5129.7 5133.2 94374.5 94549.5 95038.0 96234.0 97643.5 12682.7 13408.6 13433.0 13685.9 13880.0 25563.0 25966.6 25973.7 26003.5 26083.0 9414.1 10056.5 10217.4 10436.7 10576.1 5081.2 5275.9 5331.3 5409.8 5488.6 3985.9 4167.8 4169.2 4174.9 4179.9 691.0 693.6 705.3 710.3 721.0 816.5 821.2 828.4 839.1 840.8 10589.5 10860.8 10933.1 10933.8 10944.8 713.1 717.7 788.0 795.7 806.4 4794.4 5127.5 5166.5 5191.0 5213.9 120568.0 132952.0 135544.0 138334.3 141089.0 110250.4 110727.0 111540.4 114112.4 119094.0 84457.6 95671.5 95874.5 96266.5 98086.0 9826.4 10147.4 10182.1 10210.6 10331.7 58026.4 58685.7 59054.7 59548.0 59659.0 76901.6 84155.0 88007.6 88037.0 89375.0 13595.6 13613.6 13686.8 13957.4 14072.3 15082.2 15260.2 15652.4 15955.4 16080.1 15605.6 16279.9 16844.7 17200.7 17271.6 14233.4 14388.3 14895.5 15362.0 15443.9 14773.3 14888.2 15396.3 15697.7 15725.4 12531.2 13173.4 13207.3 13258.8 13313.4 12521.5 12987.9 13010.2 13050.7 13121.9 04:14:03 INFO - PROCESS | 6825 | -------- Summary: end -------- 04:14:03 INFO - PROCESS | 6825 | 04:14:04 INFO - TEST-INFO | 6825: exit 0 04:14:04 INFO - TEST-OK | dromaeo_css | took 1111092ms 04:14:04 INFO - TEST-START | kraken 04:14:04 INFO - operating with platform_type : linux_ 04:14:04 INFO - Initialising browser for kraken test... 04:14:04 INFO - TEST-INFO | started process 7090 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWgJSVb/profile http://localhost:58173/getInfo.html) 04:14:09 INFO - PROCESS | 7090 | __metrics Screen width/height:1600/1200 04:14:09 INFO - PROCESS | 7090 | colorDepth:24 04:14:09 INFO - PROCESS | 7090 | Browser inner width/height: 1024/697 04:14:09 INFO - PROCESS | 7090 | __metrics 04:14:10 ERROR - PROCESS | 7090 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 04:14:10 INFO - TEST-INFO | 7090: exit 0 04:14:10 INFO - Browser initialized. 04:14:10 INFO - Running cycle 1/1 for kraken test... 04:14:10 INFO - TEST-INFO | started process 7215 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWgJSVb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:14:22 INFO - PROCESS | 7215 | RSS: Main: 152760320 04:14:22 INFO - PROCESS | 7215 | 04:14:25 INFO - PROCESS | 7215 | Cycle 1(1): loaded http://localhost:58173/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58173/tests/kraken/driver.html?testName=audio-beat-detection) 04:14:25 INFO - PROCESS | 7215 | RSS: Main: 157995008 04:14:25 INFO - PROCESS | 7215 | 04:14:28 INFO - PROCESS | 7215 | Cycle 1(1): loaded http://localhost:58173/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58173/tests/kraken/driver.html?testName=audio-dft) 04:14:29 INFO - PROCESS | 7215 | RSS: Main: 156622848 04:14:29 INFO - PROCESS | 7215 | 04:14:32 INFO - PROCESS | 7215 | Cycle 1(1): loaded http://localhost:58173/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58173/tests/kraken/driver.html?testName=audio-fft) 04:14:32 INFO - PROCESS | 7215 | RSS: Main: 156860416 04:14:32 INFO - PROCESS | 7215 | 04:14:34 INFO - PROCESS | 7215 | Cycle 1(1): loaded http://localhost:58173/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58173/tests/kraken/driver.html?testName=audio-oscillator) 04:14:35 INFO - PROCESS | 7215 | RSS: Main: 157118464 04:14:35 INFO - PROCESS | 7215 | 04:14:37 INFO - PROCESS | 7215 | Cycle 1(1): loaded http://localhost:58173/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58173/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:14:38 INFO - PROCESS | 7215 | RSS: Main: 156712960 04:14:38 INFO - PROCESS | 7215 | 04:14:41 INFO - PROCESS | 7215 | Cycle 1(1): loaded http://localhost:58173/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58173/tests/kraken/driver.html?testName=imaging-darkroom) 04:14:41 INFO - PROCESS | 7215 | RSS: Main: 156581888 04:14:41 INFO - PROCESS | 7215 | 04:14:45 INFO - PROCESS | 7215 | Cycle 1(1): loaded http://localhost:58173/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58173/tests/kraken/driver.html?testName=imaging-desaturate) 04:14:45 INFO - PROCESS | 7215 | RSS: Main: 156610560 04:14:45 INFO - PROCESS | 7215 | 04:14:48 INFO - PROCESS | 7215 | Cycle 1(1): loaded http://localhost:58173/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58173/tests/kraken/driver.html?testName=json-parse-financial) 04:14:49 INFO - PROCESS | 7215 | RSS: Main: 157728768 04:14:49 INFO - PROCESS | 7215 | 04:14:50 INFO - PROCESS | 7215 | Cycle 1(1): loaded http://localhost:58173/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58173/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:14:51 INFO - PROCESS | 7215 | RSS: Main: 157253632 04:14:51 INFO - PROCESS | 7215 | 04:14:53 INFO - PROCESS | 7215 | Cycle 1(1): loaded http://localhost:58173/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58173/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:14:53 INFO - PROCESS | 7215 | RSS: Main: 156540928 04:14:53 INFO - PROCESS | 7215 | 04:14:55 INFO - PROCESS | 7215 | Cycle 1(1): loaded http://localhost:58173/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58173/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:14:56 INFO - PROCESS | 7215 | RSS: Main: 157409280 04:14:56 INFO - PROCESS | 7215 | 04:14:59 INFO - PROCESS | 7215 | Cycle 1(1): loaded http://localhost:58173/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58173/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:14:59 INFO - PROCESS | 7215 | RSS: Main: 157409280 04:14:59 INFO - PROCESS | 7215 | 04:15:02 INFO - PROCESS | 7215 | Cycle 1(1): loaded http://localhost:58173/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58173/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:15:03 INFO - PROCESS | 7215 | RSS: Main: 157884416 04:15:03 INFO - PROCESS | 7215 | 04:15:04 INFO - PROCESS | 7215 | Cycle 1(1): loaded http://localhost:58173/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58173/tests/kraken/driver.html?testName=ai-astar) 04:15:04 INFO - PROCESS | 7215 | RSS: Main: 158937088 04:15:04 INFO - PROCESS | 7215 | 04:15:04 INFO - PROCESS | 7215 | __start_tp_report 04:15:04 INFO - PROCESS | 7215 | _x_x_mozilla_page_load 04:15:04 INFO - PROCESS | 7215 | _x_x_mozilla_page_load_details 04:15:04 INFO - PROCESS | 7215 | |i|pagename|runs| 04:15:04 INFO - PROCESS | 7215 | |0;ai-astar;101;110;105;109;110;112;109;114;109;111 04:15:04 INFO - PROCESS | 7215 | |1;audio-beat-detection;149;119;142;167;117;151;142;124;187;115 04:15:04 INFO - PROCESS | 7215 | |2;audio-dft;162;164;162;164;162;164;163;160;163;161 04:15:04 INFO - PROCESS | 7215 | |3;audio-fft;76;76;76;178;76;75;76;74;169;75 04:15:04 INFO - PROCESS | 7215 | |4;audio-oscillator;84;83;145;83;84;82;131;84;83;147 04:15:04 INFO - PROCESS | 7215 | |5;imaging-gaussian-blur;118;117;117;118;117;118;117;118;117;117 04:15:04 INFO - PROCESS | 7215 | |6;imaging-darkroom;148;148;146;146;148;148;148;151;147;148 04:15:04 INFO - PROCESS | 7215 | |7;imaging-desaturate;96;95;96;95;97;96;101;96;95;95 04:15:04 INFO - PROCESS | 7215 | |8;json-parse-financial;54;50;51;51;50;53;50;50;51;52 04:15:04 INFO - PROCESS | 7215 | |9;json-stringify-tinderbox;63;59;59;58;60;59;59;59;60;59 04:15:04 INFO - PROCESS | 7215 | |10;stanford-crypto-aes;73;75;78;79;80;73;74;84;73;72 04:15:04 INFO - PROCESS | 7215 | |11;stanford-crypto-ccm;123;118;129;117;128;120;130;131;150;130 04:15:04 INFO - PROCESS | 7215 | |12;stanford-crypto-pbkdf2;153;154;154;160;151;156;155;151;162;153 04:15:04 INFO - PROCESS | 7215 | |13;stanford-crypto-sha256-iterative;63;63;62;60;62;60;62;62;60;65 04:15:04 INFO - PROCESS | 7215 | __end_tp_report 04:15:04 INFO - PROCESS | 7215 | __start_cc_report 04:15:04 INFO - PROCESS | 7215 | _x_x_mozilla_cycle_collect,872 04:15:04 INFO - PROCESS | 7215 | __end_cc_report 04:15:04 INFO - PROCESS | 7215 | __startTimestamp1473074104975__endTimestamp 04:15:04 INFO - PROCESS | 7215 | 04:15:04 INFO - PROCESS | 7215 | ------- Summary: start ------- 04:15:04 INFO - PROCESS | 7215 | Number of tests: 14 04:15:04 INFO - PROCESS | 7215 | 04:15:04 INFO - PROCESS | 7215 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.00 stddev:3.65 (3.3%) stddev-sans-first:2.47 04:15:04 INFO - PROCESS | 7215 | Values: 101.0 110.0 105.0 109.0 110.0 112.0 109.0 114.0 109.0 111.0 04:15:04 INFO - PROCESS | 7215 | 04:15:04 INFO - PROCESS | 7215 | [#1] audio-beat-detection Cycles:10 Average:141.30 Median:145.50 stddev:23.53 (16.2%) stddev-sans-first:24.79 04:15:04 INFO - PROCESS | 7215 | Values: 149.0 119.0 142.0 167.0 117.0 151.0 142.0 124.0 187.0 115.0 04:15:04 INFO - PROCESS | 7215 | 04:15:04 INFO - PROCESS | 7215 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:1.35 (0.8%) stddev-sans-first:1.42 04:15:04 INFO - PROCESS | 7215 | Values: 162.0 164.0 162.0 164.0 162.0 164.0 163.0 160.0 163.0 161.0 04:15:04 INFO - PROCESS | 7215 | 04:15:04 INFO - PROCESS | 7215 | [#3] audio-fft Cycles:10 Average:95.10 Median:76.00 stddev:41.38 (54.4%) stddev-sans-first:43.31 04:15:04 INFO - PROCESS | 7215 | Values: 76.0 76.0 76.0 178.0 76.0 75.0 76.0 74.0 169.0 75.0 04:15:04 INFO - PROCESS | 7215 | 04:15:04 INFO - PROCESS | 7215 | [#4] audio-oscillator Cycles:10 Average:100.60 Median:83.00 stddev:28.19 (34.0%) stddev-sans-first:29.25 04:15:04 INFO - PROCESS | 7215 | Values: 84.0 83.0 145.0 83.0 84.0 82.0 131.0 84.0 83.0 147.0 04:15:04 INFO - PROCESS | 7215 | 04:15:04 INFO - PROCESS | 7215 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 04:15:04 INFO - PROCESS | 7215 | Values: 118.0 117.0 117.0 118.0 117.0 118.0 117.0 118.0 117.0 117.0 04:15:04 INFO - PROCESS | 7215 | 04:15:04 INFO - PROCESS | 7215 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:1.40 (0.9%) stddev-sans-first:1.48 04:15:04 INFO - PROCESS | 7215 | Values: 148.0 148.0 146.0 146.0 148.0 148.0 148.0 151.0 147.0 148.0 04:15:04 INFO - PROCESS | 7215 | 04:15:04 INFO - PROCESS | 7215 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:1.81 (1.9%) stddev-sans-first:1.92 04:15:04 INFO - PROCESS | 7215 | Values: 96.0 95.0 96.0 95.0 97.0 96.0 101.0 96.0 95.0 95.0 04:15:04 INFO - PROCESS | 7215 | 04:15:04 INFO - PROCESS | 7215 | [#8] json-parse-financial Cycles:10 Average:51.20 Median:51.00 stddev:1.40 (2.7%) stddev-sans-first:1.05 04:15:04 INFO - PROCESS | 7215 | Values: 54.0 50.0 51.0 51.0 50.0 53.0 50.0 50.0 51.0 52.0 04:15:04 INFO - PROCESS | 7215 | 04:15:04 INFO - PROCESS | 7215 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:59.00 stddev:1.35 (2.3%) stddev-sans-first:0.60 04:15:04 INFO - PROCESS | 7215 | Values: 63.0 59.0 59.0 58.0 60.0 59.0 59.0 59.0 60.0 59.0 04:15:04 INFO - PROCESS | 7215 | 04:15:04 INFO - PROCESS | 7215 | [#10] stanford-crypto-aes Cycles:10 Average:76.10 Median:76.50 stddev:3.96 (5.2%) stddev-sans-first:4.03 04:15:04 INFO - PROCESS | 7215 | Values: 73.0 75.0 78.0 79.0 80.0 73.0 74.0 84.0 73.0 72.0 04:15:04 INFO - PROCESS | 7215 | 04:15:04 INFO - PROCESS | 7215 | [#11] stanford-crypto-ccm Cycles:10 Average:127.60 Median:129.50 stddev:9.49 (7.3%) stddev-sans-first:9.92 04:15:04 INFO - PROCESS | 7215 | Values: 123.0 118.0 129.0 117.0 128.0 120.0 130.0 131.0 150.0 130.0 04:15:04 INFO - PROCESS | 7215 | 04:15:04 INFO - PROCESS | 7215 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.90 Median:154.50 stddev:3.60 (2.3%) stddev-sans-first:3.76 04:15:04 INFO - PROCESS | 7215 | Values: 153.0 154.0 154.0 160.0 151.0 156.0 155.0 151.0 162.0 153.0 04:15:04 INFO - PROCESS | 7215 | 04:15:04 INFO - PROCESS | 7215 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:62.00 stddev:1.60 (2.6%) stddev-sans-first:1.64 04:15:04 INFO - PROCESS | 7215 | Values: 63.0 63.0 62.0 60.0 62.0 60.0 62.0 62.0 60.0 65.0 04:15:04 INFO - PROCESS | 7215 | -------- Summary: end -------- 04:15:04 INFO - PROCESS | 7215 | 04:15:05 INFO - TEST-INFO | 7215: exit 0 04:15:05 INFO - TEST-OK | kraken | took 61209ms 04:15:05 INFO - SUITE-END | took 1172s 04:15:06 INFO - Completed test suite (00:19:32) 04:15:06 INFO - javascript benchmark 04:15:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7834.941948386482, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3272.6563710810365, 3299.752518561107, 3314.9337013259737, 3321.883734069308, 3326.6174389945163, 5736.827895163146, 5758.280214973129, 5786.623869448483, 5814.6801925894115, 5828.213191219184, 5752.942470575293, 5806.7096645167785, 5829.242198514198, 5846.883062338761, 5856.47291743743, 5251.55361794248, 5252.3697156341295, 5272.472752724716, 5281.392639846409, 5313.070212712779, 5126.641135120543, 5135.3837539495125, 5218.895622087556, 5229.686218826863, 5326.0, 5183.818566350178, 5207.7916883324815, 5223.895522089556, 5239.52844244018, 5296.073187192245, 5285.8942821143555, 5293.947060529384, 5300.708461034642, 5310.256564081032, 5339.119045357511, 5020.623453241022, 5030.748462576857, 5047.217681259374, 5189.974050129726, 5193.246979188034, 5645.999999999959, 5686.3744988051285, 5709.314882214119, 5712.628679135884, 5761.827145185651, 6095.817125486243, 6127.877442451126, 6128.693565321716, 6145.4161854623735, 6156.6613836238985, 5983.58114931955, 6146.0, 6194.473469755077, 6201.286852012031, 6219.50243980485, 5850.76596936122, 5854.941450585482, 5862.882742345215, 5882.088276317135, 5911.29064512257, 6392.232932048091, 6414.358564143642, 6414.61512309263, 6421.74313027483, 6422.100905873182, 5916.408359164136, 6030.819075427744, 6055.333913269536, 6158.568900176944, 6166.969165154145, 6153.630782152995, 6173.104899789505, 6186.133941248228, 6189.164462797555, 6192.566520343533, 6182.28903676074, 6182.907256391158, 6194.907076393858, 6198.690065496798, 6198.9151898417595, 5947.49446297061, 6049.122877182784, 6083.270007599116, 6126.23422072241, 6195.938040619536, 4655.4180727409075, 4686.695364801277, 4695.2252878275385, 4698.506656801055, 4742.051589682077, 4180.184863951561, 4187.225363307798, 4218.0, 4231.407602935591, 4244.3209086546, 5679.204911312419, 5828.329742079631, 5860.09168578871, 5943.078822782476, 5968.582199246011, 6246.718897649616, 6250.499960003189, 6270.122182894398, 6271.905921411182, 6280.434760871452, 5864.2083318752275, 5961.493273071751, 5962.8968640801595, 5964.493018093423, 5984.970075149597, 5013.573846223039, 5118.283440318359, 5136.922946155736, 5155.484451554815, 5179.689218646893, 6363.61818290904, 6371.840703982438, 6383.744650214032, 6390.137331460193, 6390.616563006234, 6165.0, 6215.378462153749, 6220.160278362544, 6221.09794079865, 6239.875202496016, 6071.301800292847, 6304.842378940563, 6311.842203944938, 6399.392057754506, 6410.391012853772, 6125.186363432229, 6192.752289908353, 6205.875882482415, 6209.782657606962, 6217.098520714561, 6207.6275423474735, 6211.81364559064, 6211.9068213975925, 6213.502919766498, 6215.689215539295, 5868.38381969887, 6045.395460453919, 6079.422454866781, 6094.481969032682, 6094.542909281733, 6129.172561704113, 6129.172561704113, 6133.172021777003, 6134.478569321479, 6142.385761423822, 6012.368701286302, 6026.15633811258, 6080.574359794949, 6090.299615544269, 6091.634501929899, 5809.2738407699035, 6004.099385092097, 6043.7884674036195, 6105.572609917263, 6158.969205153946, 5941.435563621449, 5950.761969521171, 5963.0459126539545, 5978.581499295182, 5993.951058564647], "value": 5693.268858355139, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.6103210848731, 628.1519948070105, 653.5392548253485, 656.7471523463465, 686.7596341280549, 41876.37185442221, 46908.2963755544, 46933.530664693346, 47051.76474117633, 47207.76396118015, 46830.76584617072, 47055.52944470554, 47495.0, 47562.0, 47584.286235706495, 9048.185663290318, 9209.769755756126, 9212.124848139449, 9297.209737172348, 9324.766880827965, 9180.495072771027, 9198.2181514571, 9226.815463690722, 9235.076492350778, 9246.35275530713, 9294.02412746662, 9349.81300373992, 9369.203617692505, 9378.765530861714, 9405.858912116324, 9200.35597508178, 9249.213816825579, 9261.44431334122, 9274.211692006187, 9283.0, 9196.540172991323, 9224.907750922539, 9228.769280767967, 9272.582733776997, 9279.072092790735, 44472.0, 44560.0, 44727.77636111831, 44912.326315104976, 44998.55001450009, 4091.345384738457, 4122.42286079949, 4417.006173610912, 4508.346289787963, 4704.0, 35605.0, 35694.10764730877, 36258.456123158176, 36843.26313473716, 37195.442068369, 4750.572448479654, 4774.28385742138, 4797.30439086334, 4844.612431005511, 5003.124453220672, 369303.0, 373178.99999999726, 375619.0, 375855.0, 377183.0, 67426.32573674299, 67454.66272668606, 67490.66254668696, 67701.3229867705, 67889.66055169693, 40394.79802601027, 40944.181116377506, 41136.79431602823, 43459.13081738348, 70985.0, 18684.439466816017, 18835.77567458111, 19000.429987100408, 19005.714914276297, 19036.143373548224, 14336.21150836714, 14427.639309017359, 14507.92746036263, 14510.274486275644, 14565.41738330455, 21265.468363291042, 21539.461513462287, 21557.137714491557, 21684.45788855291, 21716.89141554282, 7618.733344332922, 7626.4661473697415, 7687.884681729778, 7734.265244801735, 7810.648520816577, 1050.406520316019, 1062.4687656171914, 1083.8753543342616, 1120.025577747365, 1156.9074474042056, 34081.82959085238, 34349.65650343464, 34593.308133837185, 34668.0, 34784.0, 1094.2668412163869, 1122.1527746551465, 1153.9249948753304, 1205.9155859089956, 1246.0716766009382, 17379.913100434416, 17709.645807083787, 17743.911280443772, 17779.377721779674, 17814.57483401325, 584704.0, 587105.0, 588105.0, 588938.0, 591284.0, 64182.679086604265, 64738.35261647418, 64862.0, 65019.34980650133, 65100.0, 1424.0956992309957, 1464.7876057971534, 1471.6835880285576, 1484.8366679665228, 1488.8362280149174, 31523.36953260876, 32196.678033219367, 32486.83756581202, 32581.34837303193, 32824.343513129126, 55382.0, 55888.720556396955, 56106.438935610124, 56167.71916140393, 56194.15708764453, 532718.0, 535836.0, 536361.0, 539326.0, 541473.0, 28637.713622863506, 29435.0, 31376.0, 31621.683783162793, 31766.0, 49420.0, 49467.59720837488, 49562.25656615226, 49923.75038124786, 50258.497415025384, 40670.0, 41487.792561037, 41771.7911410441, 42967.0, 43056.78471607622, 42381.0, 42568.57431425646, 42796.786016069724, 43582.56417435785, 43786.0, 39149.0, 42639.36040959326, 44612.776936115115, 44930.32604511001, 44981.55018449773, 38464.07679615952, 38770.80614596909, 39299.0, 39569.406458903715, 39880.20239595134, 29536.704632953395, 30633.846830765702, 30832.0, 32592.837035814668, 32615.347693046482], "value": 21597.16343008732, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [424.8045898886512, 436.6245029274823, 436.7161345125668, 437.3330670727141, 443.99334009989843, 19206.327778527753, 20503.384898453052, 21030.474238144056, 21091.789082109175, 21133.788662113395, 19424.320148794795, 20283.594328113428, 20371.49071273219, 20566.177352905903, 20688.27591034314, 6041.546883983708, 6252.374762523734, 6258.718357673893, 6258.906116408258, 6269.404406581368, 6049.727762250687, 6065.7573697052285, 6089.208402907616, 6094.878102437949, 6105.877882442349, 5967.820965371024, 6034.5172386209, 6056.969715151418, 6058.575899687024, 6061.181740465025, 5930.16977623131, 5984.132300816357, 5985.341612422651, 6005.129256257818, 6032.487238584726, 5269.341332333458, 5377.838664840061, 5385.542228910508, 5417.51242388183, 5425.782968681248, 17369.565760855952, 17432.21555030027, 21953.890230548746, 24942.87528562364, 25132.748672513222, 2614.4248265381584, 2649.3509090272814, 2662.547366947604, 2712.91861244163, 2965.4069186162856, 15194.468193613171, 15312.234388280653, 15478.380864765395, 15956.840431595652, 16056.036637801653, 1898.411492437335, 1979.2281010405952, 2055.5046054467957, 2066.71066050753, 2191.495955930129, 81776.0, 83337.58331208366, 83509.0, 84797.57601212016, 85463.57268213682, 10862.239643225057, 11191.496382662799, 11367.602133925438, 11480.081593472501, 11480.712982175512, 15925.920370398075, 15956.76064859028, 16049.598760031093, 16062.75905861413, 16073.115978621054, 8580.356473264404, 8596.054434012254, 8621.094785047606, 8716.477011379338, 8790.91209087901, 8294.543800091053, 8377.371697122619, 8381.03618083928, 8556.957215214008, 8623.275344931038, 6879.277675843964, 6959.617221052789, 6977.546459480118, 7073.151221853308, 7140.393066589294, 2040.0207900207984, 2049.098396705445, 2098.727165468479, 2099.98950005249, 2130.5738852229306, 997.850322451638, 1039.3140527251978, 1039.7296702857311, 1116.2353787655481, 1166.5916929074926, 21108.76114846655, 21136.260230891847, 21177.470563235733, 21257.68113478299, 21458.356249312546, 1055.335138862527, 1083.4691001409253, 1112.2825777373548, 1112.6272698645882, 1127.261643623428, 11791.410429478492, 11882.0, 11978.64064078079, 12080.395980200954, 12126.0, 520055.0, 525180.0, 526921.0, 539257.0, 544036.0, 79339.23964562145, 84902.15097849067, 85294.57352713197, 86131.56934215414, 87025.56487217524, 1060.867391576053, 1080.3841810168285, 1092.7049696581878, 1115.7489564847845, 1121.388843080523, 18047.819521804613, 18228.635427291116, 18498.537536561693, 18812.341568045053, 19015.42953711391, 37151.256974860895, 40273.59726402698, 41036.58963410447, 41692.79153604334, 42290.154196915275, 53553.4644653564, 54222.45777542174, 54852.72573637106, 56163.71918140383, 56238.1564276528, 9017.594208260774, 9050.321225907952, 9184.632614695605, 9195.908040919772, 9215.81418974435, 14340.56978290653, 14393.28033598295, 14448.277586120863, 14465.421383144556, 14513.78229326582, 12035.939820300842, 12079.094067944763, 12747.61757147287, 13052.869471305165, 13060.934695326463, 11504.712382190512, 11520.596779112691, 11579.88420115788, 11806.881931180578, 12227.572034979088, 12338.444769985193, 12407.751844963232, 12795.232286062866, 12871.099023068295, 12881.742365152832, 8734.519601421984, 8816.735497935073, 8953.194212520904, 9061.048589897966, 9139.817203656023, 11626.0, 12181.147319687538, 12228.510859565873, 12292.877071229173, 12529.373531323216], "value": 9881.939752472563, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1529.655827438826, 1542.2828384801069, 1707.5560354307877, 1773.5477453249418, 1800.19891148439, 8083.151269116732, 8617.698380556682, 8770.736877893658, 9354.438733675976, 9391.154796068353, 8887.377883548153, 9208.49353285569, 9225.630974761018, 9229.307801914867, 9241.76895577611, 2421.576224160778, 2452.889619967106, 2471.7404672509397, 2477.380654836291, 2478.8388754730977, 2417.347316224618, 2457.066314800373, 2512.246326102171, 2513.49730053989, 2520.8865601047996, 2450.7181674107437, 2457.9631305530434, 2482.0, 2491.402063504755, 2492.3395300245447, 2374.3470545599926, 2428.283656321372, 2439.292605144506, 2446.302803700946, 2452.558539462896, 2383.988080059606, 2405.951880962371, 2424.3211900667666, 2427.4295540547955, 2437.390652336916, 9197.310201734897, 9290.814183716288, 9310.627574896997, 9311.255099592016, 9344.205742511895, 5500.80747173847, 5586.24585680932, 5649.49154576086, 5656.095024796054, 5660.773569057233, 3310.8013519188926, 3332.983335083309, 3445.4831775233665, 3473.3053389322235, 3480.7215422766117, 1126.1047467263545, 1146.621614867092, 1164.057113737875, 1173.3312012152992, 1177.6937996120985, 12380.75238495234, 12401.62795116148, 12411.06916981221, 12411.813822792576, 12432.005439564904, 4495.527969563214, 4680.0, 4798.160321943716, 4805.255185446262, 4855.077535268288, 10474.947625261824, 10556.947215263874, 10571.418571978615, 10575.101116405038, 10577.048065674126, 5459.69971651563, 5475.315585551806, 5503.091989821714, 5504.2018907258225, 5507.807226747044, 4400.889977750582, 5054.368203974504, 5087.084324821568, 5179.223116532475, 5225.320708307896, 4033.979830100831, 4036.59634036594, 4136.234796562646, 4160.812763425653, 4183.0, 1323.358171286925, 1329.7872340425486, 1333.2667033131738, 1340.7653660609353, 1350.8581598932167, 949.7008442340641, 971.5967873332488, 1022.2690776095128, 1030.9484525773682, 1073.4471747050275, 6292.653904035231, 6424.903626445607, 6506.121673574007, 6618.437432818265, 6643.966780166165, 969.8254314223508, 984.5274268351232, 986.6891929042329, 994.5574219472265, 1044.3159730376615, 4456.68803183774, 4623.190941585276, 4639.489656137822, 4686.461056978491, 4695.906081878412, 11282.097432205404, 11624.070074394029, 11641.359725215025, 11642.301461912313, 11642.417879106011, 10798.838017429745, 11247.83128253077, 11265.436728163559, 11559.36423496699, 11589.420528973518, 8478.491290522588, 8576.1423857615, 8640.740777776551, 8672.56637168139, 8690.174433428814, 6297.937020629735, 6323.6838158090995, 6585.769498067544, 6632.502562307943, 6644.634545099872, 10421.374717516974, 10574.048335649828, 10588.205884558534, 10731.40977246259, 10888.45557722095, 10909.727256818644, 10913.618023369145, 10983.39591322485, 11035.613753518588, 11046.281991670516, 7949.920500794918, 8159.510429374256, 8208.09710931785, 8306.460080094774, 8319.0, 8798.208161265517, 8857.158569935846, 8886.155815197546, 8903.19871211594, 8908.331875109523, 7664.846703066019, 7761.72833950809, 7780.49426787257, 7803.453758236869, 7851.097123830604, 7804.453688241769, 7837.059552853694, 7852.41106916995, 7962.363010959225, 7978.84042319162, 7496.550206987598, 7531.435142364454, 7610.048743907012, 7614.428917831074, 7672.80817979555, 5476.945230547803, 5492.835214943558, 5552.278203833475, 5555.138953462219, 5601.971990140186, 5442.346918369821, 5469.124940009579, 5495.780168793203, 5518.089515229942, 5615.775368985195], "value": 4881.002936421016, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.6929086658541, 349.5368636556563, 352.3235388054934, 354.8899841049274, 355.4046971323034, 5719.656820590768, 5753.769849206032, 5793.594448388614, 5804.767809287623, 5879.206307148534, 5632.7746890124345, 5672.602917795756, 5694.202811606378, 5702.631368471558, 5738.282714660668, 4386.912261754763, 4537.795799189044, 4541.4105063227935, 4553.2942393928915, 4563.429571303587, 4518.932216016762, 4531.116432295704, 4542.295944128648, 4545.159145558066, 4557.339185818055, 4509.436320459942, 4515.548445155491, 4522.66080043998, 4525.909481810362, 4553.4763502197175, 4453.732776033448, 4544.431946006733, 4547.226971414867, 4558.225101732697, 4576.558384108995, 4008.178323443687, 4013.779242141681, 4017.3973903914352, 4020.557738648746, 4021.477207962975, 5614.63504872182, 5646.0, 5669.886602267931, 5677.858053548653, 5682.943170568283, 5054.7472626368535, 5210.739463026834, 5229.398619158807, 5236.842894713165, 5245.606579506514, 6024.638521688713, 6045.274567051982, 6060.515158787286, 6064.151018857364, 6087.482563982023, 4407.250767369523, 4451.176532341495, 4464.910701785946, 4470.687051906368, 4479.686421950465, 6070.726817293233, 6257.468115210213, 6273.937260627381, 6288.465480434169, 6291.7168727406915, 4509.1658043262105, 4520.570545798144, 4532.116237333754, 4537.8184872604725, 4550.294704320836, 4575.313702944585, 4586.197415452282, 4593.356930029799, 4609.976950115228, 4612.861614151514, 5075.137226671474, 5141.0, 5171.01750667372, 5188.714620695822, 5217.660852044605, 6060.15165374565, 6075.605085669417, 6110.908336374958, 6112.144299798032, 6118.235220597426, 1591.6657501924726, 1602.6394061336339, 1609.6136927137402, 1612.5081850035851, 1620.0846521715193, 1015.8374660054355, 1034.6533911139702, 1035.8239099352977, 1044.6604853422668, 1054.4411461925192, 5098.719570423588, 5131.512506311894, 5147.562457191106, 5173.327467429285, 5178.922316165261, 5464.562834973192, 5486.91769623456, 5516.3380394352935, 5520.282363292827, 5520.834374968757, 4983.928455382038, 5117.897642047213, 5196.9740151299, 5209.12471510256, 5213.530782229617, 2881.429620856638, 2918.7373136417823, 2922.430126125385, 2936.54955427372, 2942.3820997590747, 5384.9230153969365, 5626.43735626434, 5693.658380497183, 5697.686627235542, 5744.328887067533, 5572.498475137257, 5601.579881508822, 5605.299337582802, 5613.186088017214, 5613.522850557667, 6272.177520115966, 6520.869582608321, 6522.902156467657, 6524.608523488606, 6568.934310656928, 6289.811305660837, 6315.968420158054, 6328.873422531616, 6356.0, 6366.840828979312, 6043.8186854394435, 6200.410960958701, 6220.253569571681, 6226.844328891814, 6246.812595622138, 6454.903176452263, 6485.189351331083, 6506.4469520091325, 6508.642024688687, 6532.150820393508, 4369.584889435626, 4431.224535706174, 4440.555944405533, 4452.376667266521, 4459.509453960127, 6228.380621038472, 6284.874302513833, 6287.748490060347, 6291.433770960635, 6307.738452309464, 6156.353582873734, 6157.815265542041, 6170.598911070766, 6177.413145751147, 6228.719707613078, 5955.166276721349, 6123.540734445023, 6131.325554188947, 6158.384161583985, 6165.784197553064, 6136.0, 6148.631082135086, 6166.568340216142, 6166.722497487534, 6170.043643235305, 5998.25021872266, 6113.938860611337, 6175.814725558241, 6191.318954915046, 6214.9689251553455, 5928.229330187048, 5981.790637327673, 5986.521078313637, 5996.70016499182, 6004.489618382487], "value": 4565.18977239849, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.2644318902693, 784.8626490364186, 792.2196636313231, 835.6364981233164, 899.4288626722033, 16506.587335316624, 16517.91741041293, 16565.33738650454, 16586.917065414687, 17180.0, 16349.34602615897, 16465.25906334215, 16573.08848013359, 16578.58553536162, 16618.169091545435, 730.8867125595541, 860.1785295043219, 875.1292463998315, 875.9255463285629, 886.6674996876171, 876.5310558851016, 877.298161470824, 879.3888247667842, 880.4893161966077, 881.2465342132481, 928.7910220200469, 934.5794392523358, 938.3947353956694, 938.591712605019, 938.7418459923507, 928.512530921265, 930.6137952749668, 931.585444477208, 933.1554942776764, 934.1685899549407, 687.814290141659, 688.198249039873, 689.0972825598432, 690.8963655451722, 691.3155975584186, 15799.447019354382, 15843.0, 15847.60380990473, 15875.36498540057, 15881.36474541017, 15595.064296142154, 15838.287277072444, 16062.518124456285, 16084.115373654444, 16168.514944551682, 14089.859101408958, 14202.57392278223, 14502.927485362612, 14877.925610371878, 15043.097414155076, 5054.1407960646775, 5058.570021548136, 5069.746512674352, 5129.666571672829, 5133.204353325241, 94374.52812735892, 94549.5272523633, 95038.04961950361, 96234.0, 97643.51178244063, 12682.746345073232, 13408.597742067754, 13433.0, 13685.86314136846, 13880.0, 25563.0, 25966.610500842504, 25973.740262597134, 26003.479930401663, 26083.0, 9414.105659962293, 10056.547455364525, 10217.386956782468, 10436.686899393031, 10576.101031412261, 5081.2378143278065, 5275.947240527622, 5331.31223479312, 5409.83770486886, 5488.56091512678, 3985.9003524911527, 4167.770772607475, 4169.1661667666585, 4174.937375939303, 4179.895502612459, 690.9585424874524, 693.5803838677629, 705.263000164829, 710.3393843725385, 721.0158134146957, 816.542736067804, 821.2239433735062, 828.3538839704919, 839.1440730455024, 840.7771940435789, 10589.470526473646, 10860.782784344427, 10933.125349971982, 10933.835992460119, 10944.781104377867, 713.0765658472291, 717.7389733255227, 787.9763607091796, 795.7135431244748, 806.435495153395, 4794.424669039738, 5127.512886275797, 5166.483351664879, 5191.0, 5213.931144115447, 120568.0, 132952.0, 135544.0, 138334.3083284577, 141089.0, 110250.44874775736, 110727.0, 111540.44229778962, 114112.42943785393, 119094.0, 84457.57771211104, 95671.52164239134, 95874.52062739641, 96266.51866740621, 98086.0, 9826.361286516354, 10147.441890696082, 10182.134518566005, 10210.642627508001, 10331.741706457398, 58026.419735802105, 58685.70657146687, 59054.70472647609, 59548.0, 59659.0, 76901.61549192219, 84155.0, 88007.55996219978, 88037.0, 89375.0, 13595.592132236048, 13613.591592252249, 13686.794698079337, 13957.3719182635, 14072.296385180496, 15082.24588770579, 15260.236988150325, 15652.373905044125, 15955.361785528448, 16080.115593642462, 15605.609859753144, 16279.918600406922, 16844.747328789832, 17200.65598687994, 17271.618270538576, 14233.430662773373, 14388.28058597087, 14895.47865824691, 15362.0, 15443.922780386027, 14773.335199916244, 14888.181150036418, 15396.307166177772, 15697.729106742127, 15725.44960926362, 12531.185472944595, 13173.407196676364, 13207.339633018502, 13258.801117983045, 13313.400896959467, 12521.49914003466, 12987.935060325015, 13010.21938683682, 13050.673733156367, 13121.934390327988], "value": 8542.86399641929, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1501.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 105.0, 109.0, 110.0, 112.0, 109.0, 114.0, 109.0, 111.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 119.0, 142.0, 167.0, 117.0, 151.0, 142.0, 124.0, 187.0, 115.0], "value": 141.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 162.0, 164.0, 162.0, 164.0, 163.0, 160.0, 163.0, 161.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 178.0, 76.0, 75.0, 76.0, 74.0, 169.0, 75.0], "value": 95.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 145.0, 83.0, 84.0, 82.0, 131.0, 84.0, 83.0, 147.0], "value": 100.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 146.0, 146.0, 148.0, 148.0, 148.0, 151.0, 147.0, 148.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 97.0, 96.0, 101.0, 96.0, 95.0, 95.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 50.0, 51.0, 51.0, 50.0, 53.0, 50.0, 50.0, 51.0, 52.0], "value": 51.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 59.0, 59.0, 58.0, 60.0, 59.0, 59.0, 59.0, 60.0, 59.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 78.0, 79.0, 80.0, 73.0, 74.0, 84.0, 73.0, 72.0], "value": 76.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 118.0, 129.0, 117.0, 128.0, 120.0, 130.0, 131.0, 150.0, 130.0], "value": 127.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 154.0, 154.0, 160.0, 151.0, 156.0, 155.0, 151.0, 162.0, 153.0], "value": 154.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 60.0, 62.0, 60.0, 62.0, 62.0, 60.0, 65.0], "value": 61.9, "unit": "score"}]}]} 04:15:06 INFO - Return code: 0 04:15:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:15:06 ERROR - # TBPL SUCCESS # 04:15:06 INFO - Running post-action listener: _resource_record_post_action 04:15:06 INFO - [mozharness: 2016-09-05 11:15:06.261276Z] Finished run-tests step (success) 04:15:06 INFO - Running post-run listener: _resource_record_post_run 04:15:06 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 270336; Write bytes: 327192576; Read time: 280; Write time: 327684 04:15:06 INFO - TinderboxPrint: CPU usage
13.3% 04:15:06 INFO - TinderboxPrint: I/O read bytes / time
270,336 / 280 04:15:06 INFO - TinderboxPrint: I/O write bytes / time
327,192,576 / 327,684 04:15:06 INFO - TinderboxPrint: CPU idle
8,227.3 (86.7%) 04:15:06 INFO - TinderboxPrint: CPU user
1,199.5 (12.6%) 04:15:06 INFO - TinderboxPrint: Swap in / out
0 / 0 04:15:06 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 79417344; Read time: 0; Write time: 122340 04:15:06 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 266240; Write bytes: 247775232; Read time: 272; Write time: 205344 04:15:06 INFO - Running post-run listener: _upload_blobber_files 04:15:06 INFO - Blob upload gear active. 04:15:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:15:06 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 04:15:06 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'] 04:15:06 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 04:15:07 INFO - (blobuploader) - INFO - Open directory for files ... 04:15:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:15:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:15:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:15:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:15:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:15:07 INFO - (blobuploader) - INFO - Done attempting. 04:15:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:15:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:15:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:15:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:15:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:15:12 INFO - (blobuploader) - INFO - Done attempting. 04:15:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:15:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:15:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:15:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:15:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:15:13 INFO - (blobuploader) - INFO - Done attempting. 04:15:13 INFO - (blobuploader) - INFO - Iteration through files over. 04:15:13 INFO - Return code: 0 04:15:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:15:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:15:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c598e5fe17783d54171c8086990be276db473eb36dcb4ad040cdeab5bee40a0077cc9ad0e3a2b80a789d190b4888863ffa095bb3afff8de5be3b3e0fd5bcdbc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4ebf592e24cb851932550573dfdcf7ba1a1a64b237c1f1a8c2194eb34dd38a79e4bef95e5c21e7224b75250d875851f6f2d87d415e1041245acceaedc111958", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44c95b454b76985d5b9db620f527a614d2d97d176e153393ed2916f1fa84171d7782017485802e9c52c40bc5765786b2504e070fd05da68bc36a1d09d835f3f9"} 04:15:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:15:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:15:13 INFO - Contents: 04:15:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c598e5fe17783d54171c8086990be276db473eb36dcb4ad040cdeab5bee40a0077cc9ad0e3a2b80a789d190b4888863ffa095bb3afff8de5be3b3e0fd5bcdbc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4ebf592e24cb851932550573dfdcf7ba1a1a64b237c1f1a8c2194eb34dd38a79e4bef95e5c21e7224b75250d875851f6f2d87d415e1041245acceaedc111958", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44c95b454b76985d5b9db620f527a614d2d97d176e153393ed2916f1fa84171d7782017485802e9c52c40bc5765786b2504e070fd05da68bc36a1d09d835f3f9"} 04:15:13 INFO - Running post-run listener: copy_logs_to_upload_dir 04:15:13 INFO - Copying logs to upload dir... 04:15:13 INFO - mkdir: /builds/slave/test/build/upload/logs 04:15:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1680.534973 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 0 secs) (at 2016-09-05 04:15:11.565288) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-05 04:15:11.569291) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1473050667.566228-638762353 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/9c598e5fe17783d54171c8086990be276db473eb36dcb4ad040cdeab5bee40a0077cc9ad0e3a2b80a789d190b4888863ffa095bb3afff8de5be3b3e0fd5bcdbc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4ebf592e24cb851932550573dfdcf7ba1a1a64b237c1f1a8c2194eb34dd38a79e4bef95e5c21e7224b75250d875851f6f2d87d415e1041245acceaedc111958", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44c95b454b76985d5b9db620f527a614d2d97d176e153393ed2916f1fa84171d7782017485802e9c52c40bc5765786b2504e070fd05da68bc36a1d09d835f3f9"} build_url:https://queue.taskcluster.net/v1/task/P5W6lwchRVCbF2--E2Ac5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011395 build_url: 'https://queue.taskcluster.net/v1/task/P5W6lwchRVCbF2--E2Ac5g/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/9c598e5fe17783d54171c8086990be276db473eb36dcb4ad040cdeab5bee40a0077cc9ad0e3a2b80a789d190b4888863ffa095bb3afff8de5be3b3e0fd5bcdbc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4ebf592e24cb851932550573dfdcf7ba1a1a64b237c1f1a8c2194eb34dd38a79e4bef95e5c21e7224b75250d875851f6f2d87d415e1041245acceaedc111958", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44c95b454b76985d5b9db620f527a614d2d97d176e153393ed2916f1fa84171d7782017485802e9c52c40bc5765786b2504e070fd05da68bc36a1d09d835f3f9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-05 04:15:11.595300) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-05 04:15:11.595795) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1473050667.566228-638762353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-05 04:15:11.681777) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-05 04:15:11.682436) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-05 04:15:11.682998) ========= ========= Total master_lag: 0.16 =========