builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-013 starttime: 1472737945.94 results: success (0) buildid: 20160830093921 builduid: 86ba142624df48b3b49a4204efa8ff7c revision: c819e284a13937fc955c2efb6da7fdf9c5bb8b88 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 06:52:25.945268) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 06:52:25.945654) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 06:52:25.945923) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 06:52:26.126181) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 06:52:26.126426) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1472737028.876801-1215529486 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-01 06:52:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.7M=0s 2016-09-01 06:52:26 (70.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118816 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 06:52:26.316340) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 06:52:26.316616) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1472737028.876801-1215529486 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023034 ========= master_lag: 0.11 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 06:52:26.444887) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 06:52:26.445210) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c819e284a13937fc955c2efb6da7fdf9c5bb8b88 --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 c819e284a13937fc955c2efb6da7fdf9c5bb8b88 --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=9c3a94c35cc88655b05d2c08000001b2-1472737028.876801-1215529486 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-01 06:52:26,587 truncating revision to first 12 chars 2016-09-01 06:52:26,587 Setting DEBUG logging. 2016-09-01 06:52:26,587 attempt 1/10 2016-09-01 06:52:26,587 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c819e284a139?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-01 06:52:26,899 unpacking tar archive at: mozilla-aurora-c819e284a139/testing/mozharness/ program finished with exit code 0 elapsedTime=0.646081 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 06:52:27.112531) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 06:52:27.112811) ========= script_repo_revision: c819e284a13937fc955c2efb6da7fdf9c5bb8b88 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 06:52:27.113185) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 06:52:27.113444) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 06:52:27.127717) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 5 secs) (at 2016-09-01 06:52:27.127979) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1472737028.876801-1215529486 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:52:27 INFO - MultiFileLogger online at 20160901 06:52:27 in /builds/slave/test 06:52:27 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 06:52:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:52:27 INFO - {'append_to_log': False, 06:52:27 INFO - 'base_work_dir': '/builds/slave/test', 06:52:27 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:52:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:52:27 INFO - 'branch': 'Mozilla-Aurora', 06:52:27 INFO - 'buildbot_json_path': 'buildprops.json', 06:52:27 INFO - 'config_files': ('talos/linux_config.py',), 06:52:27 INFO - 'default_actions': ('clobber', 06:52:27 INFO - 'read-buildbot-config', 06:52:27 INFO - 'download-and-extract', 06:52:27 INFO - 'populate-webroot', 06:52:27 INFO - 'create-virtualenv', 06:52:27 INFO - 'install', 06:52:27 INFO - 'run-tests'), 06:52:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:52:27 INFO - 'download_minidump_stackwalk': True, 06:52:27 INFO - 'download_symbols': 'ondemand', 06:52:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:52:27 INFO - 'tooltool.py': '/tools/tooltool.py', 06:52:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:52:27 INFO - '/tools/misc-python/virtualenv.py')}, 06:52:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:52:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:52:27 INFO - 'installer_path': 'installer.exe', 06:52:27 INFO - 'log_level': 'info', 06:52:27 INFO - 'log_name': 'talos', 06:52:27 INFO - 'log_to_console': True, 06:52:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:52:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:52:27 INFO - 'opt_config_files': (), 06:52:27 INFO - 'pip_index': False, 06:52:27 INFO - 'sps_profile': False, 06:52:27 INFO - 'sps_profile_interval': 0, 06:52:27 INFO - 'suite': 'dromaeojs-e10s', 06:52:27 INFO - 'system_bits': '32', 06:52:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:52:27 INFO - 'title': 'talos-linux64-ix-013', 06:52:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:52:27 INFO - 'use_talos_json': True, 06:52:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:52:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:52:27 INFO - 'work_dir': 'build'} 06:52:27 INFO - [mozharness: 2016-09-01 13:52:27.349814Z] Running clobber step. 06:52:27 INFO - Running pre-action listener: _resource_record_pre_action 06:52:27 INFO - Running main action method: clobber 06:52:27 INFO - rmtree: /builds/slave/test/build 06:52:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:52:27 INFO - Running post-action listener: _resource_record_post_action 06:52:27 INFO - [mozharness: 2016-09-01 13:52:27.801609Z] Finished clobber step (success) 06:52:27 INFO - [mozharness: 2016-09-01 13:52:27.801708Z] Running read-buildbot-config step. 06:52:27 INFO - Running pre-action listener: _resource_record_pre_action 06:52:27 INFO - Running main action method: read_buildbot_config 06:52:27 INFO - Using buildbot properties: 06:52:27 INFO - { 06:52:27 INFO - "project": "", 06:52:27 INFO - "product": "firefox", 06:52:27 INFO - "script_repo_revision": "production", 06:52:27 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 06:52:27 INFO - "repository": "", 06:52:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 06:52:27 INFO - "buildid": "20160830093921", 06:52:27 INFO - "pgo_build": "True", 06:52:27 INFO - "basedir": "/builds/slave/test", 06:52:27 INFO - "buildnumber": 523, 06:52:27 INFO - "slavename": "talos-linux64-ix-013", 06:52:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:52:27 INFO - "platform": "ubuntu64_hw", 06:52:27 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 06:52:27 INFO - "branch": "mozilla-aurora", 06:52:27 INFO - "repo_path": "releases/mozilla-aurora", 06:52:27 INFO - "revision": "c819e284a13937fc955c2efb6da7fdf9c5bb8b88", 06:52:27 INFO - "stage_platform": "linux64-pgo", 06:52:27 INFO - "builduid": "86ba142624df48b3b49a4204efa8ff7c", 06:52:27 INFO - "slavebuilddir": "test" 06:52:27 INFO - } 06:52:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 06:52:27 INFO - Running post-action listener: _resource_record_post_action 06:52:27 INFO - [mozharness: 2016-09-01 13:52:27.804145Z] Finished read-buildbot-config step (success) 06:52:27 INFO - [mozharness: 2016-09-01 13:52:27.804234Z] Running download-and-extract step. 06:52:27 INFO - Running pre-action listener: _resource_record_pre_action 06:52:27 INFO - Running main action method: download_and_extract 06:52:27 INFO - mkdir: /builds/slave/test/build/tests 06:52:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:52:27 INFO - https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:52:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 06:52:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 06:52:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/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 06:52:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/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 06:52:27 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 06:52:27 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 06:52:27 INFO - retry: Failed, sleeping 30 seconds before retrying 06:52:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/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 06:52:57 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 06:52:57 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 06:52:57 INFO - retry: Failed, sleeping 60 seconds before retrying 06:53:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/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 06:53:57 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 06:53:57 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 06:53:57 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/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! 06:53:57 INFO - Caught exception: HTTP Error 404: Not Found 06:53:57 INFO - Caught exception: HTTP Error 404: Not Found 06:53:57 INFO - Caught exception: HTTP Error 404: Not Found 06:53:57 INFO - trying https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 06:53:57 INFO - Downloading https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/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 06:53:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/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 06:53:58 INFO - Downloaded 1361 bytes. 06:53:58 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 06:53:58 INFO - Using the following test package requirements: 06:53:58 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 06:53:58 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 06:53:58 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 06:53:58 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 06:53:58 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 06:53:58 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 06:53:58 INFO - u'jsshell-linux-x86_64.zip'], 06:53:58 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 06:53:58 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 06:53:58 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 06:53:58 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 06:53:58 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 06:53:58 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 06:53:58 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 06:53:58 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 06:53:58 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 06:53:58 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 06:53:58 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 06:53:58 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:58 INFO - https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:53:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:53:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:53:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/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 06:53:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/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 06:53:58 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:53:58 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 06:53:58 INFO - retry: Failed, sleeping 30 seconds before retrying 06:54:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/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 06:54:28 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:54:28 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 06:54:28 INFO - retry: Failed, sleeping 60 seconds before retrying 06:55:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/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 06:55:28 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:55:28 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 06:55:28 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/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! 06:55:28 INFO - Caught exception: HTTP Error 404: Not Found 06:55:28 INFO - Caught exception: HTTP Error 404: Not Found 06:55:28 INFO - Caught exception: HTTP Error 404: Not Found 06:55:28 INFO - trying https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:55:28 INFO - Downloading https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/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 06:55:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/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 06:55:29 INFO - Downloaded 21769265 bytes. 06:55:29 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'] 06:55:29 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 06:55:30 INFO - Return code: 0 06:55:30 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 06:55:30 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')]} 06:55:30 INFO - https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:55:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:55:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:55:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/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 06:55:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/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 06:55:30 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:55:30 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 06:55:30 INFO - retry: Failed, sleeping 30 seconds before retrying 06:56:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/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 06:56:00 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:56:00 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 06:56:00 INFO - retry: Failed, sleeping 60 seconds before retrying 06:57:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/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 06:57:00 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:57:00 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 06:57:00 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/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! 06:57:00 INFO - Caught exception: HTTP Error 404: Not Found 06:57:00 INFO - Caught exception: HTTP Error 404: Not Found 06:57:00 INFO - Caught exception: HTTP Error 404: Not Found 06:57:00 INFO - trying https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:57:00 INFO - Downloading https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/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 06:57:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/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 06:57:01 INFO - Downloaded 21769265 bytes. 06:57:01 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'] 06:57:01 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 06:57:03 INFO - Return code: 0 06:57:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:03 INFO - https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:57:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 06:57:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 06:57:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/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 06:57:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/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 06:57:03 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 06:57:03 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 06:57:03 INFO - retry: Failed, sleeping 30 seconds before retrying 06:57:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/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 06:57:33 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 06:57:33 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 06:57:33 INFO - retry: Failed, sleeping 60 seconds before retrying 06:58:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/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 06:58:33 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 06:58:33 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 06:58:33 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/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! 06:58:33 INFO - Caught exception: HTTP Error 404: Not Found 06:58:33 INFO - Caught exception: HTTP Error 404: Not Found 06:58:33 INFO - Caught exception: HTTP Error 404: Not Found 06:58:33 INFO - trying https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 06:58:33 INFO - Downloading https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/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 06:58:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/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 06:58:33 INFO - Downloaded 14413723 bytes. 06:58:33 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'] 06:58:33 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 06:58:34 INFO - Return code: 0 06:58:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:34 INFO - https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:58:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 06:58:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 06:58:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/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 06:58:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/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 06:58:34 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 06:58:34 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 06:58:34 INFO - retry: Failed, sleeping 30 seconds before retrying 06:59:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/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 06:59:04 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 06:59:04 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 06:59:04 INFO - retry: Failed, sleeping 60 seconds before retrying 07:00:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/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 07:00:04 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:00:04 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 07:00:04 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/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! 07:00:04 INFO - Caught exception: HTTP Error 404: Not Found 07:00:04 INFO - Caught exception: HTTP Error 404: Not Found 07:00:04 INFO - Caught exception: HTTP Error 404: Not Found 07:00:04 INFO - trying https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:00:04 INFO - Downloading https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/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 07:00:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/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 07:00:05 INFO - Downloaded 63875997 bytes. 07:00:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:00:05 INFO - mkdir: /builds/slave/test/properties 07:00:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:00:05 INFO - Writing to file /builds/slave/test/properties/build_url 07:00:05 INFO - Contents: 07:00:05 INFO - build_url:https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:00:06 INFO - Running post-action listener: _resource_record_post_action 07:00:06 INFO - Running post-action listener: set_extra_try_arguments 07:00:06 INFO - [mozharness: 2016-09-01 14:00:06.318832Z] Finished download-and-extract step (success) 07:00:06 INFO - [mozharness: 2016-09-01 14:00:06.319064Z] Running populate-webroot step. 07:00:06 INFO - Running pre-action listener: _resource_record_pre_action 07:00:06 INFO - Running main action method: populate_webroot 07:00:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:00:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:00:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:00:06 INFO - '--tppagecycles', 07:00:06 INFO - '7'], 07:00:06 INFO - 'tests': ['tsvgm']}}, 07:00:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:00:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:00:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:00:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:00:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:00:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:00:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:06 INFO - 'talos_options': ['--disable-e10s'], 07:00:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:00:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:00:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:06 INFO - 'talos_options': ['--disable-e10s'], 07:00:06 INFO - 'tests': ['damp', 'tps']}, 07:00:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:06 INFO - 'tests': ['damp', 'tps']}, 07:00:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:00:06 INFO - 'tests': ['dromaeo_dom']}, 07:00:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:00:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:00:06 INFO - 'tests': ['basic_compositor_video']}, 07:00:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:00:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:00:06 INFO - 'tests': ['a11yr', 07:00:06 INFO - 'ts_paint', 07:00:06 INFO - 'tpaint', 07:00:06 INFO - 'sessionrestore', 07:00:06 INFO - 'sessionrestore_no_auto_restore', 07:00:06 INFO - 'tabpaint']}, 07:00:06 INFO - 'other-e10s': {'tests': ['a11yr', 07:00:06 INFO - 'ts_paint', 07:00:06 INFO - 'tpaint', 07:00:06 INFO - 'sessionrestore', 07:00:06 INFO - 'sessionrestore_no_auto_restore', 07:00:06 INFO - 'tabpaint']}, 07:00:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:00:06 INFO - 'ts_paint', 07:00:06 INFO - 'tpaint', 07:00:06 INFO - 'sessionrestore', 07:00:06 INFO - 'sessionrestore_no_auto_restore', 07:00:06 INFO - 'tabpaint']}, 07:00:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:00:06 INFO - 'ts_paint', 07:00:06 INFO - 'tpaint', 07:00:06 INFO - 'sessionrestore', 07:00:06 INFO - 'sessionrestore_no_auto_restore', 07:00:06 INFO - 'tabpaint']}, 07:00:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:00:06 INFO - 'tests': ['a11yr', 07:00:06 INFO - 'ts_paint', 07:00:06 INFO - 'tpaint', 07:00:06 INFO - 'sessionrestore', 07:00:06 INFO - 'sessionrestore_no_auto_restore', 07:00:06 INFO - 'tabpaint']}, 07:00:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:00:06 INFO - 'tests': ['a11yr', 07:00:06 INFO - 'ts_paint', 07:00:06 INFO - 'tpaint', 07:00:06 INFO - 'sessionrestore', 07:00:06 INFO - 'sessionrestore_no_auto_restore', 07:00:06 INFO - 'tabpaint']}, 07:00:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:00:06 INFO - 'tests': ['tsvgx', 07:00:06 INFO - 'tsvgr_opacity', 07:00:06 INFO - 'tart', 07:00:06 INFO - 'tscrollx', 07:00:06 INFO - 'cart']}, 07:00:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:00:06 INFO - 'tsvgr_opacity', 07:00:06 INFO - 'tart', 07:00:06 INFO - 'tscrollx', 07:00:06 INFO - 'cart']}, 07:00:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:06 INFO - 'talos_options': ['--disable-e10s'], 07:00:06 INFO - 'tests': ['tp5o']}, 07:00:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:06 INFO - 'tests': ['tp5o']}, 07:00:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:06 INFO - 'talos_options': ['--disable-e10s', 07:00:06 INFO - '--xperf_path', 07:00:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:00:06 INFO - 'tests': ['tp5n']}, 07:00:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:06 INFO - 'talos_options': ['--xperf_path', 07:00:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:00:06 INFO - 'tests': ['tp5n']}}, 07:00:06 INFO - 'talos.zip': {'path': '', 07:00:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:00:06 INFO - Running post-action listener: _resource_record_post_action 07:00:06 INFO - [mozharness: 2016-09-01 14:00:06.341372Z] Finished populate-webroot step (success) 07:00:06 INFO - [mozharness: 2016-09-01 14:00:06.341460Z] Running create-virtualenv step. 07:00:06 INFO - Running pre-action listener: _resource_record_pre_action 07:00:06 INFO - Running main action method: create_virtualenv 07:00:06 INFO - Creating virtualenv /builds/slave/test/build/venv 07:00:06 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 07:00:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:00:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:00:06 INFO - Using real prefix '/usr' 07:00:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:00:06 INFO - Installing distribute.............................................................................................................................................................................................done. 07:00:08 INFO - Installing pip.................done. 07:00:08 INFO - Return code: 0 07:00:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:00:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c570>, '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 0x1b8d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8d900>, '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': '9c3a94c35cc88655b05d2c08000001b2-1472737028.876801-1215529486', '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 07:00:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:00:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:00:08 INFO - Using env: {'DISPLAY': ':0', 07:00:08 INFO - 'HOME': '/home/cltbld', 07:00:08 INFO - 'LANG': 'en_US.UTF-8', 07:00:08 INFO - 'LANGUAGE': 'en_US:en', 07:00:08 INFO - 'LOGNAME': 'cltbld', 07:00:08 INFO - 'MAIL': '/var/mail/cltbld', 07:00:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:08 INFO - 'MOZ_NO_REMOTE': '1', 07:00:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:08 INFO - 'NO_EM_RESTART': '1', 07:00:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:08 INFO - 'PWD': '/builds/slave/test', 07:00:08 INFO - 'SHELL': '/bin/bash', 07:00:08 INFO - 'SHLVL': '1', 07:00:08 INFO - 'TERM': 'linux', 07:00:08 INFO - 'TMOUT': '86400', 07:00:08 INFO - 'USER': 'cltbld', 07:00:08 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1472737028.876801-1215529486', 07:00:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:08 INFO - '_': '/tools/buildbot/bin/python'} 07:00:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:09 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 07:00:09 INFO - Cleaning up... 07:00:09 INFO - Return code: 0 07:00:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:00: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')]} 07:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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')]} 07:00:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:09 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 0x18ce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c570>, '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 0x1b8d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8d900>, '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': '9c3a94c35cc88655b05d2c08000001b2-1472737028.876801-1215529486', '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 07:00:09 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 07:00:09 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 07:00:09 INFO - Using env: {'DISPLAY': ':0', 07:00:09 INFO - 'HOME': '/home/cltbld', 07:00:09 INFO - 'LANG': 'en_US.UTF-8', 07:00:09 INFO - 'LANGUAGE': 'en_US:en', 07:00:09 INFO - 'LOGNAME': 'cltbld', 07:00:09 INFO - 'MAIL': '/var/mail/cltbld', 07:00:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:09 INFO - 'MOZ_NO_REMOTE': '1', 07:00:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:09 INFO - 'NO_EM_RESTART': '1', 07:00:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:09 INFO - 'PWD': '/builds/slave/test', 07:00:09 INFO - 'SHELL': '/bin/bash', 07:00:09 INFO - 'SHLVL': '1', 07:00:09 INFO - 'TERM': 'linux', 07:00:09 INFO - 'TMOUT': '86400', 07:00:09 INFO - 'USER': 'cltbld', 07:00:09 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1472737028.876801-1215529486', 07:00:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:09 INFO - '_': '/tools/buildbot/bin/python'} 07:00:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:09 INFO - Downloading/unpacking psutil>=3.1.1 07:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:00:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:00:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:00:11 INFO - Installing collected packages: psutil 07:00:11 INFO - Running setup.py install for psutil 07:00:11 INFO - building 'psutil._psutil_linux' extension 07:00:11 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 07:00:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:00:11 INFO - building 'psutil._psutil_posix' extension 07:00:11 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 07:00:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:00:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:00:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:00:11 INFO - Successfully installed psutil 07:00:11 INFO - Cleaning up... 07:00:11 INFO - Return code: 0 07:00:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:00:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c570>, '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 0x1b8d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8d900>, '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': '9c3a94c35cc88655b05d2c08000001b2-1472737028.876801-1215529486', '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 07:00:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:00:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:00:11 INFO - Using env: {'DISPLAY': ':0', 07:00:11 INFO - 'HOME': '/home/cltbld', 07:00:11 INFO - 'LANG': 'en_US.UTF-8', 07:00:11 INFO - 'LANGUAGE': 'en_US:en', 07:00:11 INFO - 'LOGNAME': 'cltbld', 07:00:11 INFO - 'MAIL': '/var/mail/cltbld', 07:00:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:11 INFO - 'MOZ_NO_REMOTE': '1', 07:00:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:11 INFO - 'NO_EM_RESTART': '1', 07:00:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:11 INFO - 'PWD': '/builds/slave/test', 07:00:11 INFO - 'SHELL': '/bin/bash', 07:00:11 INFO - 'SHLVL': '1', 07:00:11 INFO - 'TERM': 'linux', 07:00:11 INFO - 'TMOUT': '86400', 07:00:11 INFO - 'USER': 'cltbld', 07:00:11 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1472737028.876801-1215529486', 07:00:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:11 INFO - '_': '/tools/buildbot/bin/python'} 07:00:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:00:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:00:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:00:13 INFO - Installing collected packages: mozsystemmonitor 07:00:13 INFO - Running setup.py install for mozsystemmonitor 07:00:14 INFO - Successfully installed mozsystemmonitor 07:00:14 INFO - Cleaning up... 07:00:14 INFO - Return code: 0 07:00:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:00:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:14 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 0x18ce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c570>, '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 0x1b8d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8d900>, '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': '9c3a94c35cc88655b05d2c08000001b2-1472737028.876801-1215529486', '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 07:00:14 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 07:00:14 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 07:00:14 INFO - Using env: {'DISPLAY': ':0', 07:00:14 INFO - 'HOME': '/home/cltbld', 07:00:14 INFO - 'LANG': 'en_US.UTF-8', 07:00:14 INFO - 'LANGUAGE': 'en_US:en', 07:00:14 INFO - 'LOGNAME': 'cltbld', 07:00:14 INFO - 'MAIL': '/var/mail/cltbld', 07:00:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:14 INFO - 'MOZ_NO_REMOTE': '1', 07:00:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:14 INFO - 'NO_EM_RESTART': '1', 07:00:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:14 INFO - 'PWD': '/builds/slave/test', 07:00:14 INFO - 'SHELL': '/bin/bash', 07:00:14 INFO - 'SHLVL': '1', 07:00:14 INFO - 'TERM': 'linux', 07:00:14 INFO - 'TMOUT': '86400', 07:00:14 INFO - 'USER': 'cltbld', 07:00:14 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1472737028.876801-1215529486', 07:00:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:14 INFO - '_': '/tools/buildbot/bin/python'} 07:00:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:14 INFO - Downloading/unpacking jsonschema==2.5.1 07:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:00:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:16 INFO - Downloading functools32-3.2.3-2.tar.gz 07:00:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:00:16 INFO - warning: no files found matching '*.txt' 07:00:16 INFO - no previously-included directories found matching 'build' 07:00:16 INFO - no previously-included directories found matching 'dist' 07:00:16 INFO - no previously-included directories found matching '.git*' 07:00:16 INFO - Installing collected packages: jsonschema, functools32 07:00:16 INFO - Running setup.py install for functools32 07:00:16 INFO - warning: no files found matching '*.txt' 07:00:16 INFO - no previously-included directories found matching 'build' 07:00:16 INFO - no previously-included directories found matching 'dist' 07:00:16 INFO - no previously-included directories found matching '.git*' 07:00:16 INFO - Successfully installed jsonschema functools32 07:00:16 INFO - Cleaning up... 07:00:16 INFO - Return code: 0 07:00:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:00: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')]} 07:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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')]} 07:00:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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', '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 0x18ce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c570>, '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 0x1b8d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8d900>, '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': '9c3a94c35cc88655b05d2c08000001b2-1472737028.876801-1215529486', '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 07:00: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:00: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 functools32==3.2.3-2 07:00:16 INFO - Using env: {'DISPLAY': ':0', 07:00:16 INFO - 'HOME': '/home/cltbld', 07:00:16 INFO - 'LANG': 'en_US.UTF-8', 07:00:16 INFO - 'LANGUAGE': 'en_US:en', 07:00:16 INFO - 'LOGNAME': 'cltbld', 07:00:16 INFO - 'MAIL': '/var/mail/cltbld', 07:00:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:16 INFO - 'MOZ_NO_REMOTE': '1', 07:00:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:16 INFO - 'NO_EM_RESTART': '1', 07:00:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:16 INFO - 'PWD': '/builds/slave/test', 07:00:16 INFO - 'SHELL': '/bin/bash', 07:00:16 INFO - 'SHLVL': '1', 07:00:16 INFO - 'TERM': 'linux', 07:00:16 INFO - 'TMOUT': '86400', 07:00:16 INFO - 'USER': 'cltbld', 07:00:16 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1472737028.876801-1215529486', 07:00:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:16 INFO - '_': '/tools/buildbot/bin/python'} 07:00:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:00:16 INFO - Cleaning up... 07:00:16 INFO - Return code: 0 07:00:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:00: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')]} 07:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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')]} 07:00:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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', '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 0x18ce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c570>, '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 0x1b8d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8d900>, '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': '9c3a94c35cc88655b05d2c08000001b2-1472737028.876801-1215529486', '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 07:00: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:00: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 blobuploader==1.2.4 07:00:16 INFO - Using env: {'DISPLAY': ':0', 07:00:16 INFO - 'HOME': '/home/cltbld', 07:00:16 INFO - 'LANG': 'en_US.UTF-8', 07:00:16 INFO - 'LANGUAGE': 'en_US:en', 07:00:16 INFO - 'LOGNAME': 'cltbld', 07:00:16 INFO - 'MAIL': '/var/mail/cltbld', 07:00:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:16 INFO - 'MOZ_NO_REMOTE': '1', 07:00:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:16 INFO - 'NO_EM_RESTART': '1', 07:00:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:16 INFO - 'PWD': '/builds/slave/test', 07:00:16 INFO - 'SHELL': '/bin/bash', 07:00:16 INFO - 'SHLVL': '1', 07:00:16 INFO - 'TERM': 'linux', 07:00:16 INFO - 'TMOUT': '86400', 07:00:16 INFO - 'USER': 'cltbld', 07:00:16 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1472737028.876801-1215529486', 07:00:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:16 INFO - '_': '/tools/buildbot/bin/python'} 07:00:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:17 INFO - Downloading/unpacking blobuploader==1.2.4 07:00:17 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 07:00:17 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 07:00:17 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 07:00:17 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 07:00:17 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 07:00:17 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 07:00:19 INFO - Downloading blobuploader-1.2.4.tar.gz 07:00:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:00:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:00:19 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 07:00:19 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 07:00:19 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 07:00:19 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 07:00:19 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 07:00:19 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 07:00:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:00:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:00:19 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 07:00:19 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 07:00:19 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 07:00:19 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 07:00:19 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 07:00:19 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 07:00:19 INFO - Downloading docopt-0.6.1.tar.gz 07:00:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:00:19 INFO - Installing collected packages: blobuploader, requests, docopt 07:00:19 INFO - Running setup.py install for blobuploader 07:00:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:00:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:00:19 INFO - Running setup.py install for requests 07:00:20 INFO - Running setup.py install for docopt 07:00:20 INFO - Successfully installed blobuploader requests docopt 07:00:20 INFO - Cleaning up... 07:00:20 INFO - Return code: 0 07:00:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:00:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:20 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 0x18ce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c570>, '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 0x1b8d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8d900>, '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': '9c3a94c35cc88655b05d2c08000001b2-1472737028.876801-1215529486', '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 07:00:20 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 07:00:20 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 07:00:20 INFO - Using env: {'DISPLAY': ':0', 07:00:20 INFO - 'HOME': '/home/cltbld', 07:00:20 INFO - 'LANG': 'en_US.UTF-8', 07:00:20 INFO - 'LANGUAGE': 'en_US:en', 07:00:20 INFO - 'LOGNAME': 'cltbld', 07:00:20 INFO - 'MAIL': '/var/mail/cltbld', 07:00:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:20 INFO - 'MOZ_NO_REMOTE': '1', 07:00:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:20 INFO - 'NO_EM_RESTART': '1', 07:00:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:20 INFO - 'PWD': '/builds/slave/test', 07:00:20 INFO - 'SHELL': '/bin/bash', 07:00:20 INFO - 'SHLVL': '1', 07:00:20 INFO - 'TERM': 'linux', 07:00:20 INFO - 'TMOUT': '86400', 07:00:20 INFO - 'USER': 'cltbld', 07:00:20 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1472737028.876801-1215529486', 07:00:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:20 INFO - '_': '/tools/buildbot/bin/python'} 07:00:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:00:20 INFO - Running setup.py (path:/tmp/pip-vZyc3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:00:20 INFO - Running setup.py (path:/tmp/pip-O6a0U8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:00:20 INFO - Running setup.py (path:/tmp/pip-1felOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:00:20 INFO - Running setup.py (path:/tmp/pip-SN_5VP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:00:20 INFO - Running setup.py (path:/tmp/pip-8hzsQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:00:20 INFO - Running setup.py (path:/tmp/pip-CpFktO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:00:21 INFO - Running setup.py (path:/tmp/pip-0eG7SS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:00:21 INFO - Running setup.py (path:/tmp/pip-PcZfFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:00:21 INFO - Running setup.py (path:/tmp/pip-QWw2hX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:00:21 INFO - Running setup.py (path:/tmp/pip-4eCbTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:00:21 INFO - Running setup.py (path:/tmp/pip-s6KDB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:00:21 INFO - Running setup.py (path:/tmp/pip-clCgMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:00:21 INFO - Running setup.py (path:/tmp/pip-sRJjg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:00:21 INFO - Running setup.py (path:/tmp/pip-tFNVf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:00:21 INFO - Running setup.py (path:/tmp/pip-avUpC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:00:21 INFO - Running setup.py (path:/tmp/pip-zHI2rA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:00:21 INFO - Running setup.py (path:/tmp/pip-HM5izG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:00:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:00:21 INFO - Running setup.py install for manifestparser 07:00:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:00:21 INFO - Running setup.py install for mozcrash 07:00:22 INFO - Running setup.py install for mozdebug 07:00:22 INFO - Running setup.py install for mozdevice 07:00:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:00:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:00:22 INFO - Running setup.py install for mozfile 07:00:22 INFO - Running setup.py install for mozhttpd 07:00:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:00:22 INFO - Running setup.py install for mozinfo 07:00:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:00:22 INFO - Running setup.py install for mozInstall 07:00:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:00:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:00:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:00:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:00:22 INFO - Running setup.py install for mozleak 07:00:22 INFO - Running setup.py install for mozlog 07:00:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:00:22 INFO - Running setup.py install for moznetwork 07:00:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:00:22 INFO - Running setup.py install for mozprocess 07:00:23 INFO - Running setup.py install for mozprofile 07:00:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:00:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:00:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:00:23 INFO - Running setup.py install for mozrunner 07:00:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:00:23 INFO - Running setup.py install for mozscreenshot 07:00:23 INFO - Running setup.py install for moztest 07:00:23 INFO - Running setup.py install for mozversion 07:00:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:00:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:00:23 INFO - Cleaning up... 07:00:23 INFO - Return code: 0 07:00:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:00:23 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')]} 07:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:23 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')]} 07:00:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:23 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 0x18ce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c570>, '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 0x1b8d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8d900>, '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': '9c3a94c35cc88655b05d2c08000001b2-1472737028.876801-1215529486', '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 07:00:23 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 07:00:23 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 07:00:23 INFO - Using env: {'DISPLAY': ':0', 07:00:23 INFO - 'HOME': '/home/cltbld', 07:00:23 INFO - 'LANG': 'en_US.UTF-8', 07:00:23 INFO - 'LANGUAGE': 'en_US:en', 07:00:23 INFO - 'LOGNAME': 'cltbld', 07:00:23 INFO - 'MAIL': '/var/mail/cltbld', 07:00:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:23 INFO - 'MOZ_NO_REMOTE': '1', 07:00:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:23 INFO - 'NO_EM_RESTART': '1', 07:00:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:23 INFO - 'PWD': '/builds/slave/test', 07:00:23 INFO - 'SHELL': '/bin/bash', 07:00:23 INFO - 'SHLVL': '1', 07:00:23 INFO - 'TERM': 'linux', 07:00:23 INFO - 'TMOUT': '86400', 07:00:23 INFO - 'USER': 'cltbld', 07:00:23 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1472737028.876801-1215529486', 07:00:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:23 INFO - '_': '/tools/buildbot/bin/python'} 07:00:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:00:23 INFO - Running setup.py (path:/tmp/pip-ALxMZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:00:23 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)) 07:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:00:23 INFO - Running setup.py (path:/tmp/pip-XOHSgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:00:24 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)) 07:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:00:24 INFO - Running setup.py (path:/tmp/pip-uXs7y6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:00:24 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)) 07:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:00:24 INFO - Running setup.py (path:/tmp/pip-kCxxOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:00:24 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)) 07:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:00:24 INFO - Running setup.py (path:/tmp/pip-VqJR5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:00:24 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)) 07:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:00:24 INFO - Running setup.py (path:/tmp/pip-JuzEPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:00:24 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)) 07:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:00:24 INFO - Running setup.py (path:/tmp/pip-37xY6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:00:24 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)) 07:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:00:24 INFO - Running setup.py (path:/tmp/pip-P1PO1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:00:24 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)) 07:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:00:24 INFO - Running setup.py (path:/tmp/pip-6gxHSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:00:24 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)) 07:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:00:24 INFO - Running setup.py (path:/tmp/pip-SCWqwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:00:24 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)) 07:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:00:24 INFO - Running setup.py (path:/tmp/pip-v6psEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:00:24 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)) 07:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:00:24 INFO - Running setup.py (path:/tmp/pip-qSzL22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:00:24 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)) 07:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:00:24 INFO - Running setup.py (path:/tmp/pip-fDYi8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:00:24 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)) 07:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:00:24 INFO - Running setup.py (path:/tmp/pip-8i3oka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:00:24 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)) 07:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:00:24 INFO - Running setup.py (path:/tmp/pip-AtxmNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:00:24 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)) 07:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:00:24 INFO - Running setup.py (path:/tmp/pip-ZRjFJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:00:25 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)) 07:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:00:25 INFO - Running setup.py (path:/tmp/pip-E_ox8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:00:25 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)) 07:00:25 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)) 07:00:25 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)) 07:00:25 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)) 07:00:25 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)) 07:00:25 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)) 07:00:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:27 INFO - Downloading blessings-1.6.tar.gz 07:00:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:00:27 INFO - Installing collected packages: blessings 07:00:27 INFO - Running setup.py install for blessings 07:00:27 INFO - Successfully installed blessings 07:00:27 INFO - Cleaning up... 07:00:27 INFO - Return code: 0 07:00:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:00:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:00:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:00:27 INFO - Reading from file tmpfile_stdout 07:00:27 INFO - Current package versions: 07:00:27 INFO - argparse == 1.2.1 07:00:27 INFO - blessings == 1.6 07:00:27 INFO - blobuploader == 1.2.4 07:00:27 INFO - docopt == 0.6.1 07:00:27 INFO - functools32 == 3.2.3-2 07:00:27 INFO - jsonschema == 2.5.1 07:00:27 INFO - manifestparser == 1.1 07:00:27 INFO - mozInstall == 1.12 07:00:27 INFO - mozcrash == 0.17 07:00:27 INFO - mozdebug == 0.1 07:00:27 INFO - mozdevice == 0.48 07:00:27 INFO - mozfile == 1.2 07:00:27 INFO - mozhttpd == 0.7 07:00:27 INFO - mozinfo == 0.9 07:00:27 INFO - mozleak == 0.1 07:00:27 INFO - mozlog == 3.3 07:00:27 INFO - moznetwork == 0.27 07:00:27 INFO - mozprocess == 0.23 07:00:27 INFO - mozprofile == 0.28 07:00:27 INFO - mozrunner == 6.12 07:00:27 INFO - mozscreenshot == 0.1 07:00:27 INFO - mozsystemmonitor == 0.3 07:00:27 INFO - moztest == 0.7 07:00:27 INFO - mozversion == 1.4 07:00:27 INFO - psutil == 3.1.1 07:00:27 INFO - requests == 1.2.3 07:00:27 INFO - wsgiref == 0.1.2 07:00:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:00:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:27 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 0x18ce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c570>, '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 0x1b8d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8d900>, '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': '9c3a94c35cc88655b05d2c08000001b2-1472737028.876801-1215529486', '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 07:00:27 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 07:00:27 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 07:00:27 INFO - Using env: {'DISPLAY': ':0', 07:00:27 INFO - 'HOME': '/home/cltbld', 07:00:27 INFO - 'LANG': 'en_US.UTF-8', 07:00:27 INFO - 'LANGUAGE': 'en_US:en', 07:00:27 INFO - 'LOGNAME': 'cltbld', 07:00:27 INFO - 'MAIL': '/var/mail/cltbld', 07:00:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:27 INFO - 'MOZ_NO_REMOTE': '1', 07:00:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:27 INFO - 'NO_EM_RESTART': '1', 07:00:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:27 INFO - 'PWD': '/builds/slave/test', 07:00:27 INFO - 'SHELL': '/bin/bash', 07:00:27 INFO - 'SHLVL': '1', 07:00:27 INFO - 'TERM': 'linux', 07:00:27 INFO - 'TMOUT': '86400', 07:00:27 INFO - 'USER': 'cltbld', 07:00:27 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1472737028.876801-1215529486', 07:00:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:27 INFO - '_': '/tools/buildbot/bin/python'} 07:00:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:27 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)) 07:00:27 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)) 07:00:27 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)) 07:00:27 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)) 07:00:27 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)) 07:00:27 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)) 07:00:27 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)) 07:00:27 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)) 07:00:27 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)) 07:00:27 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)) 07:00:27 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)) 07:00:27 INFO - Cleaning up... 07:00:27 INFO - Return code: 0 07:00:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:00:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c570>, '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 0x1b8d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8d900>, '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': '9c3a94c35cc88655b05d2c08000001b2-1472737028.876801-1215529486', '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 07:00:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:00:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:00:27 INFO - Using env: {'DISPLAY': ':0', 07:00:27 INFO - 'HOME': '/home/cltbld', 07:00:27 INFO - 'LANG': 'en_US.UTF-8', 07:00:27 INFO - 'LANGUAGE': 'en_US:en', 07:00:27 INFO - 'LOGNAME': 'cltbld', 07:00:27 INFO - 'MAIL': '/var/mail/cltbld', 07:00:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:27 INFO - 'MOZ_NO_REMOTE': '1', 07:00:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:27 INFO - 'NO_EM_RESTART': '1', 07:00:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:27 INFO - 'PWD': '/builds/slave/test', 07:00:27 INFO - 'SHELL': '/bin/bash', 07:00:27 INFO - 'SHLVL': '1', 07:00:27 INFO - 'TERM': 'linux', 07:00:27 INFO - 'TMOUT': '86400', 07:00:27 INFO - 'USER': 'cltbld', 07:00:27 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1472737028.876801-1215529486', 07:00:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:27 INFO - '_': '/tools/buildbot/bin/python'} 07:00:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:00:27 INFO - Cleaning up... 07:00:27 INFO - Return code: 0 07:00:27 INFO - Running post-action listener: _resource_record_post_action 07:00:27 INFO - Running post-action listener: _start_resource_monitoring 07:00:27 INFO - Starting resource monitoring. 07:00:27 INFO - [mozharness: 2016-09-01 14:00:27.946241Z] Finished create-virtualenv step (success) 07:00:27 INFO - [mozharness: 2016-09-01 14:00:27.946668Z] Running install step. 07:00:27 INFO - Running pre-action listener: _resource_record_pre_action 07:00:27 INFO - Running main action method: install 07:00:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:00:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:00:28 INFO - Reading from file tmpfile_stdout 07:00:28 INFO - Detecting whether we're running mozinstall >=1.0... 07:00:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:00:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:00:28 INFO - Reading from file tmpfile_stdout 07:00:28 INFO - Output received: 07:00:28 INFO - Usage: mozinstall [options] installer 07:00:28 INFO - Options: 07:00:28 INFO - -h, --help show this help message and exit 07:00:28 INFO - -d DEST, --destination=DEST 07:00:28 INFO - Directory to install application into. [default: 07:00:28 INFO - "/builds/slave/test"] 07:00:28 INFO - --app=APP Application being installed. [default: firefox] 07:00:28 INFO - mkdir: /builds/slave/test/build/application 07:00:28 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'] 07:00:28 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 07:00:44 INFO - Reading from file tmpfile_stdout 07:00:44 INFO - Output received: 07:00:44 INFO - /builds/slave/test/build/application/firefox/firefox 07:00:44 INFO - Running post-action listener: _resource_record_post_action 07:00:44 INFO - [mozharness: 2016-09-01 14:00:44.786953Z] Finished install step (success) 07:00:44 INFO - [mozharness: 2016-09-01 14:00:44.787225Z] Running run-tests step. 07:00:44 INFO - Running pre-action listener: _resource_record_pre_action 07:00:44 INFO - Running main action method: run_tests 07:00:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:00:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:00:44 INFO - Python 2.7.3 07:00:44 INFO - Return code: 0 07:00:44 INFO - grabbing minidump binary from tooltool 07:00:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:44 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c570>, '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 0x1b8d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8d900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:00:44 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:00:44 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:00:44 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 07:00:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:00:44 INFO - Return code: 0 07:00:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:00:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:00:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:00:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:00:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:00:44 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/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 07:00:44 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/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 07:00:44 INFO - Using env: {'DISPLAY': ':0', 07:00:44 INFO - 'HOME': '/home/cltbld', 07:00:44 INFO - 'LANG': 'en_US.UTF-8', 07:00:44 INFO - 'LANGUAGE': 'en_US:en', 07:00:44 INFO - 'LOGNAME': 'cltbld', 07:00:44 INFO - 'MAIL': '/var/mail/cltbld', 07:00:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:00:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:00:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:44 INFO - 'MOZ_NO_REMOTE': '1', 07:00:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:00:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:44 INFO - 'NO_EM_RESTART': '1', 07:00:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:44 INFO - 'PWD': '/builds/slave/test', 07:00:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:00:44 INFO - 'SHELL': '/bin/bash', 07:00:44 INFO - 'SHLVL': '1', 07:00:44 INFO - 'TERM': 'linux', 07:00:44 INFO - 'TMOUT': '86400', 07:00:44 INFO - 'USER': 'cltbld', 07:00:44 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1472737028.876801-1215529486', 07:00:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:44 INFO - '_': '/tools/buildbot/bin/python'} 07:00:44 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/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 07:00:45 INFO - mozversion application_buildid: 20160830093921 07:00:45 INFO - mozversion application_changeset: c819e284a13937fc955c2efb6da7fdf9c5bb8b88 07:00:45 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:00:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:00:45 INFO - mozversion application_name: Firefox 07:00:45 INFO - mozversion application_remotingname: firefox-dev 07:00:45 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:00:45 INFO - mozversion application_vendor: Mozilla 07:00:45 INFO - mozversion application_version: 50.0a2 07:00:45 INFO - mozversion platform_buildid: 20160830093921 07:00:45 INFO - mozversion platform_changeset: c819e284a13937fc955c2efb6da7fdf9c5bb8b88 07:00:45 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:00:45 INFO - mozversion platform_version: 50.0a2 07:00:45 INFO - using testdate: 1472738445 07:00:45 INFO - actual date: 1472738445 07:00:45 INFO - starting webserver on 'localhost:35032' 07:00:45 INFO - SUITE-START | Running 2 tests 07:00:45 INFO - TEST-START | dromaeo_css 07:00:45 INFO - operating with platform_type : linux_ 07:00:45 INFO - Initialising browser for dromaeo_css test... 07:00:45 INFO - TEST-INFO | started process 11491 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHTyEIH/profile http://localhost:35032/getInfo.html) 07:00:49 INFO - PROCESS | 11491 | __metrics Screen width/height:1600/1200 07:00:49 INFO - PROCESS | 11491 | colorDepth:24 07:00:49 INFO - PROCESS | 11491 | Browser inner width/height: 1024/697 07:00:49 INFO - PROCESS | 11491 | __metrics 07:00:50 ERROR - PROCESS | 11491 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 07:00:51 INFO - TEST-INFO | 11491: exit 0 07:00:51 INFO - Browser initialized. 07:00:51 INFO - Running cycle 1/1 for dromaeo_css test... 07:00:51 INFO - TEST-INFO | started process 11613 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHTyEIH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:01:03 INFO - PROCESS | 11613 | RSS: Main: 152727552 07:01:03 INFO - PROCESS | 11613 | 07:01:52 INFO - PROCESS | 11613 | 1472738512798 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] 07:04:01 INFO - PROCESS | 11613 | Cycle 1(1): loaded http://localhost:35032/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35032/tests/dromaeo/cssquery-ext.html) 07:04:02 INFO - PROCESS | 11613 | RSS: Main: 158175232 07:04:02 INFO - PROCESS | 11613 | 07:07:04 INFO - PROCESS | 11613 | Cycle 1(1): loaded http://localhost:35032/tests/dromaeo/cssquery-ext.html (next: http://localhost:35032/tests/dromaeo/cssquery-jquery.html) 07:07:05 INFO - PROCESS | 11613 | RSS: Main: 154271744 07:07:05 INFO - PROCESS | 11613 | 07:10:06 INFO - PROCESS | 11613 | Cycle 1(1): loaded http://localhost:35032/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35032/tests/dromaeo/cssquery-mootools.html) 07:10:07 INFO - PROCESS | 11613 | RSS: Main: 154963968 07:10:07 INFO - PROCESS | 11613 | 07:13:09 INFO - PROCESS | 11613 | Cycle 1(1): loaded http://localhost:35032/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35032/tests/dromaeo/cssquery-prototype.html) 07:13:09 INFO - PROCESS | 11613 | RSS: Main: 152756224 07:13:09 INFO - PROCESS | 11613 | 07:16:12 INFO - PROCESS | 11613 | Cycle 1(1): loaded http://localhost:35032/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35032/tests/dromaeo/cssquery-yui.html) 07:16:13 INFO - PROCESS | 11613 | RSS: Main: 155541504 07:16:13 INFO - PROCESS | 11613 | 07:19:15 INFO - PROCESS | 11613 | Cycle 1(1): loaded http://localhost:35032/tests/dromaeo/cssquery-yui.html (next: http://localhost:35032/tests/dromaeo/cssquery-dojo.html) 07:19:15 INFO - PROCESS | 11613 | RSS: Main: 156151808 07:19:15 INFO - PROCESS | 11613 | 07:19:15 INFO - PROCESS | 11613 | __start_tp_report 07:19:15 INFO - PROCESS | 11613 | _x_x_mozilla_page_load 07:19:15 INFO - PROCESS | 11613 | _x_x_mozilla_page_load_details 07:19:15 INFO - PROCESS | 11613 | |i|pagename|runs| 07:19:15 INFO - PROCESS | 11613 | |0;dojo.html;3352.3295340931813;3378.983105084474;3389.864405423783;3402.829858507074;3405.710514606258;5824.563157763168;5947.256592925884;5958.940410595898;5959.731812068457;5964.403559644044;5892.2929248490245;5960.880782384361;5972.104184372346;5974.462298393144;5985.730642121104;5384.703841288728;5406.945930540684;5470.835874923759;5488.313960754906;5492.286002819648;5329.840104796843;5336.332958380202;5348.037353276409;5384.246205531229;5390.137577987503;5328.280682107905;5382.4886635769535;5385.703786291752;5388.218708287296;5454.672719636835;5392.379876314196;5409.215663728757;5448.700321482317;5459.535939445152;5464.508194262496;5102.056119617882;5194.844154675366;5216.895662086737;5325.8934821303355;5347.278117454132;5769.798057067983;5797.565182611321;5804.390538993429;5853.443922827325;5899.7050147492455;6238.906416403757;6314.305426403092;6317.526185536103;6342.714577844008;6352.555321127523;6087.634741915455;6237.625742455467;6293.433590976834;6356.460738626742;6365.809025729235;5934.910976335358;5942.138389933479;5945.31628862682;5946.583739138262;5985.072313791369;6473.676316184172;6495.68050697987;6534.771283005072;6537.34626537352;6569.343065693392;6031.819045428644;6125.4487096160665;6137.048757442603;6274.717637706314;6289.842753931097;6269.905951410732;6291.716872740738;6315.494760419156;6326.620402775849;6367.808965731036;6276.435120839055;6281.152044474029;6286.402791734778;6312.589681670676;6323.114763933053;6137.140800287963;6139.754409823647;6175.382461753788;6258.874822503524;6318.4313411793155;4737.8341758038305;4794.568488836021;4794.640401969867;4818.445878723992;4843.4430040545085;4257.914841703148;4266.31738921771;4274.829006839754;4304.203722311382;4307.246231909466;5858.121281807677;5966.19456373384;6095.05526643371;6098.69506524672;6104.17593624855;6236.064590311399;6374.713137908805;6375.6174629522375;6402;6436.195475565554;6083.969580152071;6101;6135.294441139326;6141.416565426277;6159.568830181934;5283.947160528345;5405.243265942771;5419.83740487786;5506.669599824023;5546.4453554644215;6631.966840165768;6633.104530888365;6636.8672626547195;6637.23671777742;6651.600903945779;6348.079528468254;6375.4262116409745;6390.073439351361;6401.8719625608155;6407.807765767035;6350.333215012357;6482.513811464065;6526.934730652632;6613.570117942319;6622.403983641495;6262.780802671885;6269.96865015672;6304.464120549805;6311.116443697794;6342.048692696132;6373.012183111625;6432.13166222554;6456.870862582816;6459.61242325462;6466.870662586628;5995.580309378476;6132.264128304632;6140.381550880894;6274.749010039547;6293.213348331458;6192.349803270592;6195.876082478415;6201.131841542278;6203.96898015507;6210.813675589558;6187.071939209155;6188.257409110755;6190.690465476799;6199.318075011655;6202.379762023762;6078.422549857756;6165.876682466415;6201.534884883742;6258.718357673824;6272.717727702173;6020.1270815730595;6100.816975490742;6119.8776024478375;6120.081455037822;6142 07:19:15 INFO - PROCESS | 11613 | |1;ext.html;586.9530437564995;633.8098570428871;652.960822350659;657.8421178917058;693.3274723518185;45039.774801126034;46191.769041154745;46195.76902115485;46307.76846115769;46633;46329.7683511582;46922.53077469224;46944;46974.53025469744;47086;9131.863022054675;9253.213476854475;9275.628974840998;9294.58174382151;9296.44221346718;9212.72361829143;9230.307726920475;9255.53722313885;9278.536073196346;9291.581878815436;9327.76680582984;9328.207102396305;9355.298352623546;9371.39085959414;9384;9324.347295689304;9325.860112098324;9357.859632105525;9360.204382627484;9368.765780855465;9161.404508706979;9170.541472926327;9227;9240;9242.168204861528;42873;42905.785471072755;43277.56722432767;43334.78332608317;43335.78332108351;3762.548494180716;3874.6512813846607;3967.6429121378924;4016.5380981187245;4058.5738497457637;34404.65595344039;34571.30857382863;35154.12114697127;35855.282894341966;36434.8178259107;4287.2711639021445;4319.892002699958;4331.371951067078;4446.710963787344;4486.237339652267;380119;382934;384788;384825;387979;63251.683741581;63355.366446335865;63661;63736.68131659312;63866.36133638604;39833.20333593312;40849.795751021054;40856.38715419271;43012.13975720531;66136.6693166531;18609.255629774656;18723.531911702317;18790.624187516172;18802.811971880106;18805.341813036477;13881.930590346983;13962.371693273826;13977.301134943416;13979.510717125055;13990;20657.380278591667;20857.89571052135;20865.79134208669;21079.8946005269;21122.788772112388;7624.847503049908;7660.8508723690775;7670.884936725954;7801.531908085533;7864.252895974873;1042.1506472225112;1087.4065354130298;1133.0595605647293;1154.1286328821686;1173.5423184957874;34137.65862341395;34285.82857085699;34310.14224644354;34325.313493729984;34372.656273437446;1193.20651766576;1200.3458115327167;1213.9089568282413;1218.2081646929566;1257.7798885195236;17655.911720441316;17811.46565603034;17840.3755868544;17875.73186402205;17902.820971790115;543736;552421;556375;558957;559097;42886.78556607197;42955.570444295154;43012.13975720468;43229;43269;1402.6283034995733;1440.7622742247622;1453.11360070357;1463.3049301581664;1471.587955372476;32919.34161316808;33813.81651642181;33923.83038084794;33942.83028584841;34462;56112.719436402556;56172.438275618355;56518;56548.43451565432;56553.71723141358;517473;521634;521945;524138;524991;30917.227069322547;30989;31149.688503114678;31218.687813121578;31362.68637313689;52732.20901686555;53253.201201981225;53644;53846;54333;43384.13231735411;44377.77811110924;44746;48863.267050994975;49303;46244.988151540085;46629.53370466252;46929.2960605598;47059.76470117764;47310.76344618255;44713.55286447094;45387.319190211514;45515;46185;47878.760606196745;40052.39921401123;40338;40765.38851917164;40809.59190408058;40878.182436350515;29428.411431771674;29800.10599682013;30432.543511846896;30468.84765576158;30559.2360190997 07:19:15 INFO - PROCESS | 11613 | |2;jquery.html;417.8203372549804;422.9365595160726;424.4715329414879;426.5137742973009;449.3596624809645;18194.09029548522;18933.526661833443;19550.608987820237;20939.162433502643;21048.052837622305;20351.796482035214;20420.285290014814;20543.691844622343;21049.26327578535;21052.89473552634;5822.796202132916;6027.457528822405;6029.69851507425;6036.547258955596;6037.094435834616;5852.151438041481;5856.5314774818125;5864.296284445851;5931.258592675916;5941.792037278696;5914.083317085859;5936;5940.673262970535;5947.881042379171;5960.672163031031;5869.530437565006;5907.586468947197;5934.673592952386;5950.7917222896995;5960.791372301948;5193.818216362409;5350.464953504657;5374.596905232123;5377.946220537784;5379.112446446332;24212.878935605386;24527.509449810903;24863;25006.874965625237;25085.87457062703;2448.4123810285405;2468.7037555493457;2491.9003239870385;2537.172410363508;2645.2196602002455;15713;15879.206039697969;15937.123458209793;16086.356545738156;16268.593285167966;1989.7512810898638;2051.8974051297523;2110.5884352551257;2129.8402619803423;2184.1045171479777;83238.58380708119;84498.57750711207;86369.56815216009;86900;87685.56157219173;11397.145214108808;11440;11547.884521154681;11873.346965916957;11912.285262884254;16609.41867034648;16630.417935372203;16638.667226655398;16643.33426662944;16662.4168154114;8761.34289928258;8764.5179515126;8786.516741579275;9029.729108126767;9037.051109633525;8812.16284452976;8845.248153906861;8933.240674542607;8949.284057275403;9059.909400906039;7065.258147894499;7137.4290056795335;7174.246704096099;7217.530860494051;7218.27817218274;2014.7280117184287;2057.907394167266;2100.6113868934294;2101.8423618228694;2153.7415510138885;977.9853302200472;1033.8914413986574;1122.6183097746805;1133.7335726104359;1206.740550781586;21339.46651333729;21454.678179827002;21727.67408488874;21728.13087476515;22063.66904496434;1094.8686157661132;1105.4196546812987;1116;1125.3529220697967;1140.749035212252;9825.901740982641;12274.772522747833;12360.072994525266;12426.502939882303;12479.875201248053;401149;401264;402860;526377.0163898539;552486;92429.53785231031;92831.06322829345;99232;105451;107049;1062.8086944349936;1094.8850370710961;1100.7468282295117;1102.393683474102;1104.116706634673;16444.83555164481;17729.645407092044;18650.81349186491;18952.348833518423;19208.615827683647;44412;44438;44718.55281447144;45272;45622.771886140355;64348.678256608415;64684;65509.67245163744;65675;65701.34298656952;8042.517448953082;8277;8350.457220280663;8985.415947963362;9309.44143351401;10724.785504290026;13731.931340343235;13923;14189.574312770634;14621.488247911271;11547.307161570332;12031.45858436355;12374.81437778452;12411.875881241072;12547.749045018865;11986;12030.15788894804;12054.819177712518;12254.75490490203;12311.138220324492;12374.14387841831;12546.435410406737;12568.445116625033;12571.30857802793;12847.550335738204;8017.118117007008;8107.22981316774;8234.05308389543;8443.00425430418;8871.068537803438;8958;11445.542178312775;11524.250923689933;11617;11676.241044332091 07:19:15 INFO - PROCESS | 11613 | |3;mootools.html;1569.5212960047184;1582.1614544291526;1751.6584266068114;1854.471475629445;1863.245385618823;8727.476351418904;9286.953565232172;9479.47862867542;9985.450800205996;9989.051040151184;9486.620535178601;9768.462734549597;9798.216142708585;9805.31362804604;9816.607335706563;2495.0892924082714;2502.4995000999784;2513.7863281621085;2523.3313172009434;2530.051230788454;2470.777630013298;2476.4304210031705;2484.627305904111;2485.962710559343;2490.091116742385;2478.355627536844;2489.4647650755082;2519.143491212987;2527.128140791424;2527.9873600632063;2445.254197469771;2454.656348111257;2459.7909177719916;2465.2604218734396;2475.8266921315517;2449.7550244975537;2450.889709963056;2466.1245257933533;2487.5398051360376;2488.8755562222;9758.512074396253;9865.260105492116;9891.703248902473;9918.30571859963;9933.3543319684;5511.366192887829;5675.347335056439;5677.971610141964;5703.230063941398;5704.429557044304;3536.504889315498;3718.7768733876055;3793.487879136309;3820.59883712209;3848.5381754189675;1260.7730608490467;1287.5429222625926;1296.572131196703;1323.0540163782941;1337.2511393619507;13167.473301067947;13361.66595835102;13497.730045399136;13876.444942202299;13936.233507157101;4942.9752851236235;4955.90088198234;4964.776585053682;5021.548060674557;5105.285260063594;10836.295640783324;10837.133029357632;10865.239433239598;10865.619703310345;10902.291351062155;5672.914906276409;5715.685637289989;5725.026745453283;5726.398728133569;5737.3688894221605;4752.405949256343;5122.590192784568;5231.136862417735;5244.606654500852;5375.3012108425655;4073.383388172322;4148.730332528376;4205.222033923734;4231.555686652919;4314.7626880521875;1200.0759415250384;1221.6640423883325;1227.8833510816457;1230.0528592983533;1239.8388209532702;966.6568368229177;1062.3148069495132;1062.5324857062867;1080.3949788118678;1104.4643347976225;6437.324080971431;6466.159399278158;6552.082708420825;6587.110740050128;6762.256151823295;502.51005269861594;515.2014377714602;1111.072254667362;1124.522078116797;1155.607093588184;4489.685721999494;4522.547745225451;4627.259638457831;4700.858974230779;4768.451628062748;12076.396180190955;12154.33151176676;12349.691257718629;12375.443105060294;12399.75200496003;11628.94185529067;11945.343006134572;12238.449269782881;12273.93863030697;12288.692782680504;8952.283817294601;9105.408148470327;9137.908620913706;9162.587683554257;9179.127982841754;6720.831979200363;6759.831004224934;6823.249442561413;6842.521023528305;6842.794716158523;11062.170337224901;11343.546258149581;11353.943230283796;11395.601153959571;11501.712457188303;11175.161862860155;11454.08367330595;11742.178047536932;11811.881881181422;11843.111766617365;8777.297816174818;8954;8995.100489950952;9156.084391560791;9437.905620943702;9676.467794271382;9766.658166964122;9771.755706107404;9788.314817962959;9790.657326993522;8154.388420868578;8261.504309741435;8430.325573954191;8459.746207613782;8576.656933722581;8043.477173983672;8359.707410240613;8389.916100839158;8529.317654587494;8531.95734021326;7662.233776622294;7746.65140068687;7819.648115834915;7827.765167044998;7841;5605.719714014364;5821.854453638693;5864.530837533072;5889.381614930542;5947.345791962967;5722.599418040697;5788.247527821356;5851.414858514115;5888.558358123072;5909.3795151508475 07:19:15 INFO - PROCESS | 11613 | |4;prototype.html;345.1096171876557;349.54384528190735;353.20352604876;356.52760092876946;362.09295714235844;5820.148127417567;5875.676837773921;5883.294004719429;5885.205497257874;5892.351841297459;5751.4536119068725;5800.53595712343;5803.419658034194;5829.825105246839;5840.8247752567495;4333.306670932651;4437.134758722051;4471;4489.306416150316;4507.867032412475;4492.191405547001;4497.168023915569;4500.369948207237;4502.797374118156;4507.278835386339;4472.619827314682;4472.910541789162;4492.910141797162;4502.48221454532;4505.121501307246;4435.578620031092;4444.911101777979;4476.127155204753;4493.708208813496;4505.977470112662;3941.8423263069444;3954.6638535724496;3958.5051868516434;3968.523777146732;3982.681385489183;5639.492445679867;5646.85882852932;5658.094704847204;5660.2075709400715;5689.573282003825;5123.333966584358;5171.3535808024;5198.714070726109;5208.479152084799;5229.189475631283;6070.878582428327;6073.908891366633;6088.786892458787;6095.786647467362;6117.5717699761035;4422.358757980075;4434.401355816955;4438.15675021748;4447;4453.376527286183;5888.499477544414;6123.4488895999575;6142.293636231846;6270.937290627081;6329.303776584618;4380.145871555016;4382.496012958487;4384.693071484965;4430.712003719748;4440.4005459263235;4465.933011004838;4469.34634185347;4480.260756975063;4485.282354823213;4493.505714371417;5016.222485514678;5153.974230128825;5162.225666150108;5173.922391164136;5197.24639927216;6133.405314618142;6136.417040381157;6136.815895523141;6140.324564297924;6146.602824898293;1532.1496569404087;1560.2042958091229;1562.2969663651402;1564.0615630621764;1570.4581919237844;970.9223262139012;1000.0449570660003;1002.9097381235724;1008.5461542305845;1027.4041056187393;5188.63679542436;5193.792248310101;5207.739613019409;5214.687118772886;5251.921221181686;5448.591355648342;5539.7840863654865;5551.472610102034;5551.583631227674;5573.6098473106495;4962.925556116661;5182;5236.554892834076;5328.014317351302;5329.282066146293;2942.514485109976;2954.335274563206;2981.2248815307744;2989.701029896993;2997.3405850712807;5664.8867022659315;5712.6286791358425;5716.370469583955;5722.141678748221;5752.338481074647;5952.494038006731;6369.108324834434;6423.325550817097;6473.514486413538;6487;6560.606363618198;6562.2453417856605;6563.260735904989;6580.901286480706;6669.399754022064;6121.632702037892;6192.628442293477;6242.282137554058;6268.091126786499;6357.90463143044;6148.292946311231;6165.414285642857;6175.228096487939;6199.938000619936;6224.315325314303;6213.782517611862;6332.271788744353;6451.806445806634;6490.864098782599;6513.147704959646;4477.507474177903;4517.299818528133;4544.477385100756;4551.748269225989;4559;6131.601445906002;6166.321704612399;6235.719392627252;6355.330761080265;6362.204724409449;6063.636181828928;6077.726502307319;6090.908636370546;6098.834913605783;6108.267007959073;5853.209816674865;5975.342712301556;6047.697615119315;6103.69481525913;6151.569390142826;5974.267462435845;6013.548983826143;6049.213602231682;6050.6369617823075;6068.362821903636;6137.570370074052;6150.231221097363;6176.227971503562;6189.545456817735;6193.907091393543;5703.201551782837;5908.202392676933;5923.771544508168;5959.940400595939;5968.701564921824 07:19:15 INFO - PROCESS | 11613 | |5;yui.html;710.3677726823126;777.8405426887489;805.7461899501658;806.5604245686104;896.3411892259193;15701.607459813496;16491.422800201995;16544.503664890042;16549.66900661986;16627.334906603723;16496.587585310343;16627.66744665106;16637.417690380807;16663.750043749355;16682.58293542662;738.7931379213828;843.3801156150224;875.0855356152836;876.2902049340023;884.2925659472396;869.2046777198856;875.6803766625168;875.7854325690215;875.8204568063563;876.570480464571;920.9033051529593;923.8198551282503;924.3021518753332;924.7688077980505;925.1581061234278;916.2303664921465;918.274563095154;918.3020904112856;921.2123634292684;922.0548937339247;674.9696263668097;675.6317806795308;676.245985725917;677.8271540757124;679.1273213920089;13274.601761947157;13454.461821527128;14179;14585.416583336653;14650.487232946796;14206.07660502064;15604.92197539005;15751.2124393781;15977.520674379788;16187.595310117224;14188.574342769733;14246.501372452018;14313;14377.928110359486;14498.855011449961;4636.374089497908;4655.464621568495;4671.58080202273;4730.455997560291;4761.666683332168;67901;69541.30458695449;69646.3035369645;78055.60972195103;78614;12479.688007799878;12746.171498852545;12814.496805111747;12967.610971670865;13247.602571922858;19645.01774911249;19736.30922917691;19747.111379987648;19755.01224938776;19762.90118549398;9291.814163716688;9301.813963720688;9427.905720942703;9583;9770.706878793648;4730.432348118248;4835.492273311322;4874.390701162355;5040.47075057121;5123.770295129217;3929.4891664083484;4065.8780236592947;4094.0992981544014;4096.631303182728;4424.0709451015;782.9295363417206;797.7367468735304;798.4530596541388;806.7378102116718;810.7365106340463;684.3259389501337;684.5310961991051;699.0143897105057;763.2253262938123;768.6195333310047;10477.580896764044;10926.235163538635;11155.776884462266;11561.76876462466;11655.533778648929;693.9659906738923;738.1695592458484;751.0949306086153;763.9991610989622;785.3638552772272;4707.764611769398;4965.35450391454;5028.673136246132;5078.238264260391;5109.463506331782;116832;117184.41407793076;117927.41036294935;119595.40202298932;123737;104010;105777;109255;112252;112451.43774281077;94466.52766736122;95233;96170;97391.51304243575;98880.99999999856;9498.857517137387;9503.429794212369;9529;9530.428174309563;9844.261680373857;48871.5112848867;52228;54187.18719219136;59029;61014.69492652508;50565.494345056075;63685.3631463698;67346.32653673597;69254.65372673105;70974.64512677403;13560.796588051384;13651.11267767592;13672.042956993313;13695;13788.586342409744;14989.775153372926;15135.545933622008;16004.759928600848;16283.348666053698;16326.591835204215;14673;14687.339069741674;14748.926255368655;14767.483138090116;15206.163660998309;13753.587392378246;13907.860921390657;14283;14297.35661895238;15200.315985780446;11373.54505819758;13047.478100875858;13513.459461621425;13579.59261222165;13746.518871839438;11100.444977751242;11153.442327883411;11245.381504017358;11952.282863028246;12120.818187727367;12218;12598.87401125977;12658;12772.361381931052;12826.55107071248 07:19:15 INFO - PROCESS | 11613 | __end_tp_report 07:19:15 INFO - PROCESS | 11613 | __start_cc_report 07:19:15 INFO - PROCESS | 11613 | _x_x_mozilla_cycle_collect,342 07:19:15 INFO - PROCESS | 11613 | __end_cc_report 07:19:15 INFO - PROCESS | 11613 | __startTimestamp1472739555650__endTimestamp 07:19:15 INFO - PROCESS | 11613 | 07:19:15 INFO - PROCESS | 11613 | ------- Summary: start ------- 07:19:15 INFO - PROCESS | 11613 | Number of tests: 6 07:19:15 INFO - PROCESS | 11613 | 07:19:15 INFO - PROCESS | 11613 | [#0] dojo.html Cycles:165 Average:5883.91 Median:6135.29 stddev:684.17 (11.2%) stddev-sans-first:656.81 07:19:15 INFO - PROCESS | 11613 | Values: 3352.3 3379.0 3389.9 3402.8 3405.7 5824.6 5947.3 5958.9 5959.7 5964.4 5892.3 5960.9 5972.1 5974.5 5985.7 5384.7 5406.9 5470.8 5488.3 5492.3 5329.8 5336.3 5348.0 5384.2 5390.1 5328.3 5382.5 5385.7 5388.2 5454.7 5392.4 5409.2 5448.7 5459.5 5464.5 5102.1 5194.8 5216.9 5325.9 5347.3 5769.8 5797.6 5804.4 5853.4 5899.7 6238.9 6314.3 6317.5 6342.7 6352.6 6087.6 6237.6 6293.4 6356.5 6365.8 5934.9 5942.1 5945.3 5946.6 5985.1 6473.7 6495.7 6534.8 6537.3 6569.3 6031.8 6125.4 6137.0 6274.7 6289.8 6269.9 6291.7 6315.5 6326.6 6367.8 6276.4 6281.2 6286.4 6312.6 6323.1 6137.1 6139.8 6175.4 6258.9 6318.4 4737.8 4794.6 4794.6 4818.4 4843.4 4257.9 4266.3 4274.8 4304.2 4307.2 5858.1 5966.2 6095.1 6098.7 6104.2 6236.1 6374.7 6375.6 6402.0 6436.2 6084.0 6101.0 6135.3 6141.4 6159.6 5283.9 5405.2 5419.8 5506.7 5546.4 6632.0 6633.1 6636.9 6637.2 6651.6 6348.1 6375.4 6390.1 6401.9 6407.8 6350.3 6482.5 6526.9 6613.6 6622.4 6262.8 6270.0 6304.5 6311.1 6342.0 6373.0 6432.1 6456.9 6459.6 6466.9 5995.6 6132.3 6140.4 6274.7 6293.2 6192.3 6195.9 6201.1 6204.0 6210.8 6187.1 6188.3 6190.7 6199.3 6202.4 6078.4 6165.9 6201.5 6258.7 6272.7 6020.1 6100.8 6119.9 6120.1 6142.0 07:19:15 INFO - PROCESS | 11613 | 07:19:15 INFO - PROCESS | 11613 | [#1] ext.html Cycles:180 Average:65042.02 Median:43335.28 stddev:130596.58 (301.4%) stddev-sans-first:130873.27 07:19:15 INFO - PROCESS | 11613 | Values: 587.0 633.8 653.0 657.8 693.3 45039.8 46191.8 46195.8 46307.8 46633.0 46329.8 46922.5 46944.0 46974.5 47086.0 9131.9 9253.2 9275.6 9294.6 9296.4 9212.7 9230.3 9255.5 9278.5 9291.6 9327.8 9328.2 9355.3 9371.4 9384.0 9324.3 9325.9 9357.9 9360.2 9368.8 9161.4 9170.5 9227.0 9240.0 9242.2 42873.0 42905.8 43277.6 43334.8 43335.8 3762.5 3874.7 3967.6 4016.5 4058.6 34404.7 34571.3 35154.1 35855.3 36434.8 4287.3 4319.9 4331.4 4446.7 4486.2 380119.0 382934.0 384788.0 384825.0 387979.0 63251.7 63355.4 63661.0 63736.7 63866.4 39833.2 40849.8 40856.4 43012.1 66136.7 18609.3 18723.5 18790.6 18802.8 18805.3 13881.9 13962.4 13977.3 13979.5 13990.0 20657.4 20857.9 20865.8 21079.9 21122.8 7624.8 7660.9 7670.9 7801.5 7864.3 1042.2 1087.4 1133.1 1154.1 1173.5 34137.7 34285.8 34310.1 34325.3 34372.7 1193.2 1200.3 1213.9 1218.2 1257.8 17655.9 17811.5 17840.4 17875.7 17902.8 543736.0 552421.0 556375.0 558957.0 559097.0 42886.8 42955.6 43012.1 43229.0 43269.0 1402.6 1440.8 1453.1 1463.3 1471.6 32919.3 33813.8 33923.8 33942.8 34462.0 56112.7 56172.4 56518.0 56548.4 56553.7 517473.0 521634.0 521945.0 524138.0 524991.0 30917.2 30989.0 31149.7 31218.7 31362.7 52732.2 53253.2 53644.0 53846.0 54333.0 43384.1 44377.8 44746.0 48863.3 49303.0 46245.0 46629.5 46929.3 47059.8 47310.8 44713.6 45387.3 45515.0 46185.0 47878.8 40052.4 40338.0 40765.4 40809.6 40878.2 29428.4 29800.1 30432.5 30468.8 30559.2 07:19:15 INFO - PROCESS | 11613 | 07:19:15 INFO - PROCESS | 11613 | [#2] jquery.html Cycles:180 Average:29331.86 Median:13487.96 stddev:76628.43 (568.1%) stddev-sans-first:76812.64 07:19:15 INFO - PROCESS | 11613 | Values: 417.8 422.9 424.5 426.5 449.4 18194.1 18933.5 19550.6 20939.2 21048.1 20351.8 20420.3 20543.7 21049.3 21052.9 5822.8 6027.5 6029.7 6036.5 6037.1 5852.2 5856.5 5864.3 5931.3 5941.8 5914.1 5936.0 5940.7 5947.9 5960.7 5869.5 5907.6 5934.7 5950.8 5960.8 5193.8 5350.5 5374.6 5377.9 5379.1 24212.9 24527.5 24863.0 25006.9 25085.9 2448.4 2468.7 2491.9 2537.2 2645.2 15713.0 15879.2 15937.1 16086.4 16268.6 1989.8 2051.9 2110.6 2129.8 2184.1 83238.6 84498.6 86369.6 86900.0 87685.6 11397.1 11440.0 11547.9 11873.3 11912.3 16609.4 16630.4 16638.7 16643.3 16662.4 8761.3 8764.5 8786.5 9029.7 9037.1 8812.2 8845.2 8933.2 8949.3 9059.9 7065.3 7137.4 7174.2 7217.5 7218.3 2014.7 2057.9 2100.6 2101.8 2153.7 978.0 1033.9 1122.6 1133.7 1206.7 21339.5 21454.7 21727.7 21728.1 22063.7 1094.9 1105.4 1116.0 1125.4 1140.7 9825.9 12274.8 12360.1 12426.5 12479.9 401149.0 401264.0 402860.0 526377.0 552486.0 92429.5 92831.1 99232.0 105451.0 107049.0 1062.8 1094.9 1100.7 1102.4 1104.1 16444.8 17729.6 18650.8 18952.3 19208.6 44412.0 44438.0 44718.6 45272.0 45622.8 64348.7 64684.0 65509.7 65675.0 65701.3 8042.5 8277.0 8350.5 8985.4 9309.4 10724.8 13731.9 13923.0 14189.6 14621.5 11547.3 12031.5 12374.8 12411.9 12547.7 11986.0 12030.2 12054.8 12254.8 12311.1 12374.1 12546.4 12568.4 12571.3 12847.6 8017.1 8107.2 8234.1 8443.0 8871.1 8958.0 11445.5 11524.3 11617.0 11676.2 07:19:15 INFO - PROCESS | 11613 | 07:19:15 INFO - PROCESS | 11613 | [#3] mootools.html Cycles:180 Average:6416.09 Median:4726.63 stddev:3696.26 (78.2%) stddev-sans-first:3688.69 07:19:15 INFO - PROCESS | 11613 | Values: 1569.5 1582.2 1751.7 1854.5 1863.2 8727.5 9287.0 9479.5 9985.5 9989.1 9486.6 9768.5 9798.2 9805.3 9816.6 2495.1 2502.5 2513.8 2523.3 2530.1 2470.8 2476.4 2484.6 2486.0 2490.1 2478.4 2489.5 2519.1 2527.1 2528.0 2445.3 2454.7 2459.8 2465.3 2475.8 2449.8 2450.9 2466.1 2487.5 2488.9 9758.5 9865.3 9891.7 9918.3 9933.4 5511.4 5675.3 5678.0 5703.2 5704.4 3536.5 3718.8 3793.5 3820.6 3848.5 1260.8 1287.5 1296.6 1323.1 1337.3 13167.5 13361.7 13497.7 13876.4 13936.2 4943.0 4955.9 4964.8 5021.5 5105.3 10836.3 10837.1 10865.2 10865.6 10902.3 5672.9 5715.7 5725.0 5726.4 5737.4 4752.4 5122.6 5231.1 5244.6 5375.3 4073.4 4148.7 4205.2 4231.6 4314.8 1200.1 1221.7 1227.9 1230.1 1239.8 966.7 1062.3 1062.5 1080.4 1104.5 6437.3 6466.2 6552.1 6587.1 6762.3 502.5 515.2 1111.1 1124.5 1155.6 4489.7 4522.5 4627.3 4700.9 4768.5 12076.4 12154.3 12349.7 12375.4 12399.8 11628.9 11945.3 12238.4 12273.9 12288.7 8952.3 9105.4 9137.9 9162.6 9179.1 6720.8 6759.8 6823.2 6842.5 6842.8 11062.2 11343.5 11353.9 11395.6 11501.7 11175.2 11454.1 11742.2 11811.9 11843.1 8777.3 8954.0 8995.1 9156.1 9437.9 9676.5 9766.7 9771.8 9788.3 9790.7 8154.4 8261.5 8430.3 8459.7 8576.7 8043.5 8359.7 8389.9 8529.3 8532.0 7662.2 7746.7 7819.6 7827.8 7841.0 5605.7 5821.9 5864.5 5889.4 5947.3 5722.6 5788.2 5851.4 5888.6 5909.4 07:19:15 INFO - PROCESS | 11613 | 07:19:15 INFO - PROCESS | 11613 | [#4] prototype.html Cycles:180 Average:5042.22 Median:5652.48 stddev:1492.80 (26.4%) stddev-sans-first:1454.76 07:19:15 INFO - PROCESS | 11613 | Values: 345.1 349.5 353.2 356.5 362.1 5820.1 5875.7 5883.3 5885.2 5892.4 5751.5 5800.5 5803.4 5829.8 5840.8 4333.3 4437.1 4471.0 4489.3 4507.9 4492.2 4497.2 4500.4 4502.8 4507.3 4472.6 4472.9 4492.9 4502.5 4505.1 4435.6 4444.9 4476.1 4493.7 4506.0 3941.8 3954.7 3958.5 3968.5 3982.7 5639.5 5646.9 5658.1 5660.2 5689.6 5123.3 5171.4 5198.7 5208.5 5229.2 6070.9 6073.9 6088.8 6095.8 6117.6 4422.4 4434.4 4438.2 4447.0 4453.4 5888.5 6123.4 6142.3 6270.9 6329.3 4380.1 4382.5 4384.7 4430.7 4440.4 4465.9 4469.3 4480.3 4485.3 4493.5 5016.2 5154.0 5162.2 5173.9 5197.2 6133.4 6136.4 6136.8 6140.3 6146.6 1532.1 1560.2 1562.3 1564.1 1570.5 970.9 1000.0 1002.9 1008.5 1027.4 5188.6 5193.8 5207.7 5214.7 5251.9 5448.6 5539.8 5551.5 5551.6 5573.6 4962.9 5182.0 5236.6 5328.0 5329.3 2942.5 2954.3 2981.2 2989.7 2997.3 5664.9 5712.6 5716.4 5722.1 5752.3 5952.5 6369.1 6423.3 6473.5 6487.0 6560.6 6562.2 6563.3 6580.9 6669.4 6121.6 6192.6 6242.3 6268.1 6357.9 6148.3 6165.4 6175.2 6199.9 6224.3 6213.8 6332.3 6451.8 6490.9 6513.1 4477.5 4517.3 4544.5 4551.7 4559.0 6131.6 6166.3 6235.7 6355.3 6362.2 6063.6 6077.7 6090.9 6098.8 6108.3 5853.2 5975.3 6047.7 6103.7 6151.6 5974.3 6013.5 6049.2 6050.6 6068.4 6137.6 6150.2 6176.2 6189.5 6193.9 5703.2 5908.2 5923.8 5959.9 5968.7 07:19:15 INFO - PROCESS | 11613 | 07:19:15 INFO - PROCESS | 11613 | [#5] yui.html Cycles:180 Average:21606.51 Median:4645.92 stddev:31062.07 (668.6%) stddev-sans-first:31109.58 07:19:15 INFO - PROCESS | 11613 | Values: 710.4 777.8 805.7 806.6 896.3 15701.6 16491.4 16544.5 16549.7 16627.3 16496.6 16627.7 16637.4 16663.8 16682.6 738.8 843.4 875.1 876.3 884.3 869.2 875.7 875.8 875.8 876.6 920.9 923.8 924.3 924.8 925.2 916.2 918.3 918.3 921.2 922.1 675.0 675.6 676.2 677.8 679.1 13274.6 13454.5 14179.0 14585.4 14650.5 14206.1 15604.9 15751.2 15977.5 16187.6 14188.6 14246.5 14313.0 14377.9 14498.9 4636.4 4655.5 4671.6 4730.5 4761.7 67901.0 69541.3 69646.3 78055.6 78614.0 12479.7 12746.2 12814.5 12967.6 13247.6 19645.0 19736.3 19747.1 19755.0 19762.9 9291.8 9301.8 9427.9 9583.0 9770.7 4730.4 4835.5 4874.4 5040.5 5123.8 3929.5 4065.9 4094.1 4096.6 4424.1 782.9 797.7 798.5 806.7 810.7 684.3 684.5 699.0 763.2 768.6 10477.6 10926.2 11155.8 11561.8 11655.5 694.0 738.2 751.1 764.0 785.4 4707.8 4965.4 5028.7 5078.2 5109.5 116832.0 117184.4 117927.4 119595.4 123737.0 104010.0 105777.0 109255.0 112252.0 112451.4 94466.5 95233.0 96170.0 97391.5 98881.0 9498.9 9503.4 9529.0 9530.4 9844.3 48871.5 52228.0 54187.2 59029.0 61014.7 50565.5 63685.4 67346.3 69254.7 70974.6 13560.8 13651.1 13672.0 13695.0 13788.6 14989.8 15135.5 16004.8 16283.3 16326.6 14673.0 14687.3 14748.9 14767.5 15206.2 13753.6 13907.9 14283.0 14297.4 15200.3 11373.5 13047.5 13513.5 13579.6 13746.5 11100.4 11153.4 11245.4 11952.3 12120.8 12218.0 12598.9 12658.0 12772.4 12826.6 07:19:15 INFO - PROCESS | 11613 | -------- Summary: end -------- 07:19:15 INFO - PROCESS | 11613 | 07:19:16 INFO - TEST-INFO | 11613: exit 0 07:19:16 INFO - TEST-OK | dromaeo_css | took 1111338ms 07:19:16 INFO - TEST-START | kraken 07:19:16 INFO - operating with platform_type : linux_ 07:19:16 INFO - Initialising browser for kraken test... 07:19:16 INFO - TEST-INFO | started process 11875 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaLWhFB/profile http://localhost:35032/getInfo.html) 07:19:21 INFO - PROCESS | 11875 | __metrics Screen width/height:1600/1200 07:19:21 INFO - PROCESS | 11875 | colorDepth:24 07:19:21 INFO - PROCESS | 11875 | Browser inner width/height: 1024/697 07:19:21 INFO - PROCESS | 11875 | __metrics 07:19:21 ERROR - PROCESS | 11875 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 07:19:22 INFO - TEST-INFO | 11875: exit 0 07:19:22 INFO - Browser initialized. 07:19:22 INFO - Running cycle 1/1 for kraken test... 07:19:22 INFO - TEST-INFO | started process 12001 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaLWhFB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:19:34 INFO - PROCESS | 12001 | RSS: Main: 152973312 07:19:34 INFO - PROCESS | 12001 | 07:19:36 INFO - PROCESS | 12001 | Cycle 1(1): loaded http://localhost:35032/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35032/tests/kraken/driver.html?testName=audio-beat-detection) 07:19:37 INFO - PROCESS | 12001 | RSS: Main: 158273536 07:19:37 INFO - PROCESS | 12001 | 07:19:40 INFO - PROCESS | 12001 | Cycle 1(1): loaded http://localhost:35032/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35032/tests/kraken/driver.html?testName=audio-dft) 07:19:40 INFO - PROCESS | 12001 | RSS: Main: 156536832 07:19:40 INFO - PROCESS | 12001 | 07:19:43 INFO - PROCESS | 12001 | Cycle 1(1): loaded http://localhost:35032/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35032/tests/kraken/driver.html?testName=audio-fft) 07:19:44 INFO - PROCESS | 12001 | RSS: Main: 157634560 07:19:44 INFO - PROCESS | 12001 | 07:19:46 INFO - PROCESS | 12001 | Cycle 1(1): loaded http://localhost:35032/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35032/tests/kraken/driver.html?testName=audio-oscillator) 07:19:47 INFO - PROCESS | 12001 | RSS: Main: 157257728 07:19:47 INFO - PROCESS | 12001 | 07:19:49 INFO - PROCESS | 12001 | Cycle 1(1): loaded http://localhost:35032/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35032/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:19:49 INFO - PROCESS | 12001 | RSS: Main: 156815360 07:19:49 INFO - PROCESS | 12001 | 07:19:52 INFO - PROCESS | 12001 | Cycle 1(1): loaded http://localhost:35032/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35032/tests/kraken/driver.html?testName=imaging-darkroom) 07:19:53 INFO - PROCESS | 12001 | RSS: Main: 156057600 07:19:53 INFO - PROCESS | 12001 | 07:19:56 INFO - PROCESS | 12001 | Cycle 1(1): loaded http://localhost:35032/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35032/tests/kraken/driver.html?testName=imaging-desaturate) 07:19:57 INFO - PROCESS | 12001 | RSS: Main: 156819456 07:19:57 INFO - PROCESS | 12001 | 07:20:00 INFO - PROCESS | 12001 | Cycle 1(1): loaded http://localhost:35032/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35032/tests/kraken/driver.html?testName=json-parse-financial) 07:20:00 INFO - PROCESS | 12001 | RSS: Main: 157990912 07:20:00 INFO - PROCESS | 12001 | 07:20:02 INFO - PROCESS | 12001 | Cycle 1(1): loaded http://localhost:35032/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35032/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:20:03 INFO - PROCESS | 12001 | RSS: Main: 157396992 07:20:03 INFO - PROCESS | 12001 | 07:20:04 INFO - PROCESS | 12001 | Cycle 1(1): loaded http://localhost:35032/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35032/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:20:05 INFO - PROCESS | 12001 | RSS: Main: 157577216 07:20:05 INFO - PROCESS | 12001 | 07:20:07 INFO - PROCESS | 12001 | Cycle 1(1): loaded http://localhost:35032/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35032/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:20:08 INFO - PROCESS | 12001 | RSS: Main: 157589504 07:20:08 INFO - PROCESS | 12001 | 07:20:10 INFO - PROCESS | 12001 | Cycle 1(1): loaded http://localhost:35032/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35032/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:20:11 INFO - PROCESS | 12001 | RSS: Main: 157949952 07:20:11 INFO - PROCESS | 12001 | 07:20:13 INFO - PROCESS | 12001 | Cycle 1(1): loaded http://localhost:35032/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35032/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:20:14 INFO - PROCESS | 12001 | RSS: Main: 158162944 07:20:14 INFO - PROCESS | 12001 | 07:20:16 INFO - PROCESS | 12001 | Cycle 1(1): loaded http://localhost:35032/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35032/tests/kraken/driver.html?testName=ai-astar) 07:20:16 INFO - PROCESS | 12001 | RSS: Main: 158953472 07:20:16 INFO - PROCESS | 12001 | 07:20:16 INFO - PROCESS | 12001 | __start_tp_report 07:20:16 INFO - PROCESS | 12001 | _x_x_mozilla_page_load 07:20:16 INFO - PROCESS | 12001 | _x_x_mozilla_page_load_details 07:20:16 INFO - PROCESS | 12001 | |i|pagename|runs| 07:20:16 INFO - PROCESS | 12001 | |0;ai-astar;98;111;103;109;109;112;108;110;111;110 07:20:16 INFO - PROCESS | 12001 | |1;audio-beat-detection;150;114;144;185;121;147;149;116;175;124 07:20:16 INFO - PROCESS | 12001 | |2;audio-dft;162;161;163;161;161;162;162;161;160;160 07:20:16 INFO - PROCESS | 12001 | |3;audio-fft;74;76;74;178;75;74;75;74;176;75 07:20:16 INFO - PROCESS | 12001 | |4;audio-oscillator;83;84;147;83;85;82;138;84;85;141 07:20:16 INFO - PROCESS | 12001 | |5;imaging-gaussian-blur;117;118;117;117;117;117;117;118;117;117 07:20:16 INFO - PROCESS | 12001 | |6;imaging-darkroom;147;148;148;147;147;147;146;146;147;147 07:20:16 INFO - PROCESS | 12001 | |7;imaging-desaturate;95;95;96;96;95;96;96;96;96;96 07:20:16 INFO - PROCESS | 12001 | |8;json-parse-financial;52;52;53;51;52;51;51;51;53;51 07:20:16 INFO - PROCESS | 12001 | |9;json-stringify-tinderbox;63;59;59;58;59;59;59;59;59;58 07:20:16 INFO - PROCESS | 12001 | |10;stanford-crypto-aes;71;72;81;71;72;77;72;79;72;71 07:20:16 INFO - PROCESS | 12001 | |11;stanford-crypto-ccm;127;119;116;116;123;118;147;124;151;117 07:20:16 INFO - PROCESS | 12001 | |12;stanford-crypto-pbkdf2;157;154;155;157;156;159;152;155;155;158 07:20:16 INFO - PROCESS | 12001 | |13;stanford-crypto-sha256-iterative;61;62;61;62;64;60;60;60;62;60 07:20:16 INFO - PROCESS | 12001 | __end_tp_report 07:20:16 INFO - PROCESS | 12001 | __start_cc_report 07:20:16 INFO - PROCESS | 12001 | _x_x_mozilla_cycle_collect,849 07:20:16 INFO - PROCESS | 12001 | __end_cc_report 07:20:16 INFO - PROCESS | 12001 | __startTimestamp1472739616477__endTimestamp 07:20:16 INFO - PROCESS | 12001 | 07:20:16 INFO - PROCESS | 12001 | ------- Summary: start ------- 07:20:16 INFO - PROCESS | 12001 | Number of tests: 14 07:20:16 INFO - PROCESS | 12001 | 07:20:16 INFO - PROCESS | 12001 | [#0] ai-astar Cycles:10 Average:108.10 Median:110.50 stddev:4.33 (3.9%) stddev-sans-first:2.64 07:20:16 INFO - PROCESS | 12001 | Values: 98.0 111.0 103.0 109.0 109.0 112.0 108.0 110.0 111.0 110.0 07:20:16 INFO - PROCESS | 12001 | 07:20:16 INFO - PROCESS | 12001 | [#1] audio-beat-detection Cycles:10 Average:142.50 Median:148.00 stddev:24.27 (16.4%) stddev-sans-first:25.59 07:20:16 INFO - PROCESS | 12001 | Values: 150.0 114.0 144.0 185.0 121.0 147.0 149.0 116.0 175.0 124.0 07:20:16 INFO - PROCESS | 12001 | 07:20:16 INFO - PROCESS | 12001 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 07:20:16 INFO - PROCESS | 12001 | Values: 162.0 161.0 163.0 161.0 161.0 162.0 162.0 161.0 160.0 160.0 07:20:16 INFO - PROCESS | 12001 | 07:20:16 INFO - PROCESS | 12001 | [#3] audio-fft Cycles:10 Average:95.10 Median:74.50 stddev:43.17 (57.9%) stddev-sans-first:45.11 07:20:16 INFO - PROCESS | 12001 | Values: 74.0 76.0 74.0 178.0 75.0 74.0 75.0 74.0 176.0 75.0 07:20:16 INFO - PROCESS | 12001 | 07:20:16 INFO - PROCESS | 12001 | [#4] audio-oscillator Cycles:10 Average:101.20 Median:83.50 stddev:28.25 (33.8%) stddev-sans-first:29.19 07:20:16 INFO - PROCESS | 12001 | Values: 83.0 84.0 147.0 83.0 85.0 82.0 138.0 84.0 85.0 141.0 07:20:16 INFO - PROCESS | 12001 | 07:20:16 INFO - PROCESS | 12001 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:20:16 INFO - PROCESS | 12001 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 07:20:16 INFO - PROCESS | 12001 | 07:20:16 INFO - PROCESS | 12001 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 07:20:16 INFO - PROCESS | 12001 | Values: 147.0 148.0 148.0 147.0 147.0 147.0 146.0 146.0 147.0 147.0 07:20:16 INFO - PROCESS | 12001 | 07:20:16 INFO - PROCESS | 12001 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 07:20:16 INFO - PROCESS | 12001 | Values: 95.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 07:20:16 INFO - PROCESS | 12001 | 07:20:16 INFO - PROCESS | 12001 | [#8] json-parse-financial Cycles:10 Average:51.70 Median:52.00 stddev:0.82 (1.6%) stddev-sans-first:0.87 07:20:16 INFO - PROCESS | 12001 | Values: 52.0 52.0 53.0 51.0 52.0 51.0 51.0 51.0 53.0 51.0 07:20:16 INFO - PROCESS | 12001 | 07:20:16 INFO - PROCESS | 12001 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.00 stddev:1.40 (2.4%) stddev-sans-first:0.44 07:20:16 INFO - PROCESS | 12001 | Values: 63.0 59.0 59.0 58.0 59.0 59.0 59.0 59.0 59.0 58.0 07:20:16 INFO - PROCESS | 12001 | 07:20:16 INFO - PROCESS | 12001 | [#10] stanford-crypto-aes Cycles:10 Average:73.80 Median:72.00 stddev:3.74 (5.2%) stddev-sans-first:3.82 07:20:16 INFO - PROCESS | 12001 | Values: 71.0 72.0 81.0 71.0 72.0 77.0 72.0 79.0 72.0 71.0 07:20:16 INFO - PROCESS | 12001 | 07:20:16 INFO - PROCESS | 12001 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:123.50 stddev:12.80 (10.4%) stddev-sans-first:13.56 07:20:16 INFO - PROCESS | 12001 | Values: 127.0 119.0 116.0 116.0 123.0 118.0 147.0 124.0 151.0 117.0 07:20:16 INFO - PROCESS | 12001 | 07:20:16 INFO - PROCESS | 12001 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.80 Median:156.50 stddev:2.04 (1.3%) stddev-sans-first:2.12 07:20:16 INFO - PROCESS | 12001 | Values: 157.0 154.0 155.0 157.0 156.0 159.0 152.0 155.0 155.0 158.0 07:20:16 INFO - PROCESS | 12001 | 07:20:16 INFO - PROCESS | 12001 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.20 Median:61.50 stddev:1.32 (2.1%) stddev-sans-first:1.39 07:20:16 INFO - PROCESS | 12001 | Values: 61.0 62.0 61.0 62.0 64.0 60.0 60.0 60.0 62.0 60.0 07:20:16 INFO - PROCESS | 12001 | -------- Summary: end -------- 07:20:16 INFO - PROCESS | 12001 | 07:20:17 INFO - TEST-INFO | 12001: exit 0 07:20:17 INFO - TEST-OK | kraken | took 61075ms 07:20:17 INFO - SUITE-END | took 1172s 07:20:17 INFO - Completed test suite (00:19:32) 07:20:17 INFO - javascript benchmark 07:20:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7833.051314893946, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3352.3295340931813, 3378.983105084474, 3389.864405423783, 3402.829858507074, 3405.710514606258, 5824.563157763168, 5947.256592925884, 5958.940410595898, 5959.731812068457, 5964.403559644044, 5892.2929248490245, 5960.880782384361, 5972.104184372346, 5974.462298393144, 5985.730642121104, 5384.703841288728, 5406.945930540684, 5470.835874923759, 5488.313960754906, 5492.286002819648, 5329.840104796843, 5336.332958380202, 5348.037353276409, 5384.246205531229, 5390.137577987503, 5328.280682107905, 5382.4886635769535, 5385.703786291752, 5388.218708287296, 5454.672719636835, 5392.379876314196, 5409.215663728757, 5448.700321482317, 5459.535939445152, 5464.508194262496, 5102.056119617882, 5194.844154675366, 5216.895662086737, 5325.8934821303355, 5347.278117454132, 5769.798057067983, 5797.565182611321, 5804.390538993429, 5853.443922827325, 5899.7050147492455, 6238.906416403757, 6314.305426403092, 6317.526185536103, 6342.714577844008, 6352.555321127523, 6087.634741915455, 6237.625742455467, 6293.433590976834, 6356.460738626742, 6365.809025729235, 5934.910976335358, 5942.138389933479, 5945.31628862682, 5946.583739138262, 5985.072313791369, 6473.676316184172, 6495.68050697987, 6534.771283005072, 6537.34626537352, 6569.343065693392, 6031.819045428644, 6125.4487096160665, 6137.048757442603, 6274.717637706314, 6289.842753931097, 6269.905951410732, 6291.716872740738, 6315.494760419156, 6326.620402775849, 6367.808965731036, 6276.435120839055, 6281.152044474029, 6286.402791734778, 6312.589681670676, 6323.114763933053, 6137.140800287963, 6139.754409823647, 6175.382461753788, 6258.874822503524, 6318.4313411793155, 4737.8341758038305, 4794.568488836021, 4794.640401969867, 4818.445878723992, 4843.4430040545085, 4257.914841703148, 4266.31738921771, 4274.829006839754, 4304.203722311382, 4307.246231909466, 5858.121281807677, 5966.19456373384, 6095.05526643371, 6098.69506524672, 6104.17593624855, 6236.064590311399, 6374.713137908805, 6375.6174629522375, 6402.0, 6436.195475565554, 6083.969580152071, 6101.0, 6135.294441139326, 6141.416565426277, 6159.568830181934, 5283.947160528345, 5405.243265942771, 5419.83740487786, 5506.669599824023, 5546.4453554644215, 6631.966840165768, 6633.104530888365, 6636.8672626547195, 6637.23671777742, 6651.600903945779, 6348.079528468254, 6375.4262116409745, 6390.073439351361, 6401.8719625608155, 6407.807765767035, 6350.333215012357, 6482.513811464065, 6526.934730652632, 6613.570117942319, 6622.403983641495, 6262.780802671885, 6269.96865015672, 6304.464120549805, 6311.116443697794, 6342.048692696132, 6373.012183111625, 6432.13166222554, 6456.870862582816, 6459.61242325462, 6466.870662586628, 5995.580309378476, 6132.264128304632, 6140.381550880894, 6274.749010039547, 6293.213348331458, 6192.349803270592, 6195.876082478415, 6201.131841542278, 6203.96898015507, 6210.813675589558, 6187.071939209155, 6188.257409110755, 6190.690465476799, 6199.318075011655, 6202.379762023762, 6078.422549857756, 6165.876682466415, 6201.534884883742, 6258.718357673824, 6272.717727702173, 6020.1270815730595, 6100.816975490742, 6119.8776024478375, 6120.081455037822, 6142.0], "value": 5836.406464668243, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.9530437564995, 633.8098570428871, 652.960822350659, 657.8421178917058, 693.3274723518185, 45039.774801126034, 46191.769041154745, 46195.76902115485, 46307.76846115769, 46633.0, 46329.7683511582, 46922.53077469224, 46944.0, 46974.53025469744, 47086.0, 9131.863022054675, 9253.213476854475, 9275.628974840998, 9294.58174382151, 9296.44221346718, 9212.72361829143, 9230.307726920475, 9255.53722313885, 9278.536073196346, 9291.581878815436, 9327.76680582984, 9328.207102396305, 9355.298352623546, 9371.39085959414, 9384.0, 9324.347295689304, 9325.860112098324, 9357.859632105525, 9360.204382627484, 9368.765780855465, 9161.404508706979, 9170.541472926327, 9227.0, 9240.0, 9242.168204861528, 42873.0, 42905.785471072755, 43277.56722432767, 43334.78332608317, 43335.78332108351, 3762.548494180716, 3874.6512813846607, 3967.6429121378924, 4016.5380981187245, 4058.5738497457637, 34404.65595344039, 34571.30857382863, 35154.12114697127, 35855.282894341966, 36434.8178259107, 4287.2711639021445, 4319.892002699958, 4331.371951067078, 4446.710963787344, 4486.237339652267, 380119.0, 382934.0, 384788.0, 384825.0, 387979.0, 63251.683741581, 63355.366446335865, 63661.0, 63736.68131659312, 63866.36133638604, 39833.20333593312, 40849.795751021054, 40856.38715419271, 43012.13975720531, 66136.6693166531, 18609.255629774656, 18723.531911702317, 18790.624187516172, 18802.811971880106, 18805.341813036477, 13881.930590346983, 13962.371693273826, 13977.301134943416, 13979.510717125055, 13990.0, 20657.380278591667, 20857.89571052135, 20865.79134208669, 21079.8946005269, 21122.788772112388, 7624.847503049908, 7660.8508723690775, 7670.884936725954, 7801.531908085533, 7864.252895974873, 1042.1506472225112, 1087.4065354130298, 1133.0595605647293, 1154.1286328821686, 1173.5423184957874, 34137.65862341395, 34285.82857085699, 34310.14224644354, 34325.313493729984, 34372.656273437446, 1193.20651766576, 1200.3458115327167, 1213.9089568282413, 1218.2081646929566, 1257.7798885195236, 17655.911720441316, 17811.46565603034, 17840.3755868544, 17875.73186402205, 17902.820971790115, 543736.0, 552421.0, 556375.0, 558957.0, 559097.0, 42886.78556607197, 42955.570444295154, 43012.13975720468, 43229.0, 43269.0, 1402.6283034995733, 1440.7622742247622, 1453.11360070357, 1463.3049301581664, 1471.587955372476, 32919.34161316808, 33813.81651642181, 33923.83038084794, 33942.83028584841, 34462.0, 56112.719436402556, 56172.438275618355, 56518.0, 56548.43451565432, 56553.71723141358, 517473.0, 521634.0, 521945.0, 524138.0, 524991.0, 30917.227069322547, 30989.0, 31149.688503114678, 31218.687813121578, 31362.68637313689, 52732.20901686555, 53253.201201981225, 53644.0, 53846.0, 54333.0, 43384.13231735411, 44377.77811110924, 44746.0, 48863.267050994975, 49303.0, 46244.988151540085, 46629.53370466252, 46929.2960605598, 47059.76470117764, 47310.76344618255, 44713.55286447094, 45387.319190211514, 45515.0, 46185.0, 47878.760606196745, 40052.39921401123, 40338.0, 40765.38851917164, 40809.59190408058, 40878.182436350515, 29428.411431771674, 29800.10599682013, 30432.543511846896, 30468.84765576158, 30559.2360190997], "value": 21327.433684860724, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.8203372549804, 422.9365595160726, 424.4715329414879, 426.5137742973009, 449.3596624809645, 18194.09029548522, 18933.526661833443, 19550.608987820237, 20939.162433502643, 21048.052837622305, 20351.796482035214, 20420.285290014814, 20543.691844622343, 21049.26327578535, 21052.89473552634, 5822.796202132916, 6027.457528822405, 6029.69851507425, 6036.547258955596, 6037.094435834616, 5852.151438041481, 5856.5314774818125, 5864.296284445851, 5931.258592675916, 5941.792037278696, 5914.083317085859, 5936.0, 5940.673262970535, 5947.881042379171, 5960.672163031031, 5869.530437565006, 5907.586468947197, 5934.673592952386, 5950.7917222896995, 5960.791372301948, 5193.818216362409, 5350.464953504657, 5374.596905232123, 5377.946220537784, 5379.112446446332, 24212.878935605386, 24527.509449810903, 24863.0, 25006.874965625237, 25085.87457062703, 2448.4123810285405, 2468.7037555493457, 2491.9003239870385, 2537.172410363508, 2645.2196602002455, 15713.0, 15879.206039697969, 15937.123458209793, 16086.356545738156, 16268.593285167966, 1989.7512810898638, 2051.8974051297523, 2110.5884352551257, 2129.8402619803423, 2184.1045171479777, 83238.58380708119, 84498.57750711207, 86369.56815216009, 86900.0, 87685.56157219173, 11397.145214108808, 11440.0, 11547.884521154681, 11873.346965916957, 11912.285262884254, 16609.41867034648, 16630.417935372203, 16638.667226655398, 16643.33426662944, 16662.4168154114, 8761.34289928258, 8764.5179515126, 8786.516741579275, 9029.729108126767, 9037.051109633525, 8812.16284452976, 8845.248153906861, 8933.240674542607, 8949.284057275403, 9059.909400906039, 7065.258147894499, 7137.4290056795335, 7174.246704096099, 7217.530860494051, 7218.27817218274, 2014.7280117184287, 2057.907394167266, 2100.6113868934294, 2101.8423618228694, 2153.7415510138885, 977.9853302200472, 1033.8914413986574, 1122.6183097746805, 1133.7335726104359, 1206.740550781586, 21339.46651333729, 21454.678179827002, 21727.67408488874, 21728.13087476515, 22063.66904496434, 1094.8686157661132, 1105.4196546812987, 1116.0, 1125.3529220697967, 1140.749035212252, 9825.901740982641, 12274.772522747833, 12360.072994525266, 12426.502939882303, 12479.875201248053, 401149.0, 401264.0, 402860.0, 526377.0163898539, 552486.0, 92429.53785231031, 92831.06322829345, 99232.0, 105451.0, 107049.0, 1062.8086944349936, 1094.8850370710961, 1100.7468282295117, 1102.393683474102, 1104.116706634673, 16444.83555164481, 17729.645407092044, 18650.81349186491, 18952.348833518423, 19208.615827683647, 44412.0, 44438.0, 44718.55281447144, 45272.0, 45622.771886140355, 64348.678256608415, 64684.0, 65509.67245163744, 65675.0, 65701.34298656952, 8042.517448953082, 8277.0, 8350.457220280663, 8985.415947963362, 9309.44143351401, 10724.785504290026, 13731.931340343235, 13923.0, 14189.574312770634, 14621.488247911271, 11547.307161570332, 12031.45858436355, 12374.81437778452, 12411.875881241072, 12547.749045018865, 11986.0, 12030.15788894804, 12054.819177712518, 12254.75490490203, 12311.138220324492, 12374.14387841831, 12546.435410406737, 12568.445116625033, 12571.30857802793, 12847.550335738204, 8017.118117007008, 8107.22981316774, 8234.05308389543, 8443.00425430418, 8871.068537803438, 8958.0, 11445.542178312775, 11524.250923689933, 11617.0, 11676.241044332091], "value": 9931.757937792414, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1569.5212960047184, 1582.1614544291526, 1751.6584266068114, 1854.471475629445, 1863.245385618823, 8727.476351418904, 9286.953565232172, 9479.47862867542, 9985.450800205996, 9989.051040151184, 9486.620535178601, 9768.462734549597, 9798.216142708585, 9805.31362804604, 9816.607335706563, 2495.0892924082714, 2502.4995000999784, 2513.7863281621085, 2523.3313172009434, 2530.051230788454, 2470.777630013298, 2476.4304210031705, 2484.627305904111, 2485.962710559343, 2490.091116742385, 2478.355627536844, 2489.4647650755082, 2519.143491212987, 2527.128140791424, 2527.9873600632063, 2445.254197469771, 2454.656348111257, 2459.7909177719916, 2465.2604218734396, 2475.8266921315517, 2449.7550244975537, 2450.889709963056, 2466.1245257933533, 2487.5398051360376, 2488.8755562222, 9758.512074396253, 9865.260105492116, 9891.703248902473, 9918.30571859963, 9933.3543319684, 5511.366192887829, 5675.347335056439, 5677.971610141964, 5703.230063941398, 5704.429557044304, 3536.504889315498, 3718.7768733876055, 3793.487879136309, 3820.59883712209, 3848.5381754189675, 1260.7730608490467, 1287.5429222625926, 1296.572131196703, 1323.0540163782941, 1337.2511393619507, 13167.473301067947, 13361.66595835102, 13497.730045399136, 13876.444942202299, 13936.233507157101, 4942.9752851236235, 4955.90088198234, 4964.776585053682, 5021.548060674557, 5105.285260063594, 10836.295640783324, 10837.133029357632, 10865.239433239598, 10865.619703310345, 10902.291351062155, 5672.914906276409, 5715.685637289989, 5725.026745453283, 5726.398728133569, 5737.3688894221605, 4752.405949256343, 5122.590192784568, 5231.136862417735, 5244.606654500852, 5375.3012108425655, 4073.383388172322, 4148.730332528376, 4205.222033923734, 4231.555686652919, 4314.7626880521875, 1200.0759415250384, 1221.6640423883325, 1227.8833510816457, 1230.0528592983533, 1239.8388209532702, 966.6568368229177, 1062.3148069495132, 1062.5324857062867, 1080.3949788118678, 1104.4643347976225, 6437.324080971431, 6466.159399278158, 6552.082708420825, 6587.110740050128, 6762.256151823295, 502.51005269861594, 515.2014377714602, 1111.072254667362, 1124.522078116797, 1155.607093588184, 4489.685721999494, 4522.547745225451, 4627.259638457831, 4700.858974230779, 4768.451628062748, 12076.396180190955, 12154.33151176676, 12349.691257718629, 12375.443105060294, 12399.75200496003, 11628.94185529067, 11945.343006134572, 12238.449269782881, 12273.93863030697, 12288.692782680504, 8952.283817294601, 9105.408148470327, 9137.908620913706, 9162.587683554257, 9179.127982841754, 6720.831979200363, 6759.831004224934, 6823.249442561413, 6842.521023528305, 6842.794716158523, 11062.170337224901, 11343.546258149581, 11353.943230283796, 11395.601153959571, 11501.712457188303, 11175.161862860155, 11454.08367330595, 11742.178047536932, 11811.881881181422, 11843.111766617365, 8777.297816174818, 8954.0, 8995.100489950952, 9156.084391560791, 9437.905620943702, 9676.467794271382, 9766.658166964122, 9771.755706107404, 9788.314817962959, 9790.657326993522, 8154.388420868578, 8261.504309741435, 8430.325573954191, 8459.746207613782, 8576.656933722581, 8043.477173983672, 8359.707410240613, 8389.916100839158, 8529.317654587494, 8531.95734021326, 7662.233776622294, 7746.65140068687, 7819.648115834915, 7827.765167044998, 7841.0, 5605.719714014364, 5821.854453638693, 5864.530837533072, 5889.381614930542, 5947.345791962967, 5722.599418040697, 5788.247527821356, 5851.414858514115, 5888.558358123072, 5909.3795151508475], "value": 5079.1602270248995, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.1096171876557, 349.54384528190735, 353.20352604876, 356.52760092876946, 362.09295714235844, 5820.148127417567, 5875.676837773921, 5883.294004719429, 5885.205497257874, 5892.351841297459, 5751.4536119068725, 5800.53595712343, 5803.419658034194, 5829.825105246839, 5840.8247752567495, 4333.306670932651, 4437.134758722051, 4471.0, 4489.306416150316, 4507.867032412475, 4492.191405547001, 4497.168023915569, 4500.369948207237, 4502.797374118156, 4507.278835386339, 4472.619827314682, 4472.910541789162, 4492.910141797162, 4502.48221454532, 4505.121501307246, 4435.578620031092, 4444.911101777979, 4476.127155204753, 4493.708208813496, 4505.977470112662, 3941.8423263069444, 3954.6638535724496, 3958.5051868516434, 3968.523777146732, 3982.681385489183, 5639.492445679867, 5646.85882852932, 5658.094704847204, 5660.2075709400715, 5689.573282003825, 5123.333966584358, 5171.3535808024, 5198.714070726109, 5208.479152084799, 5229.189475631283, 6070.878582428327, 6073.908891366633, 6088.786892458787, 6095.786647467362, 6117.5717699761035, 4422.358757980075, 4434.401355816955, 4438.15675021748, 4447.0, 4453.376527286183, 5888.499477544414, 6123.4488895999575, 6142.293636231846, 6270.937290627081, 6329.303776584618, 4380.145871555016, 4382.496012958487, 4384.693071484965, 4430.712003719748, 4440.4005459263235, 4465.933011004838, 4469.34634185347, 4480.260756975063, 4485.282354823213, 4493.505714371417, 5016.222485514678, 5153.974230128825, 5162.225666150108, 5173.922391164136, 5197.24639927216, 6133.405314618142, 6136.417040381157, 6136.815895523141, 6140.324564297924, 6146.602824898293, 1532.1496569404087, 1560.2042958091229, 1562.2969663651402, 1564.0615630621764, 1570.4581919237844, 970.9223262139012, 1000.0449570660003, 1002.9097381235724, 1008.5461542305845, 1027.4041056187393, 5188.63679542436, 5193.792248310101, 5207.739613019409, 5214.687118772886, 5251.921221181686, 5448.591355648342, 5539.7840863654865, 5551.472610102034, 5551.583631227674, 5573.6098473106495, 4962.925556116661, 5182.0, 5236.554892834076, 5328.014317351302, 5329.282066146293, 2942.514485109976, 2954.335274563206, 2981.2248815307744, 2989.701029896993, 2997.3405850712807, 5664.8867022659315, 5712.6286791358425, 5716.370469583955, 5722.141678748221, 5752.338481074647, 5952.494038006731, 6369.108324834434, 6423.325550817097, 6473.514486413538, 6487.0, 6560.606363618198, 6562.2453417856605, 6563.260735904989, 6580.901286480706, 6669.399754022064, 6121.632702037892, 6192.628442293477, 6242.282137554058, 6268.091126786499, 6357.90463143044, 6148.292946311231, 6165.414285642857, 6175.228096487939, 6199.938000619936, 6224.315325314303, 6213.782517611862, 6332.271788744353, 6451.806445806634, 6490.864098782599, 6513.147704959646, 4477.507474177903, 4517.299818528133, 4544.477385100756, 4551.748269225989, 4559.0, 6131.601445906002, 6166.321704612399, 6235.719392627252, 6355.330761080265, 6362.204724409449, 6063.636181828928, 6077.726502307319, 6090.908636370546, 6098.834913605783, 6108.267007959073, 5853.209816674865, 5975.342712301556, 6047.697615119315, 6103.69481525913, 6151.569390142826, 5974.267462435845, 6013.548983826143, 6049.213602231682, 6050.6369617823075, 6068.362821903636, 6137.570370074052, 6150.231221097363, 6176.227971503562, 6189.545456817735, 6193.907091393543, 5703.201551782837, 5908.202392676933, 5923.771544508168, 5959.940400595939, 5968.701564921824], "value": 4564.136210916982, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.3677726823126, 777.8405426887489, 805.7461899501658, 806.5604245686104, 896.3411892259193, 15701.607459813496, 16491.422800201995, 16544.503664890042, 16549.66900661986, 16627.334906603723, 16496.587585310343, 16627.66744665106, 16637.417690380807, 16663.750043749355, 16682.58293542662, 738.7931379213828, 843.3801156150224, 875.0855356152836, 876.2902049340023, 884.2925659472396, 869.2046777198856, 875.6803766625168, 875.7854325690215, 875.8204568063563, 876.570480464571, 920.9033051529593, 923.8198551282503, 924.3021518753332, 924.7688077980505, 925.1581061234278, 916.2303664921465, 918.274563095154, 918.3020904112856, 921.2123634292684, 922.0548937339247, 674.9696263668097, 675.6317806795308, 676.245985725917, 677.8271540757124, 679.1273213920089, 13274.601761947157, 13454.461821527128, 14179.0, 14585.416583336653, 14650.487232946796, 14206.07660502064, 15604.92197539005, 15751.2124393781, 15977.520674379788, 16187.595310117224, 14188.574342769733, 14246.501372452018, 14313.0, 14377.928110359486, 14498.855011449961, 4636.374089497908, 4655.464621568495, 4671.58080202273, 4730.455997560291, 4761.666683332168, 67901.0, 69541.30458695449, 69646.3035369645, 78055.60972195103, 78614.0, 12479.688007799878, 12746.171498852545, 12814.496805111747, 12967.610971670865, 13247.602571922858, 19645.01774911249, 19736.30922917691, 19747.111379987648, 19755.01224938776, 19762.90118549398, 9291.814163716688, 9301.813963720688, 9427.905720942703, 9583.0, 9770.706878793648, 4730.432348118248, 4835.492273311322, 4874.390701162355, 5040.47075057121, 5123.770295129217, 3929.4891664083484, 4065.8780236592947, 4094.0992981544014, 4096.631303182728, 4424.0709451015, 782.9295363417206, 797.7367468735304, 798.4530596541388, 806.7378102116718, 810.7365106340463, 684.3259389501337, 684.5310961991051, 699.0143897105057, 763.2253262938123, 768.6195333310047, 10477.580896764044, 10926.235163538635, 11155.776884462266, 11561.76876462466, 11655.533778648929, 693.9659906738923, 738.1695592458484, 751.0949306086153, 763.9991610989622, 785.3638552772272, 4707.764611769398, 4965.35450391454, 5028.673136246132, 5078.238264260391, 5109.463506331782, 116832.0, 117184.41407793076, 117927.41036294935, 119595.40202298932, 123737.0, 104010.0, 105777.0, 109255.0, 112252.0, 112451.43774281077, 94466.52766736122, 95233.0, 96170.0, 97391.51304243575, 98880.99999999856, 9498.857517137387, 9503.429794212369, 9529.0, 9530.428174309563, 9844.261680373857, 48871.5112848867, 52228.0, 54187.18719219136, 59029.0, 61014.69492652508, 50565.494345056075, 63685.3631463698, 67346.32653673597, 69254.65372673105, 70974.64512677403, 13560.796588051384, 13651.11267767592, 13672.042956993313, 13695.0, 13788.586342409744, 14989.775153372926, 15135.545933622008, 16004.759928600848, 16283.348666053698, 16326.591835204215, 14673.0, 14687.339069741674, 14748.926255368655, 14767.483138090116, 15206.163660998309, 13753.587392378246, 13907.860921390657, 14283.0, 14297.35661895238, 15200.315985780446, 11373.54505819758, 13047.478100875858, 13513.459461621425, 13579.59261222165, 13746.518871839438, 11100.444977751242, 11153.442327883411, 11245.381504017358, 11952.282863028246, 12120.818187727367, 12218.0, 12598.87401125977, 12658.0, 12772.361381931052, 12826.55107071248], "value": 8059.065516257821, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1495.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 111.0, 103.0, 109.0, 109.0, 112.0, 108.0, 110.0, 111.0, 110.0], "value": 108.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 114.0, 144.0, 185.0, 121.0, 147.0, 149.0, 116.0, 175.0, 124.0], "value": 142.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 161.0, 161.0, 162.0, 162.0, 161.0, 160.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 74.0, 178.0, 75.0, 74.0, 75.0, 74.0, 176.0, 75.0], "value": 95.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 147.0, 83.0, 85.0, 82.0, 138.0, 84.0, 85.0, 141.0], "value": 101.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 53.0, 51.0, 52.0, 51.0, 51.0, 51.0, 53.0, 51.0], "value": 51.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 59.0, 59.0, 58.0, 59.0, 59.0, 59.0, 59.0, 59.0, 58.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 81.0, 71.0, 72.0, 77.0, 72.0, 79.0, 72.0, 71.0], "value": 73.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 119.0, 116.0, 116.0, 123.0, 118.0, 147.0, 124.0, 151.0, 117.0], "value": 125.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 154.0, 155.0, 157.0, 156.0, 159.0, 152.0, 155.0, 155.0, 158.0], "value": 155.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 62.0, 64.0, 60.0, 60.0, 60.0, 62.0, 60.0], "value": 61.2, "unit": "score"}]}]} 07:20:17 INFO - Return code: 0 07:20:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:20:17 ERROR - # TBPL SUCCESS # 07:20:17 INFO - Running post-action listener: _resource_record_post_action 07:20:17 INFO - [mozharness: 2016-09-01 14:20:17.806673Z] Finished run-tests step (success) 07:20:17 INFO - Running post-run listener: _resource_record_post_run 07:20:17 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 327409664; Read time: 12; Write time: 218352 07:20:17 INFO - TinderboxPrint: CPU usage
13.2% 07:20:17 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 07:20:17 INFO - TinderboxPrint: I/O write bytes / time
327,409,664 / 218,352 07:20:17 INFO - TinderboxPrint: CPU idle
8,229.5 (86.7%) 07:20:17 INFO - TinderboxPrint: CPU user
1,199.1 (12.6%) 07:20:17 INFO - TinderboxPrint: Swap in / out
0 / 0 07:20:17 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 78381056; Read time: 0; Write time: 69216 07:20:17 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 248127488; Read time: 12; Write time: 149112 07:20:18 INFO - Running post-run listener: _upload_blobber_files 07:20:18 INFO - Blob upload gear active. 07:20:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:20:18 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 07:20:18 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'] 07:20:18 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 07:20:18 INFO - (blobuploader) - INFO - Open directory for files ... 07:20:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:20:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:20:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:20:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:20:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:20:19 INFO - (blobuploader) - INFO - Done attempting. 07:20:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:20:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:20:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:20:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:20:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:20:21 INFO - (blobuploader) - INFO - Done attempting. 07:20:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:20:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:20:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:20:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:20:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:20:28 INFO - (blobuploader) - INFO - Done attempting. 07:20:28 INFO - (blobuploader) - INFO - Iteration through files over. 07:20:28 INFO - Return code: 0 07:20:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:20:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:20:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8407beb3e98dc67b335a55f4f2ad59ce3e28c7d6ef8ca666a414b3c077748062c88dd8b72e7656c3fc3ba0183126ec8f3750b7ee352308586cf1c90f0fdf13d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b254a238b109b085a0f4d13c0fcc1543ccfa113e541522a99163bfbe6f1d181b58c59dfccfe4e072b2281ca1ffd80c1e365f49820f0f09e455b18791ab1afc2f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8fccb1c3751c32b152dd272bdf8ddcc8c9173aa4b636acad4fdc6fe3d8bed0daaa0a15f1df8ab4ca7c16eef88ff498ca05b3ea9f407322084ff1b09438e51ce6"} 07:20:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:20:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:20:28 INFO - Contents: 07:20:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8407beb3e98dc67b335a55f4f2ad59ce3e28c7d6ef8ca666a414b3c077748062c88dd8b72e7656c3fc3ba0183126ec8f3750b7ee352308586cf1c90f0fdf13d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b254a238b109b085a0f4d13c0fcc1543ccfa113e541522a99163bfbe6f1d181b58c59dfccfe4e072b2281ca1ffd80c1e365f49820f0f09e455b18791ab1afc2f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8fccb1c3751c32b152dd272bdf8ddcc8c9173aa4b636acad4fdc6fe3d8bed0daaa0a15f1df8ab4ca7c16eef88ff498ca05b3ea9f407322084ff1b09438e51ce6"} 07:20:28 INFO - Running post-run listener: copy_logs_to_upload_dir 07:20:28 INFO - Copying logs to upload dir... 07:20:28 INFO - mkdir: /builds/slave/test/build/upload/logs 07:20:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1681.360569 ========= master_lag: 4.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 5 secs) (at 2016-09-01 07:20:32.568226) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-09-01 07:20:32.573174) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1472737028.876801-1215529486 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/8407beb3e98dc67b335a55f4f2ad59ce3e28c7d6ef8ca666a414b3c077748062c88dd8b72e7656c3fc3ba0183126ec8f3750b7ee352308586cf1c90f0fdf13d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b254a238b109b085a0f4d13c0fcc1543ccfa113e541522a99163bfbe6f1d181b58c59dfccfe4e072b2281ca1ffd80c1e365f49820f0f09e455b18791ab1afc2f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8fccb1c3751c32b152dd272bdf8ddcc8c9173aa4b636acad4fdc6fe3d8bed0daaa0a15f1df8ab4ca7c16eef88ff498ca05b3ea9f407322084ff1b09438e51ce6"} build_url:https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011181 build_url: 'https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/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/8407beb3e98dc67b335a55f4f2ad59ce3e28c7d6ef8ca666a414b3c077748062c88dd8b72e7656c3fc3ba0183126ec8f3750b7ee352308586cf1c90f0fdf13d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b254a238b109b085a0f4d13c0fcc1543ccfa113e541522a99163bfbe6f1d181b58c59dfccfe4e072b2281ca1ffd80c1e365f49820f0f09e455b18791ab1afc2f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8fccb1c3751c32b152dd272bdf8ddcc8c9173aa4b636acad4fdc6fe3d8bed0daaa0a15f1df8ab4ca7c16eef88ff498ca05b3ea9f407322084ff1b09438e51ce6"}' ========= master_lag: 1.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-09-01 07:20:33.598550) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-09-01 07:20:33.603063) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1472737028.876801-1215529486 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 2.60 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-09-01 07:20:36.202679) ========= ========= Started reboot skipped (results: 3, elapsed: 7 secs) (at 2016-09-01 07:20:36.203085) ========= ========= Finished reboot skipped (results: 3, elapsed: 7 secs) (at 2016-09-01 07:20:43.936019) ========= ========= Total master_lag: 7.89 =========