builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-067 starttime: 1472064531.17 results: success (0) buildid: 20160824072526 builduid: 331913dd534e470f934cd8544daf0d29 revision: e9da92c75a6933143d43fba52e57cad2a7d9246c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-24 11:48:51.165897) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-24 11:48:51.166296) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-24 11:48:51.166570) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-24 11:48:51.203606) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 11:48:51.203887) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1472060043.313554-2028269326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-24 11:48:51-- 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% 43.8M=0s 2016-08-24 11:48:51 (43.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.083025 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 11:48:51.301877) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 11:48:51.302325) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1472060043.313554-2028269326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014766 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 11:48:51.353610) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 11:48:51.353930) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e9da92c75a6933143d43fba52e57cad2a7d9246c --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 e9da92c75a6933143d43fba52e57cad2a7d9246c --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=e0e61f6f900f4dc42e3e8956000001ad-1472060043.313554-2028269326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-24 11:48:51,899 truncating revision to first 12 chars 2016-08-24 11:48:51,899 Setting DEBUG logging. 2016-08-24 11:48:51,900 attempt 1/10 2016-08-24 11:48:51,900 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e9da92c75a69?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-24 11:48:52,210 unpacking tar archive at: mozilla-aurora-e9da92c75a69/testing/mozharness/ program finished with exit code 0 elapsedTime=0.638804 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 11:48:52.006175) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-24 11:48:52.006476) ========= script_repo_revision: e9da92c75a6933143d43fba52e57cad2a7d9246c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-24 11:48:52.006906) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-24 11:48:52.007197) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-24 11:48:52.026383) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 56 secs) (at 2016-08-24 11:48:52.026655) ========= /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=e0e61f6f900f4dc42e3e8956000001ad-1472060043.313554-2028269326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:48:52 INFO - MultiFileLogger online at 20160824 11:48:52 in /builds/slave/test 11:48:52 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 11:48:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:48:52 INFO - {'append_to_log': False, 11:48:52 INFO - 'base_work_dir': '/builds/slave/test', 11:48:52 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:48:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:48:52 INFO - 'branch': 'Mozilla-Aurora', 11:48:52 INFO - 'buildbot_json_path': 'buildprops.json', 11:48:52 INFO - 'config_files': ('talos/linux_config.py',), 11:48:52 INFO - 'default_actions': ('clobber', 11:48:52 INFO - 'read-buildbot-config', 11:48:52 INFO - 'download-and-extract', 11:48:52 INFO - 'populate-webroot', 11:48:52 INFO - 'create-virtualenv', 11:48:52 INFO - 'install', 11:48:52 INFO - 'run-tests'), 11:48:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:48:52 INFO - 'download_minidump_stackwalk': True, 11:48:52 INFO - 'download_symbols': 'ondemand', 11:48:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:48:52 INFO - 'tooltool.py': '/tools/tooltool.py', 11:48:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:48:52 INFO - '/tools/misc-python/virtualenv.py')}, 11:48:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:48:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:48:52 INFO - 'installer_path': 'installer.exe', 11:48:52 INFO - 'log_level': 'info', 11:48:52 INFO - 'log_name': 'talos', 11:48:52 INFO - 'log_to_console': True, 11:48:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:48:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:48:52 INFO - 'opt_config_files': (), 11:48:52 INFO - 'pip_index': False, 11:48:52 INFO - 'sps_profile': False, 11:48:52 INFO - 'sps_profile_interval': 0, 11:48:52 INFO - 'suite': 'dromaeojs-e10s', 11:48:52 INFO - 'system_bits': '32', 11:48:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:48:52 INFO - 'title': 'talos-linux64-ix-067', 11:48:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:48:52 INFO - 'use_talos_json': True, 11:48:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:48:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:48:52 INFO - 'work_dir': 'build'} 11:48:52 INFO - [mozharness: 2016-08-24 18:48:52.669559Z] Running clobber step. 11:48:52 INFO - Running pre-action listener: _resource_record_pre_action 11:48:52 INFO - Running main action method: clobber 11:48:52 INFO - rmtree: /builds/slave/test/build 11:48:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:48:52 INFO - Running post-action listener: _resource_record_post_action 11:48:52 INFO - [mozharness: 2016-08-24 18:48:52.673392Z] Finished clobber step (success) 11:48:52 INFO - [mozharness: 2016-08-24 18:48:52.673492Z] Running read-buildbot-config step. 11:48:52 INFO - Running pre-action listener: _resource_record_pre_action 11:48:52 INFO - Running main action method: read_buildbot_config 11:48:52 INFO - Using buildbot properties: 11:48:52 INFO - { 11:48:52 INFO - "project": "", 11:48:52 INFO - "product": "firefox", 11:48:52 INFO - "script_repo_revision": "production", 11:48:52 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 11:48:52 INFO - "repository": "", 11:48:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 11:48:52 INFO - "buildid": "20160824072526", 11:48:52 INFO - "pgo_build": "True", 11:48:52 INFO - "basedir": "/builds/slave/test", 11:48:52 INFO - "buildnumber": 505, 11:48:52 INFO - "slavename": "talos-linux64-ix-067", 11:48:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:48:52 INFO - "platform": "ubuntu64_hw", 11:48:52 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:48:52 INFO - "branch": "mozilla-aurora", 11:48:52 INFO - "repo_path": "releases/mozilla-aurora", 11:48:52 INFO - "revision": "e9da92c75a6933143d43fba52e57cad2a7d9246c", 11:48:52 INFO - "stage_platform": "linux64-pgo", 11:48:52 INFO - "builduid": "331913dd534e470f934cd8544daf0d29", 11:48:52 INFO - "slavebuilddir": "test" 11:48:52 INFO - } 11:48:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 11:48:52 INFO - Running post-action listener: _resource_record_post_action 11:48:52 INFO - [mozharness: 2016-08-24 18:48:52.675900Z] Finished read-buildbot-config step (success) 11:48:52 INFO - [mozharness: 2016-08-24 18:48:52.675990Z] Running download-and-extract step. 11:48:52 INFO - Running pre-action listener: _resource_record_pre_action 11:48:52 INFO - Running main action method: download_and_extract 11:48:52 INFO - mkdir: /builds/slave/test/build/tests 11:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:52 INFO - https://queue.taskcluster.net/v1/task/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:48:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 11:48:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 11:48:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/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 11:48:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/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 11:48:52 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 11:48:52 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 11:48:52 INFO - retry: Failed, sleeping 30 seconds before retrying 11:49:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/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 11:49:22 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 11:49:22 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 11:49:22 INFO - retry: Failed, sleeping 60 seconds before retrying 11:50:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/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 11:50:22 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 11:50:22 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 11:50:22 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/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! 11:50:22 INFO - Caught exception: HTTP Error 404: Not Found 11:50:22 INFO - Caught exception: HTTP Error 404: Not Found 11:50:22 INFO - Caught exception: HTTP Error 404: Not Found 11:50:22 INFO - trying https://queue.taskcluster.net/v1/task/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 11:50:22 INFO - Downloading https://queue.taskcluster.net/v1/task/BWFGVTPVQhGDZ11syrORjA/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 11:50:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BWFGVTPVQhGDZ11syrORjA/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 11:50:23 INFO - Downloaded 1361 bytes. 11:50:23 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 11:50:23 INFO - Using the following test package requirements: 11:50:23 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 11:50:23 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 11:50:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:50:23 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 11:50:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 11:50:23 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 11:50:23 INFO - u'jsshell-linux-x86_64.zip'], 11:50:23 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 11:50:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:50:23 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 11:50:23 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 11:50:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:50:23 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 11:50:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:50:23 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 11:50:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:50:23 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 11:50:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:50:23 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:50: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')]} 11:50:23 INFO - https://queue.taskcluster.net/v1/task/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:50:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 11:50:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 11:50:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/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 11:50:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/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 11:50:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 11:50:23 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 11:50:23 INFO - retry: Failed, sleeping 30 seconds before retrying 11:50:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/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 11:50:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 11:50:53 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 11:50:53 INFO - retry: Failed, sleeping 60 seconds before retrying 11:51:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/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 11:51:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 11:51:53 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 11:51:53 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/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! 11:51:53 INFO - Caught exception: HTTP Error 404: Not Found 11:51:53 INFO - Caught exception: HTTP Error 404: Not Found 11:51:53 INFO - Caught exception: HTTP Error 404: Not Found 11:51:53 INFO - trying https://queue.taskcluster.net/v1/task/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 11:51:53 INFO - Downloading https://queue.taskcluster.net/v1/task/BWFGVTPVQhGDZ11syrORjA/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 11:51:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BWFGVTPVQhGDZ11syrORjA/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 11:51:54 INFO - Downloaded 21767213 bytes. 11:51:54 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'] 11:51:54 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 11:51:55 INFO - Return code: 0 11:51:55 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 11:51:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:55 INFO - https://queue.taskcluster.net/v1/task/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:51:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 11:51:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 11:51:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/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 11:51:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/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 11:51:55 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 11:51:55 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 11:51:55 INFO - retry: Failed, sleeping 30 seconds before retrying 11:52:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/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 11:52:25 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 11:52:25 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 11:52:25 INFO - retry: Failed, sleeping 60 seconds before retrying 11:53:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/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 11:53:25 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 11:53:25 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 11:53:25 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/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! 11:53:25 INFO - Caught exception: HTTP Error 404: Not Found 11:53:25 INFO - Caught exception: HTTP Error 404: Not Found 11:53:25 INFO - Caught exception: HTTP Error 404: Not Found 11:53:25 INFO - trying https://queue.taskcluster.net/v1/task/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 11:53:25 INFO - Downloading https://queue.taskcluster.net/v1/task/BWFGVTPVQhGDZ11syrORjA/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 11:53:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BWFGVTPVQhGDZ11syrORjA/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 11:53:26 INFO - Downloaded 21767213 bytes. 11:53:26 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'] 11:53:26 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 11:53:28 INFO - Return code: 0 11:53:28 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')]} 11:53:28 INFO - https://queue.taskcluster.net/v1/task/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:53:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 11:53:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 11:53:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/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 11:53:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/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 11:53:28 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 11:53:28 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 11:53:28 INFO - retry: Failed, sleeping 30 seconds before retrying 11:53:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/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 11: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/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 11:53:58 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 11:53:58 INFO - retry: Failed, sleeping 60 seconds before retrying 11:54:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/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 11:54:58 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 11:54:58 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 11:54:58 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/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! 11:54:58 INFO - Caught exception: HTTP Error 404: Not Found 11:54:58 INFO - Caught exception: HTTP Error 404: Not Found 11:54:58 INFO - Caught exception: HTTP Error 404: Not Found 11:54:58 INFO - trying https://queue.taskcluster.net/v1/task/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 11:54:58 INFO - Downloading https://queue.taskcluster.net/v1/task/BWFGVTPVQhGDZ11syrORjA/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 11:54:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BWFGVTPVQhGDZ11syrORjA/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 11:54:59 INFO - Downloaded 14413723 bytes. 11:54:59 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'] 11:54:59 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 11:54:59 INFO - Return code: 0 11:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:59 INFO - https://queue.taskcluster.net/v1/task/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:54:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 11:54:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 11:54:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/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 11:54:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/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 11:54:59 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 11:54:59 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 11:54:59 INFO - retry: Failed, sleeping 30 seconds before retrying 11:55:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/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 11:55:29 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 11:55:29 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 11:55:29 INFO - retry: Failed, sleeping 60 seconds before retrying 11:56:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/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 11:56:29 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 11:56:29 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 11:56:29 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWFGVTPVQhGDZ11syrORjA/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! 11:56:29 INFO - Caught exception: HTTP Error 404: Not Found 11:56:29 INFO - Caught exception: HTTP Error 404: Not Found 11:56:29 INFO - Caught exception: HTTP Error 404: Not Found 11:56:29 INFO - trying https://queue.taskcluster.net/v1/task/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 11:56:29 INFO - Downloading https://queue.taskcluster.net/v1/task/BWFGVTPVQhGDZ11syrORjA/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 11:56:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BWFGVTPVQhGDZ11syrORjA/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 11:56:31 INFO - Downloaded 63756597 bytes. 11:56:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 11:56:31 INFO - mkdir: /builds/slave/test/properties 11:56:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:56:31 INFO - Writing to file /builds/slave/test/properties/build_url 11:56:31 INFO - Contents: 11:56:31 INFO - build_url:https://queue.taskcluster.net/v1/task/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 11:56:31 INFO - Running post-action listener: _resource_record_post_action 11:56:31 INFO - Running post-action listener: set_extra_try_arguments 11:56:31 INFO - [mozharness: 2016-08-24 18:56:31.663487Z] Finished download-and-extract step (success) 11:56:31 INFO - [mozharness: 2016-08-24 18:56:31.663719Z] Running populate-webroot step. 11:56:31 INFO - Running pre-action listener: _resource_record_pre_action 11:56:31 INFO - Running main action method: populate_webroot 11:56:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:56:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:56:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:56:31 INFO - '--tppagecycles', 11:56:31 INFO - '7'], 11:56:31 INFO - 'tests': ['tsvgm']}}, 11:56:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:56:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:56:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:56:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:56:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:56:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:56:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:56:31 INFO - 'talos_options': ['--disable-e10s'], 11:56:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:56:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:56:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:56:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:56:31 INFO - 'talos_options': ['--disable-e10s'], 11:56:31 INFO - 'tests': ['damp', 'tps']}, 11:56:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:56:31 INFO - 'tests': ['damp', 'tps']}, 11:56:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:56:31 INFO - 'tests': ['dromaeo_dom']}, 11:56:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:56:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:56:31 INFO - 'tests': ['basic_compositor_video']}, 11:56:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:56:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:56:31 INFO - 'tests': ['a11yr', 11:56:31 INFO - 'ts_paint', 11:56:31 INFO - 'tpaint', 11:56:31 INFO - 'sessionrestore', 11:56:31 INFO - 'sessionrestore_no_auto_restore', 11:56:31 INFO - 'tabpaint']}, 11:56:31 INFO - 'other-e10s': {'tests': ['a11yr', 11:56:31 INFO - 'ts_paint', 11:56:31 INFO - 'tpaint', 11:56:31 INFO - 'sessionrestore', 11:56:31 INFO - 'sessionrestore_no_auto_restore', 11:56:31 INFO - 'tabpaint']}, 11:56:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:56:31 INFO - 'ts_paint', 11:56:31 INFO - 'tpaint', 11:56:31 INFO - 'sessionrestore', 11:56:31 INFO - 'sessionrestore_no_auto_restore', 11:56:31 INFO - 'tabpaint']}, 11:56:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:56:31 INFO - 'ts_paint', 11:56:31 INFO - 'tpaint', 11:56:31 INFO - 'sessionrestore', 11:56:31 INFO - 'sessionrestore_no_auto_restore', 11:56:31 INFO - 'tabpaint']}, 11:56:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:56:31 INFO - 'tests': ['a11yr', 11:56:31 INFO - 'ts_paint', 11:56:31 INFO - 'tpaint', 11:56:31 INFO - 'sessionrestore', 11:56:31 INFO - 'sessionrestore_no_auto_restore', 11:56:31 INFO - 'tabpaint']}, 11:56:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:56:31 INFO - 'tests': ['a11yr', 11:56:31 INFO - 'ts_paint', 11:56:31 INFO - 'tpaint', 11:56:31 INFO - 'sessionrestore', 11:56:31 INFO - 'sessionrestore_no_auto_restore', 11:56:31 INFO - 'tabpaint']}, 11:56:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:56:31 INFO - 'tests': ['tsvgx', 11:56:31 INFO - 'tsvgr_opacity', 11:56:31 INFO - 'tart', 11:56:31 INFO - 'tscrollx', 11:56:31 INFO - 'cart']}, 11:56:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:56:31 INFO - 'tsvgr_opacity', 11:56:31 INFO - 'tart', 11:56:31 INFO - 'tscrollx', 11:56:31 INFO - 'cart']}, 11:56:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:56:31 INFO - 'talos_options': ['--disable-e10s'], 11:56:31 INFO - 'tests': ['tp5o']}, 11:56:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:56:31 INFO - 'tests': ['tp5o']}, 11:56:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:56:31 INFO - 'talos_options': ['--disable-e10s', 11:56:31 INFO - '--xperf_path', 11:56:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:56:31 INFO - 'tests': ['tp5n']}, 11:56:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:56:31 INFO - 'talos_options': ['--xperf_path', 11:56:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:56:31 INFO - 'tests': ['tp5n']}}, 11:56:31 INFO - 'talos.zip': {'path': '', 11:56:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:56:31 INFO - Running post-action listener: _resource_record_post_action 11:56:31 INFO - [mozharness: 2016-08-24 18:56:31.680703Z] Finished populate-webroot step (success) 11:56:31 INFO - [mozharness: 2016-08-24 18:56:31.680792Z] Running create-virtualenv step. 11:56:31 INFO - Running pre-action listener: _resource_record_pre_action 11:56:31 INFO - Running main action method: create_virtualenv 11:56:31 INFO - Creating virtualenv /builds/slave/test/build/venv 11:56:31 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 11:56:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:56:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:56:31 INFO - Using real prefix '/usr' 11:56:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:56:32 INFO - Installing distribute.............................................................................................................................................................................................done. 11:56:34 INFO - Installing pip.................done. 11:56:34 INFO - Return code: 0 11:56:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:56: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')]} 11:56:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:56:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56: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')]} 11:56:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:56:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:34 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 0x12f4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1523400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b2570>, '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 0x15b3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b3900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1472060043.313554-2028269326', '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 11:56:34 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 11:56:34 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 11:56:34 INFO - Using env: {'DISPLAY': ':0', 11:56:34 INFO - 'HOME': '/home/cltbld', 11:56:34 INFO - 'LANG': 'en_US.UTF-8', 11:56:34 INFO - 'LANGUAGE': 'en_US:en', 11:56:34 INFO - 'LOGNAME': 'cltbld', 11:56:34 INFO - 'MAIL': '/var/mail/cltbld', 11:56:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:34 INFO - 'MOZ_NO_REMOTE': '1', 11:56:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:56:34 INFO - 'NO_EM_RESTART': '1', 11:56:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:56:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:34 INFO - 'PWD': '/builds/slave/test', 11:56:34 INFO - 'SHELL': '/bin/bash', 11:56:34 INFO - 'SHLVL': '1', 11:56:34 INFO - 'TERM': 'linux', 11:56:34 INFO - 'TMOUT': '86400', 11:56:34 INFO - 'USER': 'cltbld', 11:56:34 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1472060043.313554-2028269326', 11:56:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:34 INFO - '_': '/tools/buildbot/bin/python'} 11:56:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:56:34 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 11:56:34 INFO - Cleaning up... 11:56:34 INFO - Return code: 0 11:56:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:56: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')]} 11:56:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:56:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56: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')]} 11:56:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:56:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:34 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 0x12f4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1523400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b2570>, '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 0x15b3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b3900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1472060043.313554-2028269326', '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 11:56:34 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 11:56:34 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 11:56:34 INFO - Using env: {'DISPLAY': ':0', 11:56:34 INFO - 'HOME': '/home/cltbld', 11:56:34 INFO - 'LANG': 'en_US.UTF-8', 11:56:34 INFO - 'LANGUAGE': 'en_US:en', 11:56:34 INFO - 'LOGNAME': 'cltbld', 11:56:34 INFO - 'MAIL': '/var/mail/cltbld', 11:56:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:34 INFO - 'MOZ_NO_REMOTE': '1', 11:56:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:56:34 INFO - 'NO_EM_RESTART': '1', 11:56:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:56:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:34 INFO - 'PWD': '/builds/slave/test', 11:56:34 INFO - 'SHELL': '/bin/bash', 11:56:34 INFO - 'SHLVL': '1', 11:56:34 INFO - 'TERM': 'linux', 11:56:34 INFO - 'TMOUT': '86400', 11:56:34 INFO - 'USER': 'cltbld', 11:56:34 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1472060043.313554-2028269326', 11:56:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:34 INFO - '_': '/tools/buildbot/bin/python'} 11:56:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:56:34 INFO - Downloading/unpacking psutil>=3.1.1 11:56:34 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 11:56:34 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 11:56:34 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 11:56:34 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 11:56:34 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 11:56:34 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 11:56:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:56:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:56:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:56:36 INFO - Installing collected packages: psutil 11:56:36 INFO - Running setup.py install for psutil 11:56:36 INFO - building 'psutil._psutil_linux' extension 11:56:36 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 11:56:36 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 11:56:36 INFO - building 'psutil._psutil_posix' extension 11:56:36 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 11:56:37 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 11:56:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:56:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:56:37 INFO - Successfully installed psutil 11:56:37 INFO - Cleaning up... 11:56:37 INFO - Return code: 0 11:56:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:56:37 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')]} 11:56:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:56:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:37 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')]} 11:56:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:56:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:37 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 0x12f4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1523400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b2570>, '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 0x15b3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b3900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1472060043.313554-2028269326', '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 11:56:37 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 11:56:37 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 11:56:37 INFO - Using env: {'DISPLAY': ':0', 11:56:37 INFO - 'HOME': '/home/cltbld', 11:56:37 INFO - 'LANG': 'en_US.UTF-8', 11:56:37 INFO - 'LANGUAGE': 'en_US:en', 11:56:37 INFO - 'LOGNAME': 'cltbld', 11:56:37 INFO - 'MAIL': '/var/mail/cltbld', 11:56:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:37 INFO - 'MOZ_NO_REMOTE': '1', 11:56:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:56:37 INFO - 'NO_EM_RESTART': '1', 11:56:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:56:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:37 INFO - 'PWD': '/builds/slave/test', 11:56:37 INFO - 'SHELL': '/bin/bash', 11:56:37 INFO - 'SHLVL': '1', 11:56:37 INFO - 'TERM': 'linux', 11:56:37 INFO - 'TMOUT': '86400', 11:56:37 INFO - 'USER': 'cltbld', 11:56:37 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1472060043.313554-2028269326', 11:56:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:37 INFO - '_': '/tools/buildbot/bin/python'} 11:56:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:56:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:56:37 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 11:56:37 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 11:56:37 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 11:56:37 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 11:56:37 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 11:56:37 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 11:56:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:56:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:56:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:56:39 INFO - Installing collected packages: mozsystemmonitor 11:56:39 INFO - Running setup.py install for mozsystemmonitor 11:56:39 INFO - Successfully installed mozsystemmonitor 11:56:39 INFO - Cleaning up... 11:56:39 INFO - Return code: 0 11:56:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:56:39 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')]} 11:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:56:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:39 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')]} 11:56:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:56:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:39 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 0x12f4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1523400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b2570>, '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 0x15b3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b3900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1472060043.313554-2028269326', '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 11:56:39 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 11:56:39 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 11:56:39 INFO - Using env: {'DISPLAY': ':0', 11:56:39 INFO - 'HOME': '/home/cltbld', 11:56:39 INFO - 'LANG': 'en_US.UTF-8', 11:56:39 INFO - 'LANGUAGE': 'en_US:en', 11:56:39 INFO - 'LOGNAME': 'cltbld', 11:56:39 INFO - 'MAIL': '/var/mail/cltbld', 11:56:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:39 INFO - 'MOZ_NO_REMOTE': '1', 11:56:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:56:39 INFO - 'NO_EM_RESTART': '1', 11:56:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:56:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:39 INFO - 'PWD': '/builds/slave/test', 11:56:39 INFO - 'SHELL': '/bin/bash', 11:56:39 INFO - 'SHLVL': '1', 11:56:39 INFO - 'TERM': 'linux', 11:56:39 INFO - 'TMOUT': '86400', 11:56:39 INFO - 'USER': 'cltbld', 11:56:39 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1472060043.313554-2028269326', 11:56:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:39 INFO - '_': '/tools/buildbot/bin/python'} 11:56:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:56:39 INFO - Downloading/unpacking jsonschema==2.5.1 11:56:39 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 11:56:39 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 11:56:39 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 11:56:39 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 11:56:39 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 11:56:39 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 11:56:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:56:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:56:41 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 11:56:41 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 11:56:41 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 11:56:41 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 11:56:41 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 11:56:41 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 11:56:41 INFO - Downloading functools32-3.2.3-2.tar.gz 11:56:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:56:41 INFO - warning: no files found matching '*.txt' 11:56:41 INFO - no previously-included directories found matching 'build' 11:56:41 INFO - no previously-included directories found matching 'dist' 11:56:41 INFO - no previously-included directories found matching '.git*' 11:56:41 INFO - Installing collected packages: jsonschema, functools32 11:56:41 INFO - Running setup.py install for functools32 11:56:41 INFO - warning: no files found matching '*.txt' 11:56:41 INFO - no previously-included directories found matching 'build' 11:56:41 INFO - no previously-included directories found matching 'dist' 11:56:41 INFO - no previously-included directories found matching '.git*' 11:56:42 INFO - Successfully installed jsonschema functools32 11:56:42 INFO - Cleaning up... 11:56:42 INFO - Return code: 0 11:56:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:56:42 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')]} 11:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:56:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:42 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')]} 11:56:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:56:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:42 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 0x12f4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1523400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b2570>, '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 0x15b3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b3900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1472060043.313554-2028269326', '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 11:56:42 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 11:56:42 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 11:56:42 INFO - Using env: {'DISPLAY': ':0', 11:56:42 INFO - 'HOME': '/home/cltbld', 11:56:42 INFO - 'LANG': 'en_US.UTF-8', 11:56:42 INFO - 'LANGUAGE': 'en_US:en', 11:56:42 INFO - 'LOGNAME': 'cltbld', 11:56:42 INFO - 'MAIL': '/var/mail/cltbld', 11:56:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:42 INFO - 'MOZ_NO_REMOTE': '1', 11:56:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:56:42 INFO - 'NO_EM_RESTART': '1', 11:56:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:56:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:42 INFO - 'PWD': '/builds/slave/test', 11:56:42 INFO - 'SHELL': '/bin/bash', 11:56:42 INFO - 'SHLVL': '1', 11:56:42 INFO - 'TERM': 'linux', 11:56:42 INFO - 'TMOUT': '86400', 11:56:42 INFO - 'USER': 'cltbld', 11:56:42 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1472060043.313554-2028269326', 11:56:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:42 INFO - '_': '/tools/buildbot/bin/python'} 11:56:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:56:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:56:42 INFO - Cleaning up... 11:56:42 INFO - Return code: 0 11:56:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:56:42 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')]} 11:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:56:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:42 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')]} 11:56:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:56:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:42 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 0x12f4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1523400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b2570>, '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 0x15b3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b3900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1472060043.313554-2028269326', '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 11:56:42 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 11:56:42 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 11:56:42 INFO - Using env: {'DISPLAY': ':0', 11:56:42 INFO - 'HOME': '/home/cltbld', 11:56:42 INFO - 'LANG': 'en_US.UTF-8', 11:56:42 INFO - 'LANGUAGE': 'en_US:en', 11:56:42 INFO - 'LOGNAME': 'cltbld', 11:56:42 INFO - 'MAIL': '/var/mail/cltbld', 11:56:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:42 INFO - 'MOZ_NO_REMOTE': '1', 11:56:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:56:42 INFO - 'NO_EM_RESTART': '1', 11:56:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:56:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:42 INFO - 'PWD': '/builds/slave/test', 11:56:42 INFO - 'SHELL': '/bin/bash', 11:56:42 INFO - 'SHLVL': '1', 11:56:42 INFO - 'TERM': 'linux', 11:56:42 INFO - 'TMOUT': '86400', 11:56:42 INFO - 'USER': 'cltbld', 11:56:42 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1472060043.313554-2028269326', 11:56:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:42 INFO - '_': '/tools/buildbot/bin/python'} 11:56:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:56:42 INFO - Downloading/unpacking blobuploader==1.2.4 11:56:42 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 11:56:42 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 11:56:42 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 11:56:42 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 11:56:42 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 11:56:42 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 11:56:44 INFO - Downloading blobuploader-1.2.4.tar.gz 11:56:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:56:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:56:44 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 11:56:44 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 11:56:44 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 11:56:44 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 11:56:44 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 11:56:44 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 11:56:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:56:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:56:44 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 11:56:44 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 11:56:44 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 11:56:44 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 11:56:44 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 11:56:44 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 11:56:45 INFO - Downloading docopt-0.6.1.tar.gz 11:56:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:56:45 INFO - Installing collected packages: blobuploader, requests, docopt 11:56:45 INFO - Running setup.py install for blobuploader 11:56:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:56:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:56:45 INFO - Running setup.py install for requests 11:56:45 INFO - Running setup.py install for docopt 11:56:45 INFO - Successfully installed blobuploader requests docopt 11:56:45 INFO - Cleaning up... 11:56:45 INFO - Return code: 0 11:56:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:56:45 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')]} 11:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:56:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:45 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')]} 11:56:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:56:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:45 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 0x12f4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1523400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b2570>, '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 0x15b3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b3900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1472060043.313554-2028269326', '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 11:56:45 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 11:56:45 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 11:56:45 INFO - Using env: {'DISPLAY': ':0', 11:56:45 INFO - 'HOME': '/home/cltbld', 11:56:45 INFO - 'LANG': 'en_US.UTF-8', 11:56:45 INFO - 'LANGUAGE': 'en_US:en', 11:56:45 INFO - 'LOGNAME': 'cltbld', 11:56:45 INFO - 'MAIL': '/var/mail/cltbld', 11:56:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:45 INFO - 'MOZ_NO_REMOTE': '1', 11:56:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:56:45 INFO - 'NO_EM_RESTART': '1', 11:56:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:56:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:45 INFO - 'PWD': '/builds/slave/test', 11:56:45 INFO - 'SHELL': '/bin/bash', 11:56:45 INFO - 'SHLVL': '1', 11:56:45 INFO - 'TERM': 'linux', 11:56:45 INFO - 'TMOUT': '86400', 11:56:45 INFO - 'USER': 'cltbld', 11:56:45 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1472060043.313554-2028269326', 11:56:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:45 INFO - '_': '/tools/buildbot/bin/python'} 11:56:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:56:45 INFO - Running setup.py (path:/tmp/pip-Q1hcCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:56:46 INFO - Running setup.py (path:/tmp/pip-jcy3YT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:56:46 INFO - Running setup.py (path:/tmp/pip-mwQYpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:56:46 INFO - Running setup.py (path:/tmp/pip-WcDLCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:56:46 INFO - Running setup.py (path:/tmp/pip-4jH66P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:56:46 INFO - Running setup.py (path:/tmp/pip-NqUMjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:56:46 INFO - Running setup.py (path:/tmp/pip-TuqiCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:56:46 INFO - Running setup.py (path:/tmp/pip-5rV9O6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:56:46 INFO - Running setup.py (path:/tmp/pip-UJRtd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:56:46 INFO - Running setup.py (path:/tmp/pip-KjEPn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:56:46 INFO - Running setup.py (path:/tmp/pip-gqhOVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:56:46 INFO - Running setup.py (path:/tmp/pip-CRxDVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:56:46 INFO - Running setup.py (path:/tmp/pip-Uu7ti1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:56:46 INFO - Running setup.py (path:/tmp/pip-ckOQZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:56:46 INFO - Running setup.py (path:/tmp/pip-rFWTAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:56:47 INFO - Running setup.py (path:/tmp/pip-gMaJ2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:56:47 INFO - Running setup.py (path:/tmp/pip-un6ro0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:56:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:56:47 INFO - Running setup.py install for manifestparser 11:56:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:56:47 INFO - Running setup.py install for mozcrash 11:56:47 INFO - Running setup.py install for mozdebug 11:56:47 INFO - Running setup.py install for mozdevice 11:56:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:56:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:56:47 INFO - Running setup.py install for mozfile 11:56:47 INFO - Running setup.py install for mozhttpd 11:56:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:56:47 INFO - Running setup.py install for mozinfo 11:56:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:56:47 INFO - Running setup.py install for mozInstall 11:56:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:56:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:56:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:56:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:56:48 INFO - Running setup.py install for mozleak 11:56:48 INFO - Running setup.py install for mozlog 11:56:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:56:48 INFO - Running setup.py install for moznetwork 11:56:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:56:48 INFO - Running setup.py install for mozprocess 11:56:48 INFO - Running setup.py install for mozprofile 11:56:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:56:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:56:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:56:48 INFO - Running setup.py install for mozrunner 11:56:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:56:48 INFO - Running setup.py install for mozscreenshot 11:56:48 INFO - Running setup.py install for moztest 11:56:48 INFO - Running setup.py install for mozversion 11:56:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:56:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:56:48 INFO - Cleaning up... 11:56:49 INFO - Return code: 0 11:56:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:56:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:56:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:56:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:49 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 0x12f4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1523400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b2570>, '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 0x15b3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b3900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1472060043.313554-2028269326', '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 11:56:49 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 11:56:49 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 11:56:49 INFO - Using env: {'DISPLAY': ':0', 11:56:49 INFO - 'HOME': '/home/cltbld', 11:56:49 INFO - 'LANG': 'en_US.UTF-8', 11:56:49 INFO - 'LANGUAGE': 'en_US:en', 11:56:49 INFO - 'LOGNAME': 'cltbld', 11:56:49 INFO - 'MAIL': '/var/mail/cltbld', 11:56:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:49 INFO - 'MOZ_NO_REMOTE': '1', 11:56:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:56:49 INFO - 'NO_EM_RESTART': '1', 11:56:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:56:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:49 INFO - 'PWD': '/builds/slave/test', 11:56:49 INFO - 'SHELL': '/bin/bash', 11:56:49 INFO - 'SHLVL': '1', 11:56:49 INFO - 'TERM': 'linux', 11:56:49 INFO - 'TMOUT': '86400', 11:56:49 INFO - 'USER': 'cltbld', 11:56:49 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1472060043.313554-2028269326', 11:56:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:49 INFO - '_': '/tools/buildbot/bin/python'} 11:56:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:56:49 INFO - Running setup.py (path:/tmp/pip-FsWWCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:56:49 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)) 11:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:56:49 INFO - Running setup.py (path:/tmp/pip-4JCy0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:56:49 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)) 11:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:56:49 INFO - Running setup.py (path:/tmp/pip-doXQeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:56:49 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)) 11:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:56:49 INFO - Running setup.py (path:/tmp/pip-DFI5o4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:56:49 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)) 11:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:56:49 INFO - Running setup.py (path:/tmp/pip-ca4dhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:56:49 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)) 11:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:56:49 INFO - Running setup.py (path:/tmp/pip-KBkvlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:56:49 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)) 11:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:56:49 INFO - Running setup.py (path:/tmp/pip-cmfHbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:56:49 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)) 11:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:56:49 INFO - Running setup.py (path:/tmp/pip-reCIZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:56:49 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)) 11:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:56:49 INFO - Running setup.py (path:/tmp/pip-S4rith-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:56:49 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)) 11:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:56:49 INFO - Running setup.py (path:/tmp/pip-brTrk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:56:49 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)) 11:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:56:49 INFO - Running setup.py (path:/tmp/pip-ZgpyXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:56:50 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)) 11:56:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:56:50 INFO - Running setup.py (path:/tmp/pip-sPZAVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:56:50 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)) 11:56:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:56:50 INFO - Running setup.py (path:/tmp/pip-nrtWkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:56:50 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)) 11:56:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:56:50 INFO - Running setup.py (path:/tmp/pip-Sq0o0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:56:50 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)) 11:56:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:56:50 INFO - Running setup.py (path:/tmp/pip-m65s8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:56:50 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)) 11:56:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:56:50 INFO - Running setup.py (path:/tmp/pip-UNf5Mo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:56:50 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)) 11:56:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:56:50 INFO - Running setup.py (path:/tmp/pip-9j3jgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:56:50 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)) 11:56:50 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)) 11:56:50 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)) 11:56:50 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)) 11:56:50 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)) 11:56:50 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)) 11:56:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:56:50 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 11:56:50 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 11:56:50 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 11:56:50 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 11:56:50 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 11:56:50 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 11:56:52 INFO - Downloading blessings-1.6.tar.gz 11:56:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:56:52 INFO - Installing collected packages: blessings 11:56:52 INFO - Running setup.py install for blessings 11:56:52 INFO - Successfully installed blessings 11:56:52 INFO - Cleaning up... 11:56:52 INFO - Return code: 0 11:56:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:56:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:56:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:56:52 INFO - Reading from file tmpfile_stdout 11:56:52 INFO - Current package versions: 11:56:52 INFO - argparse == 1.2.1 11:56:52 INFO - blessings == 1.6 11:56:52 INFO - blobuploader == 1.2.4 11:56:52 INFO - docopt == 0.6.1 11:56:52 INFO - functools32 == 3.2.3-2 11:56:52 INFO - jsonschema == 2.5.1 11:56:52 INFO - manifestparser == 1.1 11:56:52 INFO - mozInstall == 1.12 11:56:52 INFO - mozcrash == 0.17 11:56:52 INFO - mozdebug == 0.1 11:56:52 INFO - mozdevice == 0.48 11:56:52 INFO - mozfile == 1.2 11:56:52 INFO - mozhttpd == 0.7 11:56:52 INFO - mozinfo == 0.9 11:56:52 INFO - mozleak == 0.1 11:56:52 INFO - mozlog == 3.3 11:56:52 INFO - moznetwork == 0.27 11:56:52 INFO - mozprocess == 0.23 11:56:52 INFO - mozprofile == 0.28 11:56:52 INFO - mozrunner == 6.12 11:56:52 INFO - mozscreenshot == 0.1 11:56:52 INFO - mozsystemmonitor == 0.3 11:56:52 INFO - moztest == 0.7 11:56:52 INFO - mozversion == 1.4 11:56:52 INFO - psutil == 3.1.1 11:56:52 INFO - requests == 1.2.3 11:56:52 INFO - wsgiref == 0.1.2 11:56:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:56:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:56:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:56:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:56:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:52 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 0x12f4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1523400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b2570>, '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 0x15b3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b3900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1472060043.313554-2028269326', '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 11:56:52 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 11:56:52 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 11:56:52 INFO - Using env: {'DISPLAY': ':0', 11:56:52 INFO - 'HOME': '/home/cltbld', 11:56:52 INFO - 'LANG': 'en_US.UTF-8', 11:56:52 INFO - 'LANGUAGE': 'en_US:en', 11:56:52 INFO - 'LOGNAME': 'cltbld', 11:56:52 INFO - 'MAIL': '/var/mail/cltbld', 11:56:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:52 INFO - 'MOZ_NO_REMOTE': '1', 11:56:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:56:52 INFO - 'NO_EM_RESTART': '1', 11:56:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:56:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:52 INFO - 'PWD': '/builds/slave/test', 11:56:52 INFO - 'SHELL': '/bin/bash', 11:56:52 INFO - 'SHLVL': '1', 11:56:52 INFO - 'TERM': 'linux', 11:56:52 INFO - 'TMOUT': '86400', 11:56:52 INFO - 'USER': 'cltbld', 11:56:52 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1472060043.313554-2028269326', 11:56:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:52 INFO - '_': '/tools/buildbot/bin/python'} 11:56:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:56:52 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)) 11:56:52 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)) 11:56:52 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)) 11:56:52 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)) 11:56:52 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)) 11:56:52 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)) 11:56:52 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)) 11:56:52 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)) 11:56:52 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)) 11:56:52 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)) 11:56:52 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)) 11:56:52 INFO - Cleaning up... 11:56:53 INFO - Return code: 0 11:56:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:56:53 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')]} 11:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:56:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:53 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')]} 11:56:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:56:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:53 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 0x12f4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1523400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b2570>, '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 0x15b3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b3900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1472060043.313554-2028269326', '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 11:56:53 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 11:56:53 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 11:56:53 INFO - Using env: {'DISPLAY': ':0', 11:56:53 INFO - 'HOME': '/home/cltbld', 11:56:53 INFO - 'LANG': 'en_US.UTF-8', 11:56:53 INFO - 'LANGUAGE': 'en_US:en', 11:56:53 INFO - 'LOGNAME': 'cltbld', 11:56:53 INFO - 'MAIL': '/var/mail/cltbld', 11:56:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:53 INFO - 'MOZ_NO_REMOTE': '1', 11:56:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:56:53 INFO - 'NO_EM_RESTART': '1', 11:56:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:56:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:53 INFO - 'PWD': '/builds/slave/test', 11:56:53 INFO - 'SHELL': '/bin/bash', 11:56:53 INFO - 'SHLVL': '1', 11:56:53 INFO - 'TERM': 'linux', 11:56:53 INFO - 'TMOUT': '86400', 11:56:53 INFO - 'USER': 'cltbld', 11:56:53 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1472060043.313554-2028269326', 11:56:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:53 INFO - '_': '/tools/buildbot/bin/python'} 11:56:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:56:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:56:53 INFO - Cleaning up... 11:56:53 INFO - Return code: 0 11:56:53 INFO - Running post-action listener: _resource_record_post_action 11:56:53 INFO - Running post-action listener: _start_resource_monitoring 11:56:53 INFO - Starting resource monitoring. 11:56:53 INFO - [mozharness: 2016-08-24 18:56:53.261095Z] Finished create-virtualenv step (success) 11:56:53 INFO - [mozharness: 2016-08-24 18:56:53.261731Z] Running install step. 11:56:53 INFO - Running pre-action listener: _resource_record_pre_action 11:56:53 INFO - Running main action method: install 11:56:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:56:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:56:53 INFO - Reading from file tmpfile_stdout 11:56:53 INFO - Detecting whether we're running mozinstall >=1.0... 11:56:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:56:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:56:53 INFO - Reading from file tmpfile_stdout 11:56:53 INFO - Output received: 11:56:53 INFO - Usage: mozinstall [options] installer 11:56:53 INFO - Options: 11:56:53 INFO - -h, --help show this help message and exit 11:56:53 INFO - -d DEST, --destination=DEST 11:56:53 INFO - Directory to install application into. [default: 11:56:53 INFO - "/builds/slave/test"] 11:56:53 INFO - --app=APP Application being installed. [default: firefox] 11:56:53 INFO - mkdir: /builds/slave/test/build/application 11:56:53 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'] 11:56:53 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 11:57:10 INFO - Reading from file tmpfile_stdout 11:57:10 INFO - Output received: 11:57:10 INFO - /builds/slave/test/build/application/firefox/firefox 11:57:10 INFO - Running post-action listener: _resource_record_post_action 11:57:10 INFO - [mozharness: 2016-08-24 18:57:10.114045Z] Finished install step (success) 11:57:10 INFO - [mozharness: 2016-08-24 18:57:10.114322Z] Running run-tests step. 11:57:10 INFO - Running pre-action listener: _resource_record_pre_action 11:57:10 INFO - Running main action method: run_tests 11:57:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:57:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:57:10 INFO - Python 2.7.3 11:57:10 INFO - Return code: 0 11:57:10 INFO - grabbing minidump binary from tooltool 11:57:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:57:10 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 0x15b2570>, '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 0x15b3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b3900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:57:10 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 11:57:10 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 11:57:10 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 11:57:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:57:10 INFO - Return code: 0 11:57:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:57:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:57:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:57:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:57:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:57:10 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/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 11:57:10 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/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 11:57:10 INFO - Using env: {'DISPLAY': ':0', 11:57:10 INFO - 'HOME': '/home/cltbld', 11:57:10 INFO - 'LANG': 'en_US.UTF-8', 11:57:10 INFO - 'LANGUAGE': 'en_US:en', 11:57:10 INFO - 'LOGNAME': 'cltbld', 11:57:10 INFO - 'MAIL': '/var/mail/cltbld', 11:57:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:57:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:57:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:10 INFO - 'MOZ_NO_REMOTE': '1', 11:57:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:57:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:57:10 INFO - 'NO_EM_RESTART': '1', 11:57:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:57:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:10 INFO - 'PWD': '/builds/slave/test', 11:57:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:57:10 INFO - 'SHELL': '/bin/bash', 11:57:10 INFO - 'SHLVL': '1', 11:57:10 INFO - 'TERM': 'linux', 11:57:10 INFO - 'TMOUT': '86400', 11:57:10 INFO - 'USER': 'cltbld', 11:57:10 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1472060043.313554-2028269326', 11:57:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:10 INFO - '_': '/tools/buildbot/bin/python'} 11:57:10 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/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 11:57:10 INFO - mozversion application_buildid: 20160824072526 11:57:10 INFO - mozversion application_changeset: e9da92c75a6933143d43fba52e57cad2a7d9246c 11:57:10 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:57:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:57:10 INFO - mozversion application_name: Firefox 11:57:10 INFO - mozversion application_remotingname: firefox-dev 11:57:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:57:10 INFO - mozversion application_vendor: Mozilla 11:57:10 INFO - mozversion application_version: 50.0a2 11:57:10 INFO - mozversion platform_buildid: 20160824072526 11:57:10 INFO - mozversion platform_changeset: e9da92c75a6933143d43fba52e57cad2a7d9246c 11:57:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:57:10 INFO - mozversion platform_version: 50.0a2 11:57:10 INFO - using testdate: 1472065030 11:57:10 INFO - actual date: 1472065030 11:57:10 INFO - starting webserver on 'localhost:54381' 11:57:10 INFO - SUITE-START | Running 2 tests 11:57:10 INFO - TEST-START | dromaeo_css 11:57:10 INFO - operating with platform_type : linux_ 11:57:10 INFO - Initialising browser for dromaeo_css test... 11:57:10 INFO - TEST-INFO | started process 8864 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTk0u7a/profile http://localhost:54381/getInfo.html) 11:57:14 INFO - PROCESS | 8864 | __metrics Screen width/height:1600/1200 11:57:14 INFO - PROCESS | 8864 | colorDepth:24 11:57:14 INFO - PROCESS | 8864 | Browser inner width/height: 1024/697 11:57:14 INFO - PROCESS | 8864 | __metrics 11:57:14 ERROR - PROCESS | 8864 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 11:57:15 INFO - TEST-INFO | 8864: exit 0 11:57:15 INFO - Browser initialized. 11:57:15 INFO - Running cycle 1/1 for dromaeo_css test... 11:57:15 INFO - TEST-INFO | started process 8990 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTk0u7a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:57:27 INFO - PROCESS | 8990 | RSS: Main: 152748032 11:57:27 INFO - PROCESS | 8990 | 11:58:17 INFO - PROCESS | 8990 | 1472065097116 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] 12:00:25 INFO - PROCESS | 8990 | Cycle 1(1): loaded http://localhost:54381/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54381/tests/dromaeo/cssquery-ext.html) 12:00:26 INFO - PROCESS | 8990 | RSS: Main: 158400512 12:00:26 INFO - PROCESS | 8990 | 12:03:28 INFO - PROCESS | 8990 | Cycle 1(1): loaded http://localhost:54381/tests/dromaeo/cssquery-ext.html (next: http://localhost:54381/tests/dromaeo/cssquery-jquery.html) 12:03:29 INFO - PROCESS | 8990 | RSS: Main: 154402816 12:03:29 INFO - PROCESS | 8990 | 12:06:31 INFO - PROCESS | 8990 | Cycle 1(1): loaded http://localhost:54381/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54381/tests/dromaeo/cssquery-mootools.html) 12:06:31 INFO - PROCESS | 8990 | RSS: Main: 154574848 12:06:31 INFO - PROCESS | 8990 | 12:09:33 INFO - PROCESS | 8990 | Cycle 1(1): loaded http://localhost:54381/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54381/tests/dromaeo/cssquery-prototype.html) 12:09:34 INFO - PROCESS | 8990 | RSS: Main: 153165824 12:09:34 INFO - PROCESS | 8990 | 12:12:36 INFO - PROCESS | 8990 | Cycle 1(1): loaded http://localhost:54381/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54381/tests/dromaeo/cssquery-yui.html) 12:12:37 INFO - PROCESS | 8990 | RSS: Main: 155185152 12:12:37 INFO - PROCESS | 8990 | 12:15:39 INFO - PROCESS | 8990 | Cycle 1(1): loaded http://localhost:54381/tests/dromaeo/cssquery-yui.html (next: http://localhost:54381/tests/dromaeo/cssquery-dojo.html) 12:15:40 INFO - PROCESS | 8990 | RSS: Main: 155877376 12:15:40 INFO - PROCESS | 8990 | 12:15:40 INFO - PROCESS | 8990 | __start_tp_report 12:15:40 INFO - PROCESS | 8990 | _x_x_mozilla_page_load 12:15:40 INFO - PROCESS | 8990 | _x_x_mozilla_page_load_details 12:15:40 INFO - PROCESS | 8990 | |i|pagename|runs| 12:15:40 INFO - PROCESS | 8990 | |0;dojo.html;3276.6231883333417;3305.752068594856;3319.5684561007074;3325.251818340872;3327.4010678077952;5756.712164391779;5799.478046975772;5825.242718446601;5830.125481177825;5835.153902684114;5760.7407666655;5762.3949485304065;5799.710014499279;5802;5831.387704291052;5262.842114736554;5288.762005709752;5311.601629877755;5336.039512887679;5363.088274993241;5177.430482646906;5180.559652429529;5202.609804264695;5209.531142197202;5319.707416092114;5334.493223143795;5337.973310133444;5346.812861549846;5352.759125839327;5357.303550538444;5367.2485851980555;5371.382291036542;5393.433689462589;5404.270423492818;5405.729713514309;5026.220935754964;5128;5154.020736060136;5276.841694749163;5285.445028272053;5675.290588676416;5725.599208055438;5726.255586773693;5747.540196784247;5788.565857560699;6132.662703551303;6180.629162250234;6182.103594978703;6186.505079593621;6199.287081985584;5888.823335299948;6138.756267604225;6144.324124346318;6244.937550624481;6250.249970003629;5782.537397008229;5788.450097240755;5809.099589563624;5821.50517206038;5827.184194212771;6349.809505714836;6352.777652782131;6361.713722882481;6378;6398.104265402847;5888.3228428731245;6031.24609423822;6033.909491357633;6085.17850090241;6116.908246376308;6202.751889924442;6239.407256310734;6241.063840423973;6242.438180563771;6246.656433896089;6198.132261483396;6214.036824292242;6225.097360882737;6229.750809967551;6232.626042437469;5904.498117659961;6120.724567394478;6140.785072522441;6221.564490485713;6225.844353891189;4744.430668319824;4748.572628463386;4753.643476739258;4767.451743049524;4772.284157376352;4218.430511880857;4225.154969006211;4229.703920725581;4239.894002649897;4258.701890867672;5729.197912292282;5866.1494083357675;5884.588078834526;5972.731227094791;6017.729202185912;6201.472874805602;6228.750849966042;6247.843803904939;6249.187605611241;6254.6872656366995;5958.076498142795;5960.6721630309885;5965.582409231399;5966.76132954677;5999.6400215986305;5032.0690672225755;5166.767495462713;5200.76596553156;5204.297419848348;5220.321358223407;6468.838279043061;6495.577787443801;6513.772017979348;6515;6528.445082167974;6291.245050593958;6293.307736149111;6298.244210694746;6317.5893566918;6323.430891219812;6083.452489275986;6228.5951413158;6249.281332646622;6293.905591416041;6488.188976377953;6065.272167339947;6067.453929146398;6070.605410648293;6075.058365953284;6089.665068421102;6057.121717351048;6101.664408457577;6164.198654174928;6194.225721784777;6205.782797602063;5901.937651222821;5980.222571065734;6000.459958603747;6053.122297266784;6061.060535616986;6041.75832966694;6078.72645730952;6096.329403765671;6098;6102.542309326907;5981.222441082631;6027.336992930862;6033.668148251712;6033.668148251712;6040.607360521728;5711.771529138788;6045.939540604538;6055.969720151371;6090.147379366981;6115.663638499926;5954.07711804671;5987.970060149672;6014.0678194879865;6022.668753218615;6047.455728984412 12:15:40 INFO - PROCESS | 8990 | |1;ext.html;587.3187102960567;645.6384424722156;653.6502970910561;655.4428735574762;703.6727921516493;41098.794506027465;46841.53158468414;46925.296120558174;47072.29391559129;47210.52789472104;45819.541804581946;46180.53819461804;46237.53762462374;46395;46424;9066.45601263923;9129.726108216764;9187.494687792168;9196.494192819426;9244.121808428188;9050.637974481013;9092.727218183465;9154.450732956011;9161.541922903862;9166.816663666723;9166.54167291636;9180;9259.907400925971;9264.212541933945;9266;9093.09069093092;9138.086191380875;9139.680111196076;9190.035046320141;9208.49353285569;8792.560371981439;8804.8679269811;8878.778030549223;8893;8899.777505562348;43842.780786096184;44009;44431.77784111059;44470.55529444697;44493.332600011025;3163.43058249515;3537.7169826413824;3672.2288319452946;3854.8843534694006;3910.569837317893;35546.46680299797;35826.820865895505;36041.09897252564;37928.81035594832;39807.40288895669;4595.333676616905;4602.424696912886;4740.762961851894;4825.734584597846;4840.491748366406;385695;388222.99999999715;389304;389879;390689;70927.64536177389;72036;72133;72147;72152.63923680349;41256.968575785846;41707.7914610425;41876.581234187266;43938;75853.24146758462;19333.90333048326;19500.414987550397;19560.8043919559;19622.509437263896;19674.70487942682;14054.437822486985;14109.506167284097;14138.787918181235;14174.07868488545;14189.290535473185;22493.43766405853;22797.316080517612;23049.308520744406;23100.19149329799;23166.65250021251;7899.249571290718;8167.795805104801;8185.467944583583;8244.464109832841;8400.83198336042;1044.4255659387306;1131.9660410187707;1217.1358335581835;1250.4623012104882;1269.6635391621228;35136.12159696028;35306.82346588302;35417.29165416677;35620.82189589035;35711.10722231965;1198.8920997110129;1245.4582256718356;1249.1318533619228;1306.3794697518792;1335.9866401336058;18503.81496185048;18553.25786968506;18619.627607448045;18650.067496625114;18660.533486662942;644984;649787;651717;655088;656080;64363.67818160973;64505;64596;65126.67436662786;65171.348286517474;1426.2512181105003;1426.415169780406;1428.6356978970296;1466.0543949152736;1472.9337179826935;34554.30891382208;34761.65238347584;35179.648203518664;35250.823745881105;35373;55905.16142257788;56267.155992659325;56325;56365;56642.716786415804;496568;499652;499762;500012;500270;32230.516542251415;32358.514622281156;32420.83789581037;32428.83785581057;32644.673553264165;53309.7334513325;53605.73197133989;53837;53875.461245388615;54449;46576.301355479016;49510.75244623754;49652.75173624109;49837;50237.74881125571;47382.52617473781;47401;47518.287225690954;47525;47672.523274766805;46341;46620.067598648515;47015.294770577784;47110.52889471062;48733.47361734318;38754;41385.79307103445;41563.58436415597;41997.1600567993;42148;31192.844035779675;31546.36907261796;31660.208494787814;32016.199595010312;32103.197420063752 12:15:40 INFO - PROCESS | 8990 | |2;jquery.html;410.67146282973613;419.8320671731305;423.68435515540915;434.3788382612863;441.27630685675496;18980.810191898076;20195.39413817586;20807.895960520214;21626.567468650617;21844.344669659935;20514.48713782156;20530.897345513287;20666.27668031619;20995.160193592277;21283.680744788842;5877.9412205877825;6078.665673387962;6089.908651370233;6097.908531372033;6109;5880.059190529516;5946.316173640022;5950.434708702666;5967.731452084645;6051.092336149591;5789.913151302734;5833.445822646863;5866.765329386841;5943.257092863392;6001.189839371695;5923.081922302029;5937.495312898409;5989.371116032841;5993.430624090704;5998.190244317048;5178.300929374524;5286.127788914824;5295.894082118374;5330.600204984642;5336.893262134736;14639.487617933428;16087.517374478784;22355.776442235532;22889.656655150186;23167;2384.225126833786;2408.2895545814026;2430.2830664953703;2472.3942634054592;2973.914521199768;7482.925170748277;7677.0403699537555;10878.347299161996;11057.336559806437;12437;2045.887476188809;2060.81452669259;2109.799569040954;2117.5976564452703;2162.9783702162936;66881.66559167222;71892;73971.26028739697;74538.62730686367;91333.08666913312;11533;11720.648380548597;11928.403579820973;11946.462409191607;12008.759824803456;16854.241559129623;16939.407120750715;16940.915295423445;16944.745828812578;16996.150192490328;8797.51613661242;8875.378723489423;9094.18152366277;9104.089591040844;9318.394304370195;8868.689595864114;8873.73378798637;8914.86627700585;9142.862857057149;9194.724158275263;4955.2567114933045;5040.193569028937;5059.139946209079;5096.210087436453;5128.153854613947;2088.4256829372043;2094.863833850795;2097.853150279466;2145.9248926287505;2211.369759618533;964.1226483899618;1046.2519298701466;1055.8469021991768;1092.8852470490642;1138.6470194239812;20235.494112647008;20709.68935465969;21366.89316553407;21426.357209283746;21694.674579881314;1063.7553362726617;1066.328213225663;1090.8418279349607;1117.5753213778712;1131.7849608574345;11123.221374503708;11149.442527873736;11891.821622675667;12075.637730868088;12080.87919120815;557891;561589;561953;573210;580509;93541;94857.525712371;96248;97605.51197243968;102702;989.8465737810651;1012.8959434216887;1019.2661283875598;1021.4484178543503;1028.0387837371932;16845.494635160965;19305.8069419304;19522.21911123596;19713.901430492755;19793.30723424673;41142.79428602838;42210.57789422067;46290.537094629966;46712.29931551097;47193;58976;60105;64049.67975160281;64523;66032;8188.467749596257;8296.751097467086;8328.458650187718;8377.623006964579;8420.410571259952;12107.515699371927;13705.314734263047;13998.58004259833;14147.151170929777;14326.283685815875;11338.773224535298;11530.82703759461;11765.76468470643;11897.940510297392;11911;12003.339816310187;12304;12318.445669945053;12441.626751197478;12550.560730374758;11438.027767639844;11628.825567616323;11641.708957275798;12389.194702344319;12443.128980971245;8504.362172837185;8554.871676924726;8567.4002819802;9362.95318523403;9385.953070234606;8658.177473140042;10278.383297002203;10620.575176992834;11353.205275630957;11354.26197297173 12:15:40 INFO - PROCESS | 8990 | |3;mootools.html;1554.440401455476;1568.1375243616008;1760.6126652136534;1865.393747032214;1869.1588785046733;8591.570421478933;9312.767180820474;9409.059094090604;9915.553800078997;10017.148542373898;9478.146966772989;9790.85313720293;9802.754931126708;9816.116549510543;9909.157721593656;2473.6907886514186;2499.8375105618074;2504.887280072392;2507.6865391826022;2511.3721569607596;2482.751724827521;2550.1457011901034;2555.757203065715;2567.10151446993;2571.2286314105786;2510.2092840755195;2527.4692314613953;2540.174443305924;2547.032127791437;2548.2610043087484;2494.8128890333205;2495.238952119603;2507.4107584717576;2510.3724068982756;2515.245426372081;2460.138951367025;2467.8395904266167;2469.6789417375626;2484.465839844424;2525.8105642076916;9859.950700246525;9909.950450247774;9912.653057142965;9925.2059835213;9926.106650401427;5598.356189038272;5694.088945768657;5694.288213973254;5703.144528320744;5719.14212868069;3543.5039094526787;3633.0372451300427;3686.4286035664513;3729.9627003730157;3767.6797472214894;1163.1450883600546;1192.3322939154102;1195.7668254690338;1198.8741182175834;1223.253815172744;12956.80564791529;12962.416691248916;12970.962323014137;12981.61055168337;13024.023198260074;4771.475137734847;4775.594074503637;5101.51535604117;5101.877586930869;5146.588272938231;10777.407242601732;10781.299215550964;10790.24468287228;10846.67459976202;10902.618408355669;5710.486056254874;5746.856328591819;5770.07678771403;5770.480656740913;5779.133130030445;4677.532246775295;5205.453427390145;5311.990721762852;5317.707526086025;5368.973155134199;4420.138073075784;4513.187626227311;4535.886602834889;4541.977290113528;4543.909121817611;1405.7469655462114;1423.7864320351823;1436.3751767980962;1448.6523234423873;1459.3651761483789;937.7186843946926;1060.7030031591166;1077.789830982951;1085.3054045410943;1107.429673718036;6503.7073331700185;6628.270890202074;6788.796336109925;6813.4889883257965;6875.140607424072;484.19865123221126;486.73959431703867;495.88842510435586;497.4428639923309;500.66455474831224;4371.388005679208;4373.518912919576;4421.336799480104;4470.994026344047;4484.775761211991;12081.697957551132;12419.813702794465;12445.688857778629;12464.189827661174;12509.749805003848;12102.878971210175;12166.635000949986;12264.81602775959;12274.631761047183;12329.568465103679;8627.309815214769;8700.738977830675;8765.737027889174;8872.8669069964;8907.421017633833;6536.803895883131;6672.232693240146;6693.598384096969;6745.426638735762;6759.053732477359;11030.558777648805;11032.28290161137;11034.503447345049;11070;11343.886561134283;11102.222844401138;11228.55085796559;11330.773384532098;11440.370779606868;11498.367589782307;7788.88316675239;8270.214329638675;8334.916650833415;8623.439476434012;8685.652573896974;9532.332736708364;9569.904300956901;9574.281928855504;9600.471974041215;9626.085521875411;8356.122607126164;8591.527465989431;8615.483071015758;8640.26557742599;8646.135386461303;8154.592270386338;8205.589720513832;8234.794130146794;8236.052853921636;8255;7579.848403032019;7615.657295421608;7657.272559106876;7659.463837531543;7711.768646940601;5754.223179870832;5757.9424205757405;5870.412958704095;5995.070764031582;6005.159277701213;5769.1634712967225;5837.270341207349;5888.735006924613;5923.940760592339;5939.910901336397 12:15:40 INFO - PROCESS | 8990 | |4;prototype.html;349.7446863789435;357.69059763304733;357.72097763744273;364.18604419123255;366.05557661234013;5614.494695477406;5699.287589051369;5741.397153298895;5746.362286748277;5761.913571296429;5737.913931291024;5750;5795.797147099853;5798.5361171106315;5804.390538993398;4545.11370282795;4559.039612966415;4564.680472366936;4569.862904112882;4571.154336447751;4471.6646251531265;4574.771261436931;4578.725276483405;4596.908061838762;4625.907481850361;4547.522510136438;4560.065186636748;4576.931346029813;4590.678652494326;4596.770161491929;4585.70192937458;4586.6469391529245;4591.931121033187;4607.4471063472265;4611.746353950532;3878.728489005771;3970.4441378207075;3974.085960229135;3988.78061706606;3993.221321842242;5610.24261724666;5610.354809196913;5657.349404818417;5687.886242275173;5705.37396841898;5064.607233010952;5182.53357197854;5195.428502864682;5204.375474943031;5212.244224587414;6008.459238668541;6031.185789918349;6036.82281955019;6037.245344331958;6059.424354686298;4372.912541749147;4404.251277282838;4406.933895991563;4415.845445409395;4418.5802348776815;5964.373740757202;6240.7533288016275;6304.455408424919;6318.210223722035;6358.1734374531015;4440;4446.199684056836;4457.643388528974;4493.932790916215;4495.820167193341;4540.636749060067;4562.927711987681;4564.657650676146;4566.360709500673;4570.108828778356;5031.899362012739;5203.502318886955;5214.243934629458;5220.269162317279;5247.816326428633;5933.703314834241;6085.391460853968;6126.908096378558;6135.263768347738;6138.785142519991;1552.8680062194614;1560.4382422327953;1564.2647955461143;1576.1961399686013;1591.8248992610804;974.3617930255693;988.8467287570438;1001.6994901529512;1026.6140710041384;1031.1956673794302;5201.566965802628;5211.739413029333;5217.7302873250255;5218.66078704883;5273.209018647157;5481.314835645544;5495.323926202466;5512.255845460892;5518.862028449321;5521.723913804293;5137.640365174477;5227.764750586232;5238.60710446718;5347.967772246521;5363.463653634605;2949.8230106193696;2951.631046119235;2966.9109926702235;2967.807092539021;3004.72957433832;5673.929015909163;5712.6286791358425;5725.312962444534;5737.569682273846;5743.898294920779;5269.631125821155;5567.944320556823;5574;5588.066265210716;5626.409227031185;5603.450430054397;5648.350439699487;5707.315122185364;5748.827535173951;5758.798442054508;5541.33503979525;5550.833474995757;5559.555235581225;5829.3296270927685;6267.373262673696;6207.379262073757;6210.199042277689;6223.284322302993;6224.968875155776;6234.438900498977;6373.876800367693;6523.151990241238;6568.704408301734;6627.768028118992;6628.933710663025;4475.082608065273;4510.34599982994;4525.954740452685;4526.162659907927;4535.909281814279;6065.848353791191;6217.891054472763;6300.243970723543;6362.522810789302;6407;6145.539084568764;6150.015997440567;6162.445379915829;6179.783707570214;6197.473214776614;6108.72510737009;6147.907781383372;6207.099970504161;6210.627362358273;6249.25008998923;5997.250343707036;6039.78860739872;6091.878162436815;6102.9694851525455;6133.785317513865;6207.16203312547;6272.560920735505;6279.58709290406;6291.307956124914;6302.464290535356;5935.34711181761;5945.554083443672;6005.858886811492;6029.095635654511;6049.304330002106 12:15:40 INFO - PROCESS | 8990 | |5;yui.html;721.9675114619841;783.941204409669;816.8039670479079;867.7266661001786;884.703624285864;16610.418635347763;16634.58413539662;17492;17676.558086047855;17677.646447071067;16053;16239.188040597983;16281.104539250337;16282;16309.83690163098;737.7860420478082;856.2122846980793;873.2097451806126;878.2666473494623;895.4716717136888;890.7372325164059;891.1400498518927;892.8125093730324;893.5175005497024;893.9106089391074;921.7465197070792;926.1942110363992;927.601131513449;930.6556574067571;932.0213775535694;925.7315378540216;925.7731855695364;927.6984979881565;930.3627015494374;937.161240689579;685.239384283445;685.6674512861258;688.5868478912662;689.2280645676824;692.0622556436007;16038.358465661477;16162.676746465006;16216.918915405347;16218.675626487522;16272.43046493367;13092.47630094795;14137.929310353486;14744.410223591043;14899.70200595982;14915;14236.501722439665;14335.638114379117;14360.497382591664;14501.637459063608;14751.041182323223;4816.51834816519;4816.7350795706225;4863.319135321058;5051.974740126276;5055.368078990126;89448;90528;91209.54395228048;92523;94414.52792735993;12242.693932651577;12541.623751287476;12553.497860085678;12645.936770316273;12679.175853569488;22281.66577501339;22471.775282246967;22568.322950311518;22622;23081.538369232523;8976.775580610538;9116.453012819253;9184.724458266262;9231.723048308562;9340;4881.829135980223;5093.363329583802;5113.233015047773;5134.820281290137;5227.111391063529;3689.7786132832116;3748.4002559590335;3770.2836461072307;3799.506064211635;3804.752691075071;650.2976785072111;668.0480315550418;670.6009924095254;679.67035987546;702.2871785138088;726.7238449389198;730.8867125595541;742.1279996004673;748.5508694783196;754.4454825703103;9692.951535242279;10470.738231544272;10681.252312338062;10745.78508429827;10960.725981850517;706.1349846438072;743.8735414979467;787.933025692811;790.1584812175015;791.1258059843905;5139.8458046258675;5282;5373.623846330797;5376.247325374451;5528.115501519737;100013;113232;115220;118744;118803;102040.48979755203;105163;105381.47309263558;107691.46154269179;109650.45174774075;90599;91441.54279228562;91886;91894;92728;10210.795784084425;10212.846807297748;10498.317609355367;10528.894711052792;10610.469476525988;51058;51585.48414515957;52675.736621316646;53991;55317.4286284694;51139;65231.34768652442;67469;68128;68591.65704171447;14080.22558759278;14084.859151408355;14125.788113178516;14274.429022838971;14495.710085798435;15263.160526171167;15675.686486270439;15826;15920.681586367977;16771.580710482336;15138.924052204064;15252.31364588574;15652.217389130727;15981.200939953189;16736.163191840114;13273.66815829612;13332.533361332307;13900.860991389956;14374.928125359307;14457.27713614294;14800.925995369955;14808;15153.848461515243;15160.545183644508;15333.00335478235;11501.654950351503;11637.185397022127;12904.41930113166;13238.338083096;13637.659058523615;12260.448279827251;12405.875941240472;12546.560870369858;12556.058295627681;12559.748805024032 12:15:40 INFO - PROCESS | 8990 | __end_tp_report 12:15:40 INFO - PROCESS | 8990 | __start_cc_report 12:15:40 INFO - PROCESS | 8990 | _x_x_mozilla_cycle_collect,310 12:15:40 INFO - PROCESS | 8990 | __end_cc_report 12:15:40 INFO - PROCESS | 8990 | __startTimestamp1472066140123__endTimestamp 12:15:40 INFO - PROCESS | 8990 | 12:15:40 INFO - PROCESS | 8990 | ------- Summary: start ------- 12:15:40 INFO - PROCESS | 8990 | Number of tests: 6 12:15:40 INFO - PROCESS | 8990 | 12:15:40 INFO - PROCESS | 8990 | [#0] dojo.html Cycles:165 Average:5752.82 Median:5999.64 stddev:659.73 (11.0%) stddev-sans-first:632.51 12:15:40 INFO - PROCESS | 8990 | Values: 3276.6 3305.8 3319.6 3325.3 3327.4 5756.7 5799.5 5825.2 5830.1 5835.2 5760.7 5762.4 5799.7 5802.0 5831.4 5262.8 5288.8 5311.6 5336.0 5363.1 5177.4 5180.6 5202.6 5209.5 5319.7 5334.5 5338.0 5346.8 5352.8 5357.3 5367.2 5371.4 5393.4 5404.3 5405.7 5026.2 5128.0 5154.0 5276.8 5285.4 5675.3 5725.6 5726.3 5747.5 5788.6 6132.7 6180.6 6182.1 6186.5 6199.3 5888.8 6138.8 6144.3 6244.9 6250.2 5782.5 5788.5 5809.1 5821.5 5827.2 6349.8 6352.8 6361.7 6378.0 6398.1 5888.3 6031.2 6033.9 6085.2 6116.9 6202.8 6239.4 6241.1 6242.4 6246.7 6198.1 6214.0 6225.1 6229.8 6232.6 5904.5 6120.7 6140.8 6221.6 6225.8 4744.4 4748.6 4753.6 4767.5 4772.3 4218.4 4225.2 4229.7 4239.9 4258.7 5729.2 5866.1 5884.6 5972.7 6017.7 6201.5 6228.8 6247.8 6249.2 6254.7 5958.1 5960.7 5965.6 5966.8 5999.6 5032.1 5166.8 5200.8 5204.3 5220.3 6468.8 6495.6 6513.8 6515.0 6528.4 6291.2 6293.3 6298.2 6317.6 6323.4 6083.5 6228.6 6249.3 6293.9 6488.2 6065.3 6067.5 6070.6 6075.1 6089.7 6057.1 6101.7 6164.2 6194.2 6205.8 5901.9 5980.2 6000.5 6053.1 6061.1 6041.8 6078.7 6096.3 6098.0 6102.5 5981.2 6027.3 6033.7 6033.7 6040.6 5711.8 6045.9 6056.0 6090.1 6115.7 5954.1 5988.0 6014.1 6022.7 6047.5 12:15:40 INFO - PROCESS | 8990 | 12:15:40 INFO - PROCESS | 8990 | [#1] ext.html Cycles:180 Average:68608.43 Median:46368.00 stddev:139445.19 (300.7%) stddev-sans-first:139742.85 12:15:40 INFO - PROCESS | 8990 | Values: 587.3 645.6 653.7 655.4 703.7 41098.8 46841.5 46925.3 47072.3 47210.5 45819.5 46180.5 46237.5 46395.0 46424.0 9066.5 9129.7 9187.5 9196.5 9244.1 9050.6 9092.7 9154.5 9161.5 9166.8 9166.5 9180.0 9259.9 9264.2 9266.0 9093.1 9138.1 9139.7 9190.0 9208.5 8792.6 8804.9 8878.8 8893.0 8899.8 43842.8 44009.0 44431.8 44470.6 44493.3 3163.4 3537.7 3672.2 3854.9 3910.6 35546.5 35826.8 36041.1 37928.8 39807.4 4595.3 4602.4 4740.8 4825.7 4840.5 385695.0 388223.0 389304.0 389879.0 390689.0 70927.6 72036.0 72133.0 72147.0 72152.6 41257.0 41707.8 41876.6 43938.0 75853.2 19333.9 19500.4 19560.8 19622.5 19674.7 14054.4 14109.5 14138.8 14174.1 14189.3 22493.4 22797.3 23049.3 23100.2 23166.7 7899.2 8167.8 8185.5 8244.5 8400.8 1044.4 1132.0 1217.1 1250.5 1269.7 35136.1 35306.8 35417.3 35620.8 35711.1 1198.9 1245.5 1249.1 1306.4 1336.0 18503.8 18553.3 18619.6 18650.1 18660.5 644984.0 649787.0 651717.0 655088.0 656080.0 64363.7 64505.0 64596.0 65126.7 65171.3 1426.3 1426.4 1428.6 1466.1 1472.9 34554.3 34761.7 35179.6 35250.8 35373.0 55905.2 56267.2 56325.0 56365.0 56642.7 496568.0 499652.0 499762.0 500012.0 500270.0 32230.5 32358.5 32420.8 32428.8 32644.7 53309.7 53605.7 53837.0 53875.5 54449.0 46576.3 49510.8 49652.8 49837.0 50237.7 47382.5 47401.0 47518.3 47525.0 47672.5 46341.0 46620.1 47015.3 47110.5 48733.5 38754.0 41385.8 41563.6 41997.2 42148.0 31192.8 31546.4 31660.2 32016.2 32103.2 12:15:40 INFO - PROCESS | 8990 | 12:15:40 INFO - PROCESS | 8990 | [#2] jquery.html Cycles:180 Average:31633.07 Median:12775.61 stddev:93165.27 (729.2%) stddev-sans-first:93397.13 12:15:40 INFO - PROCESS | 8990 | Values: 410.7 419.8 423.7 434.4 441.3 18980.8 20195.4 20807.9 21626.6 21844.3 20514.5 20530.9 20666.3 20995.2 21283.7 5877.9 6078.7 6089.9 6097.9 6109.0 5880.1 5946.3 5950.4 5967.7 6051.1 5789.9 5833.4 5866.8 5943.3 6001.2 5923.1 5937.5 5989.4 5993.4 5998.2 5178.3 5286.1 5295.9 5330.6 5336.9 14639.5 16087.5 22355.8 22889.7 23167.0 2384.2 2408.3 2430.3 2472.4 2973.9 7482.9 7677.0 10878.3 11057.3 12437.0 2045.9 2060.8 2109.8 2117.6 2163.0 66881.7 71892.0 73971.3 74538.6 91333.1 11533.0 11720.6 11928.4 11946.5 12008.8 16854.2 16939.4 16940.9 16944.7 16996.2 8797.5 8875.4 9094.2 9104.1 9318.4 8868.7 8873.7 8914.9 9142.9 9194.7 4955.3 5040.2 5059.1 5096.2 5128.2 2088.4 2094.9 2097.9 2145.9 2211.4 964.1 1046.3 1055.8 1092.9 1138.6 20235.5 20709.7 21366.9 21426.4 21694.7 1063.8 1066.3 1090.8 1117.6 1131.8 11123.2 11149.4 11891.8 12075.6 12080.9 557891.0 561589.0 561953.0 573210.0 580509.0 93541.0 94857.5 96248.0 97605.5 102702.0 989.8 1012.9 1019.3 1021.4 1028.0 16845.5 19305.8 19522.2 19713.9 19793.3 41142.8 42210.6 46290.5 46712.3 47193.0 58976.0 60105.0 64049.7 64523.0 66032.0 8188.5 8296.8 8328.5 8377.6 8420.4 12107.5 13705.3 13998.6 14147.2 14326.3 11338.8 11530.8 11765.8 11897.9 11911.0 12003.3 12304.0 12318.4 12441.6 12550.6 11438.0 11628.8 11641.7 12389.2 12443.1 8504.4 8554.9 8567.4 9363.0 9386.0 8658.2 10278.4 10620.6 11353.2 11354.3 12:15:40 INFO - PROCESS | 8990 | 12:15:40 INFO - PROCESS | 8990 | [#3] mootools.html Cycles:180 Average:6358.17 Median:4724.50 stddev:3639.44 (77.0%) stddev-sans-first:3631.75 12:15:40 INFO - PROCESS | 8990 | Values: 1554.4 1568.1 1760.6 1865.4 1869.2 8591.6 9312.8 9409.1 9915.6 10017.1 9478.1 9790.9 9802.8 9816.1 9909.2 2473.7 2499.8 2504.9 2507.7 2511.4 2482.8 2550.1 2555.8 2567.1 2571.2 2510.2 2527.5 2540.2 2547.0 2548.3 2494.8 2495.2 2507.4 2510.4 2515.2 2460.1 2467.8 2469.7 2484.5 2525.8 9860.0 9910.0 9912.7 9925.2 9926.1 5598.4 5694.1 5694.3 5703.1 5719.1 3543.5 3633.0 3686.4 3730.0 3767.7 1163.1 1192.3 1195.8 1198.9 1223.3 12956.8 12962.4 12971.0 12981.6 13024.0 4771.5 4775.6 5101.5 5101.9 5146.6 10777.4 10781.3 10790.2 10846.7 10902.6 5710.5 5746.9 5770.1 5770.5 5779.1 4677.5 5205.5 5312.0 5317.7 5369.0 4420.1 4513.2 4535.9 4542.0 4543.9 1405.7 1423.8 1436.4 1448.7 1459.4 937.7 1060.7 1077.8 1085.3 1107.4 6503.7 6628.3 6788.8 6813.5 6875.1 484.2 486.7 495.9 497.4 500.7 4371.4 4373.5 4421.3 4471.0 4484.8 12081.7 12419.8 12445.7 12464.2 12509.7 12102.9 12166.6 12264.8 12274.6 12329.6 8627.3 8700.7 8765.7 8872.9 8907.4 6536.8 6672.2 6693.6 6745.4 6759.1 11030.6 11032.3 11034.5 11070.0 11343.9 11102.2 11228.6 11330.8 11440.4 11498.4 7788.9 8270.2 8334.9 8623.4 8685.7 9532.3 9569.9 9574.3 9600.5 9626.1 8356.1 8591.5 8615.5 8640.3 8646.1 8154.6 8205.6 8234.8 8236.1 8255.0 7579.8 7615.7 7657.3 7659.5 7711.8 5754.2 5757.9 5870.4 5995.1 6005.2 5769.2 5837.3 5888.7 5923.9 5939.9 12:15:40 INFO - PROCESS | 8990 | 12:15:40 INFO - PROCESS | 8990 | [#4] prototype.html Cycles:180 Average:5010.29 Median:5555.19 stddev:1457.50 (26.2%) stddev-sans-first:1418.99 12:15:40 INFO - PROCESS | 8990 | Values: 349.7 357.7 357.7 364.2 366.1 5614.5 5699.3 5741.4 5746.4 5761.9 5737.9 5750.0 5795.8 5798.5 5804.4 4545.1 4559.0 4564.7 4569.9 4571.2 4471.7 4574.8 4578.7 4596.9 4625.9 4547.5 4560.1 4576.9 4590.7 4596.8 4585.7 4586.6 4591.9 4607.4 4611.7 3878.7 3970.4 3974.1 3988.8 3993.2 5610.2 5610.4 5657.3 5687.9 5705.4 5064.6 5182.5 5195.4 5204.4 5212.2 6008.5 6031.2 6036.8 6037.2 6059.4 4372.9 4404.3 4406.9 4415.8 4418.6 5964.4 6240.8 6304.5 6318.2 6358.2 4440.0 4446.2 4457.6 4493.9 4495.8 4540.6 4562.9 4564.7 4566.4 4570.1 5031.9 5203.5 5214.2 5220.3 5247.8 5933.7 6085.4 6126.9 6135.3 6138.8 1552.9 1560.4 1564.3 1576.2 1591.8 974.4 988.8 1001.7 1026.6 1031.2 5201.6 5211.7 5217.7 5218.7 5273.2 5481.3 5495.3 5512.3 5518.9 5521.7 5137.6 5227.8 5238.6 5348.0 5363.5 2949.8 2951.6 2966.9 2967.8 3004.7 5673.9 5712.6 5725.3 5737.6 5743.9 5269.6 5567.9 5574.0 5588.1 5626.4 5603.5 5648.4 5707.3 5748.8 5758.8 5541.3 5550.8 5559.6 5829.3 6267.4 6207.4 6210.2 6223.3 6225.0 6234.4 6373.9 6523.2 6568.7 6627.8 6628.9 4475.1 4510.3 4526.0 4526.2 4535.9 6065.8 6217.9 6300.2 6362.5 6407.0 6145.5 6150.0 6162.4 6179.8 6197.5 6108.7 6147.9 6207.1 6210.6 6249.3 5997.3 6039.8 6091.9 6103.0 6133.8 6207.2 6272.6 6279.6 6291.3 6302.5 5935.3 5945.6 6005.9 6029.1 6049.3 12:15:40 INFO - PROCESS | 8990 | 12:15:40 INFO - PROCESS | 8990 | [#5] yui.html Cycles:180 Average:21928.75 Median:3759.34 stddev:30953.95 (823.4%) stddev-sans-first:30999.83 12:15:40 INFO - PROCESS | 8990 | Values: 722.0 783.9 816.8 867.7 884.7 16610.4 16634.6 17492.0 17676.6 17677.6 16053.0 16239.2 16281.1 16282.0 16309.8 737.8 856.2 873.2 878.3 895.5 890.7 891.1 892.8 893.5 893.9 921.7 926.2 927.6 930.7 932.0 925.7 925.8 927.7 930.4 937.2 685.2 685.7 688.6 689.2 692.1 16038.4 16162.7 16216.9 16218.7 16272.4 13092.5 14137.9 14744.4 14899.7 14915.0 14236.5 14335.6 14360.5 14501.6 14751.0 4816.5 4816.7 4863.3 5052.0 5055.4 89448.0 90528.0 91209.5 92523.0 94414.5 12242.7 12541.6 12553.5 12645.9 12679.2 22281.7 22471.8 22568.3 22622.0 23081.5 8976.8 9116.5 9184.7 9231.7 9340.0 4881.8 5093.4 5113.2 5134.8 5227.1 3689.8 3748.4 3770.3 3799.5 3804.8 650.3 668.0 670.6 679.7 702.3 726.7 730.9 742.1 748.6 754.4 9693.0 10470.7 10681.3 10745.8 10960.7 706.1 743.9 787.9 790.2 791.1 5139.8 5282.0 5373.6 5376.2 5528.1 100013.0 113232.0 115220.0 118744.0 118803.0 102040.5 105163.0 105381.5 107691.5 109650.5 90599.0 91441.5 91886.0 91894.0 92728.0 10210.8 10212.8 10498.3 10528.9 10610.5 51058.0 51585.5 52675.7 53991.0 55317.4 51139.0 65231.3 67469.0 68128.0 68591.7 14080.2 14084.9 14125.8 14274.4 14495.7 15263.2 15675.7 15826.0 15920.7 16771.6 15138.9 15252.3 15652.2 15981.2 16736.2 13273.7 13332.5 13900.9 14374.9 14457.3 14800.9 14808.0 15153.8 15160.5 15333.0 11501.7 11637.2 12904.4 13238.3 13637.7 12260.4 12405.9 12546.6 12556.1 12559.7 12:15:40 INFO - PROCESS | 8990 | -------- Summary: end -------- 12:15:40 INFO - PROCESS | 8990 | 12:15:40 INFO - TEST-INFO | 8990: exit 0 12:15:40 INFO - TEST-OK | dromaeo_css | took 1110493ms 12:15:40 INFO - TEST-START | kraken 12:15:40 INFO - operating with platform_type : linux_ 12:15:40 INFO - Initialising browser for kraken test... 12:15:40 INFO - TEST-INFO | started process 9257 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxy5OoU/profile http://localhost:54381/getInfo.html) 12:15:44 INFO - PROCESS | 9257 | __metrics Screen width/height:1600/1200 12:15:44 INFO - PROCESS | 9257 | colorDepth:24 12:15:44 INFO - PROCESS | 9257 | Browser inner width/height: 1024/697 12:15:44 INFO - PROCESS | 9257 | __metrics 12:15:45 ERROR - PROCESS | 9257 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 12:15:46 INFO - TEST-INFO | 9257: exit 0 12:15:46 INFO - Browser initialized. 12:15:46 INFO - Running cycle 1/1 for kraken test... 12:15:46 INFO - TEST-INFO | started process 9379 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxy5OoU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:15:57 INFO - PROCESS | 9379 | RSS: Main: 153092096 12:15:57 INFO - PROCESS | 9379 | 12:16:00 INFO - PROCESS | 9379 | Cycle 1(1): loaded http://localhost:54381/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54381/tests/kraken/driver.html?testName=audio-beat-detection) 12:16:01 INFO - PROCESS | 9379 | RSS: Main: 158445568 12:16:01 INFO - PROCESS | 9379 | 12:16:03 INFO - PROCESS | 9379 | Cycle 1(1): loaded http://localhost:54381/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54381/tests/kraken/driver.html?testName=audio-dft) 12:16:04 INFO - PROCESS | 9379 | RSS: Main: 157233152 12:16:04 INFO - PROCESS | 9379 | 12:16:07 INFO - PROCESS | 9379 | Cycle 1(1): loaded http://localhost:54381/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54381/tests/kraken/driver.html?testName=audio-fft) 12:16:07 INFO - PROCESS | 9379 | RSS: Main: 157605888 12:16:07 INFO - PROCESS | 9379 | 12:16:09 INFO - PROCESS | 9379 | Cycle 1(1): loaded http://localhost:54381/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54381/tests/kraken/driver.html?testName=audio-oscillator) 12:16:10 INFO - PROCESS | 9379 | RSS: Main: 157433856 12:16:10 INFO - PROCESS | 9379 | 12:16:12 INFO - PROCESS | 9379 | Cycle 1(1): loaded http://localhost:54381/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54381/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:16:13 INFO - PROCESS | 9379 | RSS: Main: 157577216 12:16:13 INFO - PROCESS | 9379 | 12:16:16 INFO - PROCESS | 9379 | Cycle 1(1): loaded http://localhost:54381/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54381/tests/kraken/driver.html?testName=imaging-darkroom) 12:16:16 INFO - PROCESS | 9379 | RSS: Main: 156377088 12:16:16 INFO - PROCESS | 9379 | 12:16:20 INFO - PROCESS | 9379 | Cycle 1(1): loaded http://localhost:54381/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54381/tests/kraken/driver.html?testName=imaging-desaturate) 12:16:21 INFO - PROCESS | 9379 | RSS: Main: 156647424 12:16:21 INFO - PROCESS | 9379 | 12:16:23 INFO - PROCESS | 9379 | Cycle 1(1): loaded http://localhost:54381/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54381/tests/kraken/driver.html?testName=json-parse-financial) 12:16:24 INFO - PROCESS | 9379 | RSS: Main: 158171136 12:16:24 INFO - PROCESS | 9379 | 12:16:26 INFO - PROCESS | 9379 | Cycle 1(1): loaded http://localhost:54381/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54381/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:16:26 INFO - PROCESS | 9379 | RSS: Main: 157417472 12:16:26 INFO - PROCESS | 9379 | 12:16:28 INFO - PROCESS | 9379 | Cycle 1(1): loaded http://localhost:54381/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54381/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:16:29 INFO - PROCESS | 9379 | RSS: Main: 157515776 12:16:29 INFO - PROCESS | 9379 | 12:16:31 INFO - PROCESS | 9379 | Cycle 1(1): loaded http://localhost:54381/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54381/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:16:31 INFO - PROCESS | 9379 | RSS: Main: 157589504 12:16:31 INFO - PROCESS | 9379 | 12:16:34 INFO - PROCESS | 9379 | Cycle 1(1): loaded http://localhost:54381/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54381/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:16:34 INFO - PROCESS | 9379 | RSS: Main: 157970432 12:16:34 INFO - PROCESS | 9379 | 12:16:37 INFO - PROCESS | 9379 | Cycle 1(1): loaded http://localhost:54381/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54381/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:16:38 INFO - PROCESS | 9379 | RSS: Main: 158171136 12:16:38 INFO - PROCESS | 9379 | 12:16:39 INFO - PROCESS | 9379 | Cycle 1(1): loaded http://localhost:54381/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54381/tests/kraken/driver.html?testName=ai-astar) 12:16:39 INFO - PROCESS | 9379 | RSS: Main: 158978048 12:16:39 INFO - PROCESS | 9379 | 12:16:40 INFO - PROCESS | 9379 | __start_tp_report 12:16:40 INFO - PROCESS | 9379 | _x_x_mozilla_page_load 12:16:40 INFO - PROCESS | 9379 | _x_x_mozilla_page_load_details 12:16:40 INFO - PROCESS | 9379 | |i|pagename|runs| 12:16:40 INFO - PROCESS | 9379 | |0;ai-astar;101;111;105;110;111;112;111;111;111;109 12:16:40 INFO - PROCESS | 9379 | |1;audio-beat-detection;150;116;142;163;118;145;144;121;188;115 12:16:40 INFO - PROCESS | 9379 | |2;audio-dft;162;162;162;162;163;163;163;163;161;162 12:16:40 INFO - PROCESS | 9379 | |3;audio-fft;74;74;75;174;76;75;77;77;162;77 12:16:40 INFO - PROCESS | 9379 | |4;audio-oscillator;84;84;144;83;82;83;136;84;83;140 12:16:40 INFO - PROCESS | 9379 | |5;imaging-gaussian-blur;118;124;117;118;118;118;119;118;118;118 12:16:40 INFO - PROCESS | 9379 | |6;imaging-darkroom;148;149;147;148;148;149;148;148;148;149 12:16:40 INFO - PROCESS | 9379 | |7;imaging-desaturate;95;95;96;95;95;100;95;97;96;95 12:16:40 INFO - PROCESS | 9379 | |8;json-parse-financial;57;55;53;53;53;52;57;52;52;55 12:16:40 INFO - PROCESS | 9379 | |9;json-stringify-tinderbox;62;60;59;60;60;59;59;60;60;60 12:16:40 INFO - PROCESS | 9379 | |10;stanford-crypto-aes;74;74;73;73;74;73;73;72;80;73 12:16:40 INFO - PROCESS | 9379 | |11;stanford-crypto-ccm;128;118;127;120;120;117;120;133;158;120 12:16:40 INFO - PROCESS | 9379 | |12;stanford-crypto-pbkdf2;152;153;153;151;151;149;149;156;150;151 12:16:40 INFO - PROCESS | 9379 | |13;stanford-crypto-sha256-iterative;63;63;65;63;62;61;62;63;65;60 12:16:40 INFO - PROCESS | 9379 | __end_tp_report 12:16:40 INFO - PROCESS | 9379 | __start_cc_report 12:16:40 INFO - PROCESS | 9379 | _x_x_mozilla_cycle_collect,866 12:16:40 INFO - PROCESS | 9379 | __end_cc_report 12:16:40 INFO - PROCESS | 9379 | __startTimestamp1472066199999__endTimestamp 12:16:40 INFO - PROCESS | 9379 | 12:16:40 INFO - PROCESS | 9379 | ------- Summary: start ------- 12:16:40 INFO - PROCESS | 9379 | Number of tests: 14 12:16:40 INFO - PROCESS | 9379 | 12:16:40 INFO - PROCESS | 9379 | [#0] ai-astar Cycles:10 Average:109.20 Median:111.00 stddev:3.49 (3.1%) stddev-sans-first:2.09 12:16:40 INFO - PROCESS | 9379 | Values: 101.0 111.0 105.0 110.0 111.0 112.0 111.0 111.0 111.0 109.0 12:16:40 INFO - PROCESS | 9379 | 12:16:40 INFO - PROCESS | 9379 | [#1] audio-beat-detection Cycles:10 Average:140.20 Median:144.50 stddev:23.63 (16.4%) stddev-sans-first:24.79 12:16:40 INFO - PROCESS | 9379 | Values: 150.0 116.0 142.0 163.0 118.0 145.0 144.0 121.0 188.0 115.0 12:16:40 INFO - PROCESS | 9379 | 12:16:40 INFO - PROCESS | 9379 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.50 stddev:0.67 (0.4%) stddev-sans-first:0.71 12:16:40 INFO - PROCESS | 9379 | Values: 162.0 162.0 162.0 162.0 163.0 163.0 163.0 163.0 161.0 162.0 12:16:40 INFO - PROCESS | 9379 | 12:16:40 INFO - PROCESS | 9379 | [#3] audio-fft Cycles:10 Average:94.10 Median:75.50 stddev:39.07 (51.7%) stddev-sans-first:40.76 12:16:40 INFO - PROCESS | 9379 | Values: 74.0 74.0 75.0 174.0 76.0 75.0 77.0 77.0 162.0 77.0 12:16:40 INFO - PROCESS | 9379 | 12:16:40 INFO - PROCESS | 9379 | [#4] audio-oscillator Cycles:10 Average:100.30 Median:83.00 stddev:27.47 (33.1%) stddev-sans-first:28.49 12:16:40 INFO - PROCESS | 9379 | Values: 84.0 84.0 144.0 83.0 82.0 83.0 136.0 84.0 83.0 140.0 12:16:40 INFO - PROCESS | 9379 | 12:16:40 INFO - PROCESS | 9379 | [#5] imaging-gaussian-blur Cycles:10 Average:118.60 Median:118.00 stddev:1.96 (1.7%) stddev-sans-first:2.06 12:16:40 INFO - PROCESS | 9379 | Values: 118.0 124.0 117.0 118.0 118.0 118.0 119.0 118.0 118.0 118.0 12:16:40 INFO - PROCESS | 9379 | 12:16:40 INFO - PROCESS | 9379 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 12:16:40 INFO - PROCESS | 9379 | Values: 148.0 149.0 147.0 148.0 148.0 149.0 148.0 148.0 148.0 149.0 12:16:40 INFO - PROCESS | 9379 | 12:16:40 INFO - PROCESS | 9379 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:95.00 stddev:1.60 (1.7%) stddev-sans-first:1.66 12:16:40 INFO - PROCESS | 9379 | Values: 95.0 95.0 96.0 95.0 95.0 100.0 95.0 97.0 96.0 95.0 12:16:40 INFO - PROCESS | 9379 | 12:16:40 INFO - PROCESS | 9379 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:1.97 (3.6%) stddev-sans-first:1.74 12:16:40 INFO - PROCESS | 9379 | Values: 57.0 55.0 53.0 53.0 53.0 52.0 57.0 52.0 52.0 55.0 12:16:40 INFO - PROCESS | 9379 | 12:16:40 INFO - PROCESS | 9379 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:0.88 (1.5%) stddev-sans-first:0.50 12:16:40 INFO - PROCESS | 9379 | Values: 62.0 60.0 59.0 60.0 60.0 59.0 59.0 60.0 60.0 60.0 12:16:40 INFO - PROCESS | 9379 | 12:16:40 INFO - PROCESS | 9379 | [#10] stanford-crypto-aes Cycles:10 Average:73.90 Median:73.50 stddev:2.23 (3.0%) stddev-sans-first:2.37 12:16:40 INFO - PROCESS | 9379 | Values: 74.0 74.0 73.0 73.0 74.0 73.0 73.0 72.0 80.0 73.0 12:16:40 INFO - PROCESS | 9379 | 12:16:40 INFO - PROCESS | 9379 | [#11] stanford-crypto-ccm Cycles:10 Average:126.10 Median:123.50 stddev:12.32 (10.0%) stddev-sans-first:13.05 12:16:40 INFO - PROCESS | 9379 | Values: 128.0 118.0 127.0 120.0 120.0 117.0 120.0 133.0 158.0 120.0 12:16:40 INFO - PROCESS | 9379 | 12:16:40 INFO - PROCESS | 9379 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.50 Median:151.50 stddev:2.12 (1.4%) stddev-sans-first:2.24 12:16:40 INFO - PROCESS | 9379 | Values: 152.0 153.0 153.0 151.0 151.0 149.0 149.0 156.0 150.0 151.0 12:16:40 INFO - PROCESS | 9379 | 12:16:40 INFO - PROCESS | 9379 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:1.57 (2.5%) stddev-sans-first:1.66 12:16:40 INFO - PROCESS | 9379 | Values: 63.0 63.0 65.0 63.0 62.0 61.0 62.0 63.0 65.0 60.0 12:16:40 INFO - PROCESS | 9379 | -------- Summary: end -------- 12:16:40 INFO - PROCESS | 9379 | 12:16:40 INFO - TEST-INFO | 9379: exit 0 12:16:40 INFO - TEST-OK | kraken | took 60036ms 12:16:40 INFO - SUITE-END | took 1170s 12:16:41 INFO - Completed test suite (00:19:30) 12:16:41 INFO - javascript benchmark 12:16:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7804.369160624328, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3276.6231883333417, 3305.752068594856, 3319.5684561007074, 3325.251818340872, 3327.4010678077952, 5756.712164391779, 5799.478046975772, 5825.242718446601, 5830.125481177825, 5835.153902684114, 5760.7407666655, 5762.3949485304065, 5799.710014499279, 5802.0, 5831.387704291052, 5262.842114736554, 5288.762005709752, 5311.601629877755, 5336.039512887679, 5363.088274993241, 5177.430482646906, 5180.559652429529, 5202.609804264695, 5209.531142197202, 5319.707416092114, 5334.493223143795, 5337.973310133444, 5346.812861549846, 5352.759125839327, 5357.303550538444, 5367.2485851980555, 5371.382291036542, 5393.433689462589, 5404.270423492818, 5405.729713514309, 5026.220935754964, 5128.0, 5154.020736060136, 5276.841694749163, 5285.445028272053, 5675.290588676416, 5725.599208055438, 5726.255586773693, 5747.540196784247, 5788.565857560699, 6132.662703551303, 6180.629162250234, 6182.103594978703, 6186.505079593621, 6199.287081985584, 5888.823335299948, 6138.756267604225, 6144.324124346318, 6244.937550624481, 6250.249970003629, 5782.537397008229, 5788.450097240755, 5809.099589563624, 5821.50517206038, 5827.184194212771, 6349.809505714836, 6352.777652782131, 6361.713722882481, 6378.0, 6398.104265402847, 5888.3228428731245, 6031.24609423822, 6033.909491357633, 6085.17850090241, 6116.908246376308, 6202.751889924442, 6239.407256310734, 6241.063840423973, 6242.438180563771, 6246.656433896089, 6198.132261483396, 6214.036824292242, 6225.097360882737, 6229.750809967551, 6232.626042437469, 5904.498117659961, 6120.724567394478, 6140.785072522441, 6221.564490485713, 6225.844353891189, 4744.430668319824, 4748.572628463386, 4753.643476739258, 4767.451743049524, 4772.284157376352, 4218.430511880857, 4225.154969006211, 4229.703920725581, 4239.894002649897, 4258.701890867672, 5729.197912292282, 5866.1494083357675, 5884.588078834526, 5972.731227094791, 6017.729202185912, 6201.472874805602, 6228.750849966042, 6247.843803904939, 6249.187605611241, 6254.6872656366995, 5958.076498142795, 5960.6721630309885, 5965.582409231399, 5966.76132954677, 5999.6400215986305, 5032.0690672225755, 5166.767495462713, 5200.76596553156, 5204.297419848348, 5220.321358223407, 6468.838279043061, 6495.577787443801, 6513.772017979348, 6515.0, 6528.445082167974, 6291.245050593958, 6293.307736149111, 6298.244210694746, 6317.5893566918, 6323.430891219812, 6083.452489275986, 6228.5951413158, 6249.281332646622, 6293.905591416041, 6488.188976377953, 6065.272167339947, 6067.453929146398, 6070.605410648293, 6075.058365953284, 6089.665068421102, 6057.121717351048, 6101.664408457577, 6164.198654174928, 6194.225721784777, 6205.782797602063, 5901.937651222821, 5980.222571065734, 6000.459958603747, 6053.122297266784, 6061.060535616986, 6041.75832966694, 6078.72645730952, 6096.329403765671, 6098.0, 6102.542309326907, 5981.222441082631, 6027.336992930862, 6033.668148251712, 6033.668148251712, 6040.607360521728, 5711.771529138788, 6045.939540604538, 6055.969720151371, 6090.147379366981, 6115.663638499926, 5954.07711804671, 5987.970060149672, 6014.0678194879865, 6022.668753218615, 6047.455728984412], "value": 5707.669114149766, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.3187102960567, 645.6384424722156, 653.6502970910561, 655.4428735574762, 703.6727921516493, 41098.794506027465, 46841.53158468414, 46925.296120558174, 47072.29391559129, 47210.52789472104, 45819.541804581946, 46180.53819461804, 46237.53762462374, 46395.0, 46424.0, 9066.45601263923, 9129.726108216764, 9187.494687792168, 9196.494192819426, 9244.121808428188, 9050.637974481013, 9092.727218183465, 9154.450732956011, 9161.541922903862, 9166.816663666723, 9166.54167291636, 9180.0, 9259.907400925971, 9264.212541933945, 9266.0, 9093.09069093092, 9138.086191380875, 9139.680111196076, 9190.035046320141, 9208.49353285569, 8792.560371981439, 8804.8679269811, 8878.778030549223, 8893.0, 8899.777505562348, 43842.780786096184, 44009.0, 44431.77784111059, 44470.55529444697, 44493.332600011025, 3163.43058249515, 3537.7169826413824, 3672.2288319452946, 3854.8843534694006, 3910.569837317893, 35546.46680299797, 35826.820865895505, 36041.09897252564, 37928.81035594832, 39807.40288895669, 4595.333676616905, 4602.424696912886, 4740.762961851894, 4825.734584597846, 4840.491748366406, 385695.0, 388222.99999999715, 389304.0, 389879.0, 390689.0, 70927.64536177389, 72036.0, 72133.0, 72147.0, 72152.63923680349, 41256.968575785846, 41707.7914610425, 41876.581234187266, 43938.0, 75853.24146758462, 19333.90333048326, 19500.414987550397, 19560.8043919559, 19622.509437263896, 19674.70487942682, 14054.437822486985, 14109.506167284097, 14138.787918181235, 14174.07868488545, 14189.290535473185, 22493.43766405853, 22797.316080517612, 23049.308520744406, 23100.19149329799, 23166.65250021251, 7899.249571290718, 8167.795805104801, 8185.467944583583, 8244.464109832841, 8400.83198336042, 1044.4255659387306, 1131.9660410187707, 1217.1358335581835, 1250.4623012104882, 1269.6635391621228, 35136.12159696028, 35306.82346588302, 35417.29165416677, 35620.82189589035, 35711.10722231965, 1198.8920997110129, 1245.4582256718356, 1249.1318533619228, 1306.3794697518792, 1335.9866401336058, 18503.81496185048, 18553.25786968506, 18619.627607448045, 18650.067496625114, 18660.533486662942, 644984.0, 649787.0, 651717.0, 655088.0, 656080.0, 64363.67818160973, 64505.0, 64596.0, 65126.67436662786, 65171.348286517474, 1426.2512181105003, 1426.415169780406, 1428.6356978970296, 1466.0543949152736, 1472.9337179826935, 34554.30891382208, 34761.65238347584, 35179.648203518664, 35250.823745881105, 35373.0, 55905.16142257788, 56267.155992659325, 56325.0, 56365.0, 56642.716786415804, 496568.0, 499652.0, 499762.0, 500012.0, 500270.0, 32230.516542251415, 32358.514622281156, 32420.83789581037, 32428.83785581057, 32644.673553264165, 53309.7334513325, 53605.73197133989, 53837.0, 53875.461245388615, 54449.0, 46576.301355479016, 49510.75244623754, 49652.75173624109, 49837.0, 50237.74881125571, 47382.52617473781, 47401.0, 47518.287225690954, 47525.0, 47672.523274766805, 46341.0, 46620.067598648515, 47015.294770577784, 47110.52889471062, 48733.47361734318, 38754.0, 41385.79307103445, 41563.58436415597, 41997.1600567993, 42148.0, 31192.844035779675, 31546.36907261796, 31660.208494787814, 32016.199595010312, 32103.197420063752], "value": 22111.351787823398, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.67146282973613, 419.8320671731305, 423.68435515540915, 434.3788382612863, 441.27630685675496, 18980.810191898076, 20195.39413817586, 20807.895960520214, 21626.567468650617, 21844.344669659935, 20514.48713782156, 20530.897345513287, 20666.27668031619, 20995.160193592277, 21283.680744788842, 5877.9412205877825, 6078.665673387962, 6089.908651370233, 6097.908531372033, 6109.0, 5880.059190529516, 5946.316173640022, 5950.434708702666, 5967.731452084645, 6051.092336149591, 5789.913151302734, 5833.445822646863, 5866.765329386841, 5943.257092863392, 6001.189839371695, 5923.081922302029, 5937.495312898409, 5989.371116032841, 5993.430624090704, 5998.190244317048, 5178.300929374524, 5286.127788914824, 5295.894082118374, 5330.600204984642, 5336.893262134736, 14639.487617933428, 16087.517374478784, 22355.776442235532, 22889.656655150186, 23167.0, 2384.225126833786, 2408.2895545814026, 2430.2830664953703, 2472.3942634054592, 2973.914521199768, 7482.925170748277, 7677.0403699537555, 10878.347299161996, 11057.336559806437, 12437.0, 2045.887476188809, 2060.81452669259, 2109.799569040954, 2117.5976564452703, 2162.9783702162936, 66881.66559167222, 71892.0, 73971.26028739697, 74538.62730686367, 91333.08666913312, 11533.0, 11720.648380548597, 11928.403579820973, 11946.462409191607, 12008.759824803456, 16854.241559129623, 16939.407120750715, 16940.915295423445, 16944.745828812578, 16996.150192490328, 8797.51613661242, 8875.378723489423, 9094.18152366277, 9104.089591040844, 9318.394304370195, 8868.689595864114, 8873.73378798637, 8914.86627700585, 9142.862857057149, 9194.724158275263, 4955.2567114933045, 5040.193569028937, 5059.139946209079, 5096.210087436453, 5128.153854613947, 2088.4256829372043, 2094.863833850795, 2097.853150279466, 2145.9248926287505, 2211.369759618533, 964.1226483899618, 1046.2519298701466, 1055.8469021991768, 1092.8852470490642, 1138.6470194239812, 20235.494112647008, 20709.68935465969, 21366.89316553407, 21426.357209283746, 21694.674579881314, 1063.7553362726617, 1066.328213225663, 1090.8418279349607, 1117.5753213778712, 1131.7849608574345, 11123.221374503708, 11149.442527873736, 11891.821622675667, 12075.637730868088, 12080.87919120815, 557891.0, 561589.0, 561953.0, 573210.0, 580509.0, 93541.0, 94857.525712371, 96248.0, 97605.51197243968, 102702.0, 989.8465737810651, 1012.8959434216887, 1019.2661283875598, 1021.4484178543503, 1028.0387837371932, 16845.494635160965, 19305.8069419304, 19522.21911123596, 19713.901430492755, 19793.30723424673, 41142.79428602838, 42210.57789422067, 46290.537094629966, 46712.29931551097, 47193.0, 58976.0, 60105.0, 64049.67975160281, 64523.0, 66032.0, 8188.467749596257, 8296.751097467086, 8328.458650187718, 8377.623006964579, 8420.410571259952, 12107.515699371927, 13705.314734263047, 13998.58004259833, 14147.151170929777, 14326.283685815875, 11338.773224535298, 11530.82703759461, 11765.76468470643, 11897.940510297392, 11911.0, 12003.339816310187, 12304.0, 12318.445669945053, 12441.626751197478, 12550.560730374758, 11438.027767639844, 11628.825567616323, 11641.708957275798, 12389.194702344319, 12443.128980971245, 8504.362172837185, 8554.871676924726, 8567.4002819802, 9362.95318523403, 9385.953070234606, 8658.177473140042, 10278.383297002203, 10620.575176992834, 11353.205275630957, 11354.26197297173], "value": 9635.620608155785, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1554.440401455476, 1568.1375243616008, 1760.6126652136534, 1865.393747032214, 1869.1588785046733, 8591.570421478933, 9312.767180820474, 9409.059094090604, 9915.553800078997, 10017.148542373898, 9478.146966772989, 9790.85313720293, 9802.754931126708, 9816.116549510543, 9909.157721593656, 2473.6907886514186, 2499.8375105618074, 2504.887280072392, 2507.6865391826022, 2511.3721569607596, 2482.751724827521, 2550.1457011901034, 2555.757203065715, 2567.10151446993, 2571.2286314105786, 2510.2092840755195, 2527.4692314613953, 2540.174443305924, 2547.032127791437, 2548.2610043087484, 2494.8128890333205, 2495.238952119603, 2507.4107584717576, 2510.3724068982756, 2515.245426372081, 2460.138951367025, 2467.8395904266167, 2469.6789417375626, 2484.465839844424, 2525.8105642076916, 9859.950700246525, 9909.950450247774, 9912.653057142965, 9925.2059835213, 9926.106650401427, 5598.356189038272, 5694.088945768657, 5694.288213973254, 5703.144528320744, 5719.14212868069, 3543.5039094526787, 3633.0372451300427, 3686.4286035664513, 3729.9627003730157, 3767.6797472214894, 1163.1450883600546, 1192.3322939154102, 1195.7668254690338, 1198.8741182175834, 1223.253815172744, 12956.80564791529, 12962.416691248916, 12970.962323014137, 12981.61055168337, 13024.023198260074, 4771.475137734847, 4775.594074503637, 5101.51535604117, 5101.877586930869, 5146.588272938231, 10777.407242601732, 10781.299215550964, 10790.24468287228, 10846.67459976202, 10902.618408355669, 5710.486056254874, 5746.856328591819, 5770.07678771403, 5770.480656740913, 5779.133130030445, 4677.532246775295, 5205.453427390145, 5311.990721762852, 5317.707526086025, 5368.973155134199, 4420.138073075784, 4513.187626227311, 4535.886602834889, 4541.977290113528, 4543.909121817611, 1405.7469655462114, 1423.7864320351823, 1436.3751767980962, 1448.6523234423873, 1459.3651761483789, 937.7186843946926, 1060.7030031591166, 1077.789830982951, 1085.3054045410943, 1107.429673718036, 6503.7073331700185, 6628.270890202074, 6788.796336109925, 6813.4889883257965, 6875.140607424072, 484.19865123221126, 486.73959431703867, 495.88842510435586, 497.4428639923309, 500.66455474831224, 4371.388005679208, 4373.518912919576, 4421.336799480104, 4470.994026344047, 4484.775761211991, 12081.697957551132, 12419.813702794465, 12445.688857778629, 12464.189827661174, 12509.749805003848, 12102.878971210175, 12166.635000949986, 12264.81602775959, 12274.631761047183, 12329.568465103679, 8627.309815214769, 8700.738977830675, 8765.737027889174, 8872.8669069964, 8907.421017633833, 6536.803895883131, 6672.232693240146, 6693.598384096969, 6745.426638735762, 6759.053732477359, 11030.558777648805, 11032.28290161137, 11034.503447345049, 11070.0, 11343.886561134283, 11102.222844401138, 11228.55085796559, 11330.773384532098, 11440.370779606868, 11498.367589782307, 7788.88316675239, 8270.214329638675, 8334.916650833415, 8623.439476434012, 8685.652573896974, 9532.332736708364, 9569.904300956901, 9574.281928855504, 9600.471974041215, 9626.085521875411, 8356.122607126164, 8591.527465989431, 8615.483071015758, 8640.26557742599, 8646.135386461303, 8154.592270386338, 8205.589720513832, 8234.794130146794, 8236.052853921636, 8255.0, 7579.848403032019, 7615.657295421608, 7657.272559106876, 7659.463837531543, 7711.768646940601, 5754.223179870832, 5757.9424205757405, 5870.412958704095, 5995.070764031582, 6005.159277701213, 5769.1634712967225, 5837.270341207349, 5888.735006924613, 5923.940760592339, 5939.910901336397], "value": 4990.824950520472, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.7446863789435, 357.69059763304733, 357.72097763744273, 364.18604419123255, 366.05557661234013, 5614.494695477406, 5699.287589051369, 5741.397153298895, 5746.362286748277, 5761.913571296429, 5737.913931291024, 5750.0, 5795.797147099853, 5798.5361171106315, 5804.390538993398, 4545.11370282795, 4559.039612966415, 4564.680472366936, 4569.862904112882, 4571.154336447751, 4471.6646251531265, 4574.771261436931, 4578.725276483405, 4596.908061838762, 4625.907481850361, 4547.522510136438, 4560.065186636748, 4576.931346029813, 4590.678652494326, 4596.770161491929, 4585.70192937458, 4586.6469391529245, 4591.931121033187, 4607.4471063472265, 4611.746353950532, 3878.728489005771, 3970.4441378207075, 3974.085960229135, 3988.78061706606, 3993.221321842242, 5610.24261724666, 5610.354809196913, 5657.349404818417, 5687.886242275173, 5705.37396841898, 5064.607233010952, 5182.53357197854, 5195.428502864682, 5204.375474943031, 5212.244224587414, 6008.459238668541, 6031.185789918349, 6036.82281955019, 6037.245344331958, 6059.424354686298, 4372.912541749147, 4404.251277282838, 4406.933895991563, 4415.845445409395, 4418.5802348776815, 5964.373740757202, 6240.7533288016275, 6304.455408424919, 6318.210223722035, 6358.1734374531015, 4440.0, 4446.199684056836, 4457.643388528974, 4493.932790916215, 4495.820167193341, 4540.636749060067, 4562.927711987681, 4564.657650676146, 4566.360709500673, 4570.108828778356, 5031.899362012739, 5203.502318886955, 5214.243934629458, 5220.269162317279, 5247.816326428633, 5933.703314834241, 6085.391460853968, 6126.908096378558, 6135.263768347738, 6138.785142519991, 1552.8680062194614, 1560.4382422327953, 1564.2647955461143, 1576.1961399686013, 1591.8248992610804, 974.3617930255693, 988.8467287570438, 1001.6994901529512, 1026.6140710041384, 1031.1956673794302, 5201.566965802628, 5211.739413029333, 5217.7302873250255, 5218.66078704883, 5273.209018647157, 5481.314835645544, 5495.323926202466, 5512.255845460892, 5518.862028449321, 5521.723913804293, 5137.640365174477, 5227.764750586232, 5238.60710446718, 5347.967772246521, 5363.463653634605, 2949.8230106193696, 2951.631046119235, 2966.9109926702235, 2967.807092539021, 3004.72957433832, 5673.929015909163, 5712.6286791358425, 5725.312962444534, 5737.569682273846, 5743.898294920779, 5269.631125821155, 5567.944320556823, 5574.0, 5588.066265210716, 5626.409227031185, 5603.450430054397, 5648.350439699487, 5707.315122185364, 5748.827535173951, 5758.798442054508, 5541.33503979525, 5550.833474995757, 5559.555235581225, 5829.3296270927685, 6267.373262673696, 6207.379262073757, 6210.199042277689, 6223.284322302993, 6224.968875155776, 6234.438900498977, 6373.876800367693, 6523.151990241238, 6568.704408301734, 6627.768028118992, 6628.933710663025, 4475.082608065273, 4510.34599982994, 4525.954740452685, 4526.162659907927, 4535.909281814279, 6065.848353791191, 6217.891054472763, 6300.243970723543, 6362.522810789302, 6407.0, 6145.539084568764, 6150.015997440567, 6162.445379915829, 6179.783707570214, 6197.473214776614, 6108.72510737009, 6147.907781383372, 6207.099970504161, 6210.627362358273, 6249.25008998923, 5997.250343707036, 6039.78860739872, 6091.878162436815, 6102.9694851525455, 6133.785317513865, 6207.16203312547, 6272.560920735505, 6279.58709290406, 6291.307956124914, 6302.464290535356, 5935.34711181761, 5945.554083443672, 6005.858886811492, 6029.095635654511, 6049.304330002106], "value": 4545.8682254147725, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [721.9675114619841, 783.941204409669, 816.8039670479079, 867.7266661001786, 884.703624285864, 16610.418635347763, 16634.58413539662, 17492.0, 17676.558086047855, 17677.646447071067, 16053.0, 16239.188040597983, 16281.104539250337, 16282.0, 16309.83690163098, 737.7860420478082, 856.2122846980793, 873.2097451806126, 878.2666473494623, 895.4716717136888, 890.7372325164059, 891.1400498518927, 892.8125093730324, 893.5175005497024, 893.9106089391074, 921.7465197070792, 926.1942110363992, 927.601131513449, 930.6556574067571, 932.0213775535694, 925.7315378540216, 925.7731855695364, 927.6984979881565, 930.3627015494374, 937.161240689579, 685.239384283445, 685.6674512861258, 688.5868478912662, 689.2280645676824, 692.0622556436007, 16038.358465661477, 16162.676746465006, 16216.918915405347, 16218.675626487522, 16272.43046493367, 13092.47630094795, 14137.929310353486, 14744.410223591043, 14899.70200595982, 14915.0, 14236.501722439665, 14335.638114379117, 14360.497382591664, 14501.637459063608, 14751.041182323223, 4816.51834816519, 4816.7350795706225, 4863.319135321058, 5051.974740126276, 5055.368078990126, 89448.0, 90528.0, 91209.54395228048, 92523.0, 94414.52792735993, 12242.693932651577, 12541.623751287476, 12553.497860085678, 12645.936770316273, 12679.175853569488, 22281.66577501339, 22471.775282246967, 22568.322950311518, 22622.0, 23081.538369232523, 8976.775580610538, 9116.453012819253, 9184.724458266262, 9231.723048308562, 9340.0, 4881.829135980223, 5093.363329583802, 5113.233015047773, 5134.820281290137, 5227.111391063529, 3689.7786132832116, 3748.4002559590335, 3770.2836461072307, 3799.506064211635, 3804.752691075071, 650.2976785072111, 668.0480315550418, 670.6009924095254, 679.67035987546, 702.2871785138088, 726.7238449389198, 730.8867125595541, 742.1279996004673, 748.5508694783196, 754.4454825703103, 9692.951535242279, 10470.738231544272, 10681.252312338062, 10745.78508429827, 10960.725981850517, 706.1349846438072, 743.8735414979467, 787.933025692811, 790.1584812175015, 791.1258059843905, 5139.8458046258675, 5282.0, 5373.623846330797, 5376.247325374451, 5528.115501519737, 100013.0, 113232.0, 115220.0, 118744.0, 118803.0, 102040.48979755203, 105163.0, 105381.47309263558, 107691.46154269179, 109650.45174774075, 90599.0, 91441.54279228562, 91886.0, 91894.0, 92728.0, 10210.795784084425, 10212.846807297748, 10498.317609355367, 10528.894711052792, 10610.469476525988, 51058.0, 51585.48414515957, 52675.736621316646, 53991.0, 55317.4286284694, 51139.0, 65231.34768652442, 67469.0, 68128.0, 68591.65704171447, 14080.22558759278, 14084.859151408355, 14125.788113178516, 14274.429022838971, 14495.710085798435, 15263.160526171167, 15675.686486270439, 15826.0, 15920.681586367977, 16771.580710482336, 15138.924052204064, 15252.31364588574, 15652.217389130727, 15981.200939953189, 16736.163191840114, 13273.66815829612, 13332.533361332307, 13900.860991389956, 14374.928125359307, 14457.27713614294, 14800.925995369955, 14808.0, 15153.848461515243, 15160.545183644508, 15333.00335478235, 11501.654950351503, 11637.185397022127, 12904.41930113166, 13238.338083096, 13637.659058523615, 12260.448279827251, 12405.875941240472, 12546.560870369858, 12556.058295627681, 12559.748805024032], "value": 8189.198096999963, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1496.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 105.0, 110.0, 111.0, 112.0, 111.0, 111.0, 111.0, 109.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 116.0, 142.0, 163.0, 118.0, 145.0, 144.0, 121.0, 188.0, 115.0], "value": 140.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 163.0, 163.0, 163.0, 163.0, 161.0, 162.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 174.0, 76.0, 75.0, 77.0, 77.0, 162.0, 77.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 144.0, 83.0, 82.0, 83.0, 136.0, 84.0, 83.0, 140.0], "value": 100.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 124.0, 117.0, 118.0, 118.0, 118.0, 119.0, 118.0, 118.0, 118.0], "value": 118.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 147.0, 148.0, 148.0, 149.0, 148.0, 148.0, 148.0, 149.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 100.0, 95.0, 97.0, 96.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 53.0, 53.0, 53.0, 52.0, 57.0, 52.0, 52.0, 55.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 59.0, 60.0, 60.0, 59.0, 59.0, 60.0, 60.0, 60.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 73.0, 74.0, 73.0, 73.0, 72.0, 80.0, 73.0], "value": 73.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 118.0, 127.0, 120.0, 120.0, 117.0, 120.0, 133.0, 158.0, 120.0], "value": 126.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 153.0, 153.0, 151.0, 151.0, 149.0, 149.0, 156.0, 150.0, 151.0], "value": 151.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 65.0, 63.0, 62.0, 61.0, 62.0, 63.0, 65.0, 60.0], "value": 62.7, "unit": "score"}]}]} 12:16:41 INFO - Return code: 0 12:16:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:16:41 ERROR - # TBPL SUCCESS # 12:16:41 INFO - Running post-action listener: _resource_record_post_action 12:16:41 INFO - [mozharness: 2016-08-24 19:16:41.308077Z] Finished run-tests step (success) 12:16:41 INFO - Running post-run listener: _resource_record_post_run 12:16:41 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 266240; Write bytes: 330190848; Read time: 24; Write time: 214260 12:16:41 INFO - TinderboxPrint: CPU usage
13.3% 12:16:41 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 24 12:16:41 INFO - TinderboxPrint: I/O write bytes / time
330,190,848 / 214,260 12:16:41 INFO - TinderboxPrint: CPU idle
8,213.7 (86.7%) 12:16:41 INFO - TinderboxPrint: CPU user
1,202.8 (12.7%) 12:16:41 INFO - TinderboxPrint: Swap in / out
0 / 0 12:16:41 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 78290944; Read time: 0; Write time: 44244 12:16:41 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 266240; Write bytes: 250998784; Read time: 24; Write time: 169996 12:16:41 INFO - Running post-run listener: _upload_blobber_files 12:16:41 INFO - Blob upload gear active. 12:16:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:16:41 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 12:16:41 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'] 12:16:41 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 12:16:42 INFO - (blobuploader) - INFO - Open directory for files ... 12:16:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:16:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:16:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:16:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:16:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:16:43 INFO - (blobuploader) - INFO - Done attempting. 12:16:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:16:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:16:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:16:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:16:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:16:47 INFO - (blobuploader) - INFO - Done attempting. 12:16:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:16:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:16:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:16:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:16:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:16:48 INFO - (blobuploader) - INFO - Done attempting. 12:16:48 INFO - (blobuploader) - INFO - Iteration through files over. 12:16:48 INFO - Return code: 0 12:16:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:16:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:16:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/72a451608609de0aada07978016d8df51d4f16040e7f721fa935d1fe275709eb41af6d6d92df9846c284d1b859acec877062a402a5385512f33411ce9ab7cafd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c180f0bf3fbd0a2267ddbe9df0daca1d2162f88dc7be8b94ae451959aeae431fd72c79d196e103d4f029f80b574e96ab5bb5385b6f1af37883980c55bb73a6c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0a1e8c7a3e6d029fc4812e0b89fa106efd38ca09f472cc971383b5c6c2f07571e41ce6628b5adde4d1578152ea39c802396d352466ad6496f6c9361777f2ef32"} 12:16:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:16:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:16:48 INFO - Contents: 12:16:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/72a451608609de0aada07978016d8df51d4f16040e7f721fa935d1fe275709eb41af6d6d92df9846c284d1b859acec877062a402a5385512f33411ce9ab7cafd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c180f0bf3fbd0a2267ddbe9df0daca1d2162f88dc7be8b94ae451959aeae431fd72c79d196e103d4f029f80b574e96ab5bb5385b6f1af37883980c55bb73a6c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0a1e8c7a3e6d029fc4812e0b89fa106efd38ca09f472cc971383b5c6c2f07571e41ce6628b5adde4d1578152ea39c802396d352466ad6496f6c9361777f2ef32"} 12:16:48 INFO - Running post-run listener: copy_logs_to_upload_dir 12:16:48 INFO - Copying logs to upload dir... 12:16:48 INFO - mkdir: /builds/slave/test/build/upload/logs 12:16:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1676.020754 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 56 secs) (at 2016-08-24 12:16:48.037117) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-24 12:16:48.040478) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1472060043.313554-2028269326 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/72a451608609de0aada07978016d8df51d4f16040e7f721fa935d1fe275709eb41af6d6d92df9846c284d1b859acec877062a402a5385512f33411ce9ab7cafd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c180f0bf3fbd0a2267ddbe9df0daca1d2162f88dc7be8b94ae451959aeae431fd72c79d196e103d4f029f80b574e96ab5bb5385b6f1af37883980c55bb73a6c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0a1e8c7a3e6d029fc4812e0b89fa106efd38ca09f472cc971383b5c6c2f07571e41ce6628b5adde4d1578152ea39c802396d352466ad6496f6c9361777f2ef32"} build_url:https://queue.taskcluster.net/v1/task/BWFGVTPVQhGDZ11syrORjA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011445 build_url: 'https://queue.taskcluster.net/v1/task/BWFGVTPVQhGDZ11syrORjA/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/72a451608609de0aada07978016d8df51d4f16040e7f721fa935d1fe275709eb41af6d6d92df9846c284d1b859acec877062a402a5385512f33411ce9ab7cafd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c180f0bf3fbd0a2267ddbe9df0daca1d2162f88dc7be8b94ae451959aeae431fd72c79d196e103d4f029f80b574e96ab5bb5385b6f1af37883980c55bb73a6c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0a1e8c7a3e6d029fc4812e0b89fa106efd38ca09f472cc971383b5c6c2f07571e41ce6628b5adde4d1578152ea39c802396d352466ad6496f6c9361777f2ef32"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-24 12:16:48.066569) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 12:16:48.066977) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1472060043.313554-2028269326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 12:16:48.151200) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-24 12:16:48.151543) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-24 12:16:48.151867) ========= ========= Total master_lag: 0.15 =========