builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-034 starttime: 1471376090.96 results: success (0) buildid: 20160816111017 builduid: 8b58b4e5039343c79852faeae2f6658e revision: 26538451d2729e8f2447b35c2d3ee58be0d6a5f4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 12:34:50.964434) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 12:34:50.964834) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 12:34:50.965165) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 12:34:51.004190) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 12:34:51.004476) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1471375159.372356-354710992 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-16 12:34: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 110M=0s 2016-08-16 12:34:51 (110 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.074672 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 12:34:51.124347) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 12:34:51.124658) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1471375159.372356-354710992 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019757 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 12:34:51.194126) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 12:34:51.194689) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 26538451d2729e8f2447b35c2d3ee58be0d6a5f4 --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 26538451d2729e8f2447b35c2d3ee58be0d6a5f4 --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=d6bbd613908ccac0c6c9cb47000001f7-1471375159.372356-354710992 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-16 12:34:51,483 truncating revision to first 12 chars 2016-08-16 12:34:51,483 Setting DEBUG logging. 2016-08-16 12:34:51,483 attempt 1/10 2016-08-16 12:34:51,483 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/26538451d272?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-16 12:34:51,805 unpacking tar archive at: mozilla-aurora-26538451d272/testing/mozharness/ program finished with exit code 0 elapsedTime=0.642299 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 12:34:51.856963) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 12:34:51.857249) ========= script_repo_revision: 26538451d2729e8f2447b35c2d3ee58be0d6a5f4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 12:34:51.857605) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 12:34:51.857903) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 12:34:51.868717) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 13 secs) (at 2016-08-16 12:34:51.868976) ========= /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=d6bbd613908ccac0c6c9cb47000001f7-1471375159.372356-354710992 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:34:52 INFO - MultiFileLogger online at 20160816 12:34:52 in /builds/slave/test 12:34: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 12:34:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:34:52 INFO - {'append_to_log': False, 12:34:52 INFO - 'base_work_dir': '/builds/slave/test', 12:34:52 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:34:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:34:52 INFO - 'branch': 'Mozilla-Aurora', 12:34:52 INFO - 'buildbot_json_path': 'buildprops.json', 12:34:52 INFO - 'config_files': ('talos/linux_config.py',), 12:34:52 INFO - 'default_actions': ('clobber', 12:34:52 INFO - 'read-buildbot-config', 12:34:52 INFO - 'download-and-extract', 12:34:52 INFO - 'populate-webroot', 12:34:52 INFO - 'create-virtualenv', 12:34:52 INFO - 'install', 12:34:52 INFO - 'run-tests'), 12:34:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:34:52 INFO - 'download_minidump_stackwalk': True, 12:34:52 INFO - 'download_symbols': 'ondemand', 12:34:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:34:52 INFO - 'tooltool.py': '/tools/tooltool.py', 12:34:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:34:52 INFO - '/tools/misc-python/virtualenv.py')}, 12:34:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:34:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:34:52 INFO - 'installer_path': 'installer.exe', 12:34:52 INFO - 'log_level': 'info', 12:34:52 INFO - 'log_name': 'talos', 12:34:52 INFO - 'log_to_console': True, 12:34:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:34:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:34:52 INFO - 'opt_config_files': (), 12:34:52 INFO - 'pip_index': False, 12:34:52 INFO - 'sps_profile': False, 12:34:52 INFO - 'sps_profile_interval': 0, 12:34:52 INFO - 'suite': 'dromaeojs-e10s', 12:34:52 INFO - 'system_bits': '32', 12:34:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:34:52 INFO - 'title': 'talos-linux64-ix-034', 12:34:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:34:52 INFO - 'use_talos_json': True, 12:34:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:34:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:34:52 INFO - 'work_dir': 'build'} 12:34:52 INFO - [mozharness: 2016-08-16 19:34:52.253376Z] Running clobber step. 12:34:52 INFO - Running pre-action listener: _resource_record_pre_action 12:34:52 INFO - Running main action method: clobber 12:34:52 INFO - rmtree: /builds/slave/test/build 12:34:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:34:52 INFO - Running post-action listener: _resource_record_post_action 12:34:52 INFO - [mozharness: 2016-08-16 19:34:52.717011Z] Finished clobber step (success) 12:34:52 INFO - [mozharness: 2016-08-16 19:34:52.717116Z] Running read-buildbot-config step. 12:34:52 INFO - Running pre-action listener: _resource_record_pre_action 12:34:52 INFO - Running main action method: read_buildbot_config 12:34:52 INFO - Using buildbot properties: 12:34:52 INFO - { 12:34:52 INFO - "project": "", 12:34:52 INFO - "product": "firefox", 12:34:52 INFO - "script_repo_revision": "production", 12:34:52 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 12:34:52 INFO - "repository": "", 12:34:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 12:34:52 INFO - "buildid": "20160816111017", 12:34:52 INFO - "pgo_build": "True", 12:34:52 INFO - "basedir": "/builds/slave/test", 12:34:52 INFO - "buildnumber": 468, 12:34:52 INFO - "slavename": "talos-linux64-ix-034", 12:34:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:34:52 INFO - "platform": "ubuntu64_hw", 12:34:52 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 12:34:52 INFO - "branch": "mozilla-aurora", 12:34:52 INFO - "repo_path": "releases/mozilla-aurora", 12:34:52 INFO - "revision": "26538451d2729e8f2447b35c2d3ee58be0d6a5f4", 12:34:52 INFO - "stage_platform": "linux64-pgo", 12:34:52 INFO - "builduid": "8b58b4e5039343c79852faeae2f6658e", 12:34:52 INFO - "slavebuilddir": "test" 12:34:52 INFO - } 12:34:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 12:34:52 INFO - Running post-action listener: _resource_record_post_action 12:34:52 INFO - [mozharness: 2016-08-16 19:34:52.719562Z] Finished read-buildbot-config step (success) 12:34:52 INFO - [mozharness: 2016-08-16 19:34:52.719651Z] Running download-and-extract step. 12:34:52 INFO - Running pre-action listener: _resource_record_pre_action 12:34:52 INFO - Running main action method: download_and_extract 12:34:52 INFO - mkdir: /builds/slave/test/build/tests 12:34: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')]} 12:34:52 INFO - https://queue.taskcluster.net/v1/task/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:34:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 12:34:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 12:34:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/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 12:34:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/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 12:34:52 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 12:34:52 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 12:34:52 INFO - retry: Failed, sleeping 30 seconds before retrying 12:35:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/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 12:35:22 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 12:35:22 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 12:35:22 INFO - retry: Failed, sleeping 60 seconds before retrying 12:36:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/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 12:36:22 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 12:36:22 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 12:36:22 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/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! 12:36:22 INFO - Caught exception: HTTP Error 404: Not Found 12:36:22 INFO - Caught exception: HTTP Error 404: Not Found 12:36:22 INFO - Caught exception: HTTP Error 404: Not Found 12:36:22 INFO - trying https://queue.taskcluster.net/v1/task/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 12:36:22 INFO - Downloading https://queue.taskcluster.net/v1/task/aghdPOPzRMSxvm8uXDdp2A/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 12:36:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aghdPOPzRMSxvm8uXDdp2A/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 12:36:23 INFO - Downloaded 1361 bytes. 12:36:23 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 12:36:23 INFO - Using the following test package requirements: 12:36:23 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 12:36:23 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 12:36:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 12:36:23 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 12:36:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 12:36:23 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 12:36:23 INFO - u'jsshell-linux-x86_64.zip'], 12:36:23 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 12:36:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 12:36:23 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 12:36:23 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 12:36:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 12:36:23 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 12:36:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 12:36:23 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 12:36:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 12:36:23 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 12:36:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 12:36:23 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:36: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')]} 12:36:23 INFO - https://queue.taskcluster.net/v1/task/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:36:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 12:36:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 12:36:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/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 12:36:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/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 12:36:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 12:36:23 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 12:36:23 INFO - retry: Failed, sleeping 30 seconds before retrying 12:36:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/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 12:36:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 12:36:53 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 12:36:53 INFO - retry: Failed, sleeping 60 seconds before retrying 12:37:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/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 12:37:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 12:37:53 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 12:37:53 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/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! 12:37:53 INFO - Caught exception: HTTP Error 404: Not Found 12:37:53 INFO - Caught exception: HTTP Error 404: Not Found 12:37:53 INFO - Caught exception: HTTP Error 404: Not Found 12:37:53 INFO - trying https://queue.taskcluster.net/v1/task/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 12:37:53 INFO - Downloading https://queue.taskcluster.net/v1/task/aghdPOPzRMSxvm8uXDdp2A/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 12:37:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aghdPOPzRMSxvm8uXDdp2A/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 12:37:54 INFO - Downloaded 21768400 bytes. 12:37: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'] 12:37: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 12:37:55 INFO - Return code: 0 12:37: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 12:37: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')]} 12:37:55 INFO - https://queue.taskcluster.net/v1/task/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:37:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 12:37:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 12:37:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/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 12:37:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/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 12:37:55 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 12:37:55 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 12:37:55 INFO - retry: Failed, sleeping 30 seconds before retrying 12:38:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/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 12:38:25 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 12:38:25 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 12:38:25 INFO - retry: Failed, sleeping 60 seconds before retrying 12:39:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/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 12:39:25 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 12:39:25 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 12:39:25 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/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! 12:39:25 INFO - Caught exception: HTTP Error 404: Not Found 12:39:25 INFO - Caught exception: HTTP Error 404: Not Found 12:39:25 INFO - Caught exception: HTTP Error 404: Not Found 12:39:25 INFO - trying https://queue.taskcluster.net/v1/task/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 12:39:25 INFO - Downloading https://queue.taskcluster.net/v1/task/aghdPOPzRMSxvm8uXDdp2A/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 12:39:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aghdPOPzRMSxvm8uXDdp2A/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 12:39:27 INFO - Downloaded 21768400 bytes. 12:39:27 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'] 12:39:27 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 12:39:28 INFO - Return code: 0 12:39: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')]} 12:39:28 INFO - https://queue.taskcluster.net/v1/task/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:39:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 12:39:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 12:39:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/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 12:39:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/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 12:39:28 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 12:39:28 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 12:39:28 INFO - retry: Failed, sleeping 30 seconds before retrying 12:39:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/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 12:39:58 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 12:39:58 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 12:39:58 INFO - retry: Failed, sleeping 60 seconds before retrying 12:40:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/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 12:40:59 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 12:40:59 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 12:40:59 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/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! 12:40:59 INFO - Caught exception: HTTP Error 404: Not Found 12:40:59 INFO - Caught exception: HTTP Error 404: Not Found 12:40:59 INFO - Caught exception: HTTP Error 404: Not Found 12:40:59 INFO - trying https://queue.taskcluster.net/v1/task/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 12:40:59 INFO - Downloading https://queue.taskcluster.net/v1/task/aghdPOPzRMSxvm8uXDdp2A/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 12:40:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aghdPOPzRMSxvm8uXDdp2A/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 12:40:59 INFO - Downloaded 14413723 bytes. 12:40: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'] 12:40: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 12:41:00 INFO - Return code: 0 12:41:00 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')]} 12:41:00 INFO - https://queue.taskcluster.net/v1/task/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:41:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 12:41:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 12:41:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/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 12:41:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/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 12:41:00 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 12:41:00 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 12:41:00 INFO - retry: Failed, sleeping 30 seconds before retrying 12:41:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/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 12:41:30 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 12:41:30 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 12:41:30 INFO - retry: Failed, sleeping 60 seconds before retrying 12:42:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/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 12:42:30 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 12:42:30 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 12:42:30 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aghdPOPzRMSxvm8uXDdp2A/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! 12:42:30 INFO - Caught exception: HTTP Error 404: Not Found 12:42:30 INFO - Caught exception: HTTP Error 404: Not Found 12:42:30 INFO - Caught exception: HTTP Error 404: Not Found 12:42:30 INFO - trying https://queue.taskcluster.net/v1/task/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 12:42:30 INFO - Downloading https://queue.taskcluster.net/v1/task/aghdPOPzRMSxvm8uXDdp2A/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 12:42:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aghdPOPzRMSxvm8uXDdp2A/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 12:42:31 INFO - Downloaded 63781121 bytes. 12:42:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 12:42:31 INFO - mkdir: /builds/slave/test/properties 12:42:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:42:31 INFO - Writing to file /builds/slave/test/properties/build_url 12:42:31 INFO - Contents: 12:42:31 INFO - build_url:https://queue.taskcluster.net/v1/task/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 12:42:31 INFO - Running post-action listener: _resource_record_post_action 12:42:31 INFO - Running post-action listener: set_extra_try_arguments 12:42:31 INFO - [mozharness: 2016-08-16 19:42:31.942509Z] Finished download-and-extract step (success) 12:42:31 INFO - [mozharness: 2016-08-16 19:42:31.942742Z] Running populate-webroot step. 12:42:31 INFO - Running pre-action listener: _resource_record_pre_action 12:42:31 INFO - Running main action method: populate_webroot 12:42:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:42:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:42:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:42:31 INFO - '--tppagecycles', 12:42:31 INFO - '7'], 12:42:31 INFO - 'tests': ['tsvgm']}}, 12:42:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:42:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:42:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:42:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:42:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:42:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:42:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:42:31 INFO - 'talos_options': ['--disable-e10s'], 12:42:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:42:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:42:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:42:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:42:31 INFO - 'talos_options': ['--disable-e10s'], 12:42:31 INFO - 'tests': ['damp', 'tps']}, 12:42:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:42:31 INFO - 'tests': ['damp', 'tps']}, 12:42:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:42:31 INFO - 'tests': ['dromaeo_dom']}, 12:42:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:42:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:42:31 INFO - 'tests': ['basic_compositor_video']}, 12:42:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:42:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:42:31 INFO - 'tests': ['a11yr', 12:42:31 INFO - 'ts_paint', 12:42:31 INFO - 'tpaint', 12:42:31 INFO - 'sessionrestore', 12:42:31 INFO - 'sessionrestore_no_auto_restore', 12:42:31 INFO - 'tabpaint']}, 12:42:31 INFO - 'other-e10s': {'tests': ['a11yr', 12:42:31 INFO - 'ts_paint', 12:42:31 INFO - 'tpaint', 12:42:31 INFO - 'sessionrestore', 12:42:31 INFO - 'sessionrestore_no_auto_restore', 12:42:31 INFO - 'tabpaint']}, 12:42:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:42:31 INFO - 'ts_paint', 12:42:31 INFO - 'tpaint', 12:42:31 INFO - 'sessionrestore', 12:42:31 INFO - 'sessionrestore_no_auto_restore', 12:42:31 INFO - 'tabpaint']}, 12:42:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:42:31 INFO - 'ts_paint', 12:42:31 INFO - 'tpaint', 12:42:31 INFO - 'sessionrestore', 12:42:31 INFO - 'sessionrestore_no_auto_restore', 12:42:31 INFO - 'tabpaint']}, 12:42:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:42:31 INFO - 'tests': ['a11yr', 12:42:31 INFO - 'ts_paint', 12:42:31 INFO - 'tpaint', 12:42:31 INFO - 'sessionrestore', 12:42:31 INFO - 'sessionrestore_no_auto_restore', 12:42:31 INFO - 'tabpaint']}, 12:42:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:42:31 INFO - 'tests': ['a11yr', 12:42:31 INFO - 'ts_paint', 12:42:31 INFO - 'tpaint', 12:42:31 INFO - 'sessionrestore', 12:42:31 INFO - 'sessionrestore_no_auto_restore', 12:42:31 INFO - 'tabpaint']}, 12:42:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:42:31 INFO - 'tests': ['tsvgx', 12:42:31 INFO - 'tsvgr_opacity', 12:42:31 INFO - 'tart', 12:42:31 INFO - 'tscrollx', 12:42:31 INFO - 'cart']}, 12:42:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:42:31 INFO - 'tsvgr_opacity', 12:42:31 INFO - 'tart', 12:42:31 INFO - 'tscrollx', 12:42:31 INFO - 'cart']}, 12:42:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:42:31 INFO - 'talos_options': ['--disable-e10s'], 12:42:31 INFO - 'tests': ['tp5o']}, 12:42:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:42:31 INFO - 'tests': ['tp5o']}, 12:42:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:42:31 INFO - 'talos_options': ['--disable-e10s', 12:42:31 INFO - '--xperf_path', 12:42:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:42:31 INFO - 'tests': ['tp5n']}, 12:42:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:42:31 INFO - 'talos_options': ['--xperf_path', 12:42:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:42:31 INFO - 'tests': ['tp5n']}}, 12:42:31 INFO - 'talos.zip': {'path': '', 12:42:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:42:31 INFO - Running post-action listener: _resource_record_post_action 12:42:31 INFO - [mozharness: 2016-08-16 19:42:31.960046Z] Finished populate-webroot step (success) 12:42:31 INFO - [mozharness: 2016-08-16 19:42:31.960134Z] Running create-virtualenv step. 12:42:31 INFO - Running pre-action listener: _resource_record_pre_action 12:42:31 INFO - Running main action method: create_virtualenv 12:42:31 INFO - Creating virtualenv /builds/slave/test/build/venv 12:42: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 12:42:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:42:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:42:32 INFO - Using real prefix '/usr' 12:42:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:42:32 INFO - Installing distribute.............................................................................................................................................................................................done. 12:42:34 INFO - Installing pip.................done. 12:42:34 INFO - Return code: 0 12:42:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:42: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')]} 12:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42: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')]} 12:42:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42: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 0x282c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aea570>, '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 0x2aeb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aeb900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1471375159.372356-354710992', '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 12:42: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 12:42: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 12:42:34 INFO - Using env: {'DISPLAY': ':0', 12:42:34 INFO - 'HOME': '/home/cltbld', 12:42:34 INFO - 'LANG': 'en_US.UTF-8', 12:42:34 INFO - 'LANGUAGE': 'en_US:en', 12:42:34 INFO - 'LOGNAME': 'cltbld', 12:42:34 INFO - 'MAIL': '/var/mail/cltbld', 12:42:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:34 INFO - 'MOZ_NO_REMOTE': '1', 12:42:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:34 INFO - 'NO_EM_RESTART': '1', 12:42:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:34 INFO - 'PWD': '/builds/slave/test', 12:42:34 INFO - 'SHELL': '/bin/bash', 12:42:34 INFO - 'SHLVL': '1', 12:42:34 INFO - 'TERM': 'linux', 12:42:34 INFO - 'TMOUT': '86400', 12:42:34 INFO - 'USER': 'cltbld', 12:42:34 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471375159.372356-354710992', 12:42:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:34 INFO - '_': '/tools/buildbot/bin/python'} 12:42:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42: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 12:42:34 INFO - Cleaning up... 12:42:34 INFO - Return code: 0 12:42:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:42: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')]} 12:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42: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')]} 12:42:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42: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 0x282c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aea570>, '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 0x2aeb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aeb900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1471375159.372356-354710992', '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 12:42: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 12:42: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 12:42:34 INFO - Using env: {'DISPLAY': ':0', 12:42:34 INFO - 'HOME': '/home/cltbld', 12:42:34 INFO - 'LANG': 'en_US.UTF-8', 12:42:34 INFO - 'LANGUAGE': 'en_US:en', 12:42:34 INFO - 'LOGNAME': 'cltbld', 12:42:34 INFO - 'MAIL': '/var/mail/cltbld', 12:42:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:34 INFO - 'MOZ_NO_REMOTE': '1', 12:42:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:34 INFO - 'NO_EM_RESTART': '1', 12:42:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:34 INFO - 'PWD': '/builds/slave/test', 12:42:34 INFO - 'SHELL': '/bin/bash', 12:42:34 INFO - 'SHLVL': '1', 12:42:34 INFO - 'TERM': 'linux', 12:42:34 INFO - 'TMOUT': '86400', 12:42:34 INFO - 'USER': 'cltbld', 12:42:34 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471375159.372356-354710992', 12:42:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:34 INFO - '_': '/tools/buildbot/bin/python'} 12:42:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:34 INFO - Downloading/unpacking psutil>=3.1.1 12:42: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 12:42: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 12:42: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 12:42: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 12:42: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 12:42: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 12:42:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:42:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:42:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:42:36 INFO - Installing collected packages: psutil 12:42:36 INFO - Running setup.py install for psutil 12:42:37 INFO - building 'psutil._psutil_linux' extension 12:42:37 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 12:42: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_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:42:37 INFO - building 'psutil._psutil_posix' extension 12:42:37 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 12:42: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 12:42:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:42:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:42:37 INFO - Successfully installed psutil 12:42:37 INFO - Cleaning up... 12:42:37 INFO - Return code: 0 12:42:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:42: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')]} 12:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42: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')]} 12:42:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42: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 0x282c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aea570>, '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 0x2aeb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aeb900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1471375159.372356-354710992', '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 12:42: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 12:42: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 12:42:37 INFO - Using env: {'DISPLAY': ':0', 12:42:37 INFO - 'HOME': '/home/cltbld', 12:42:37 INFO - 'LANG': 'en_US.UTF-8', 12:42:37 INFO - 'LANGUAGE': 'en_US:en', 12:42:37 INFO - 'LOGNAME': 'cltbld', 12:42:37 INFO - 'MAIL': '/var/mail/cltbld', 12:42:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:37 INFO - 'MOZ_NO_REMOTE': '1', 12:42:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:37 INFO - 'NO_EM_RESTART': '1', 12:42:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:37 INFO - 'PWD': '/builds/slave/test', 12:42:37 INFO - 'SHELL': '/bin/bash', 12:42:37 INFO - 'SHLVL': '1', 12:42:37 INFO - 'TERM': 'linux', 12:42:37 INFO - 'TMOUT': '86400', 12:42:37 INFO - 'USER': 'cltbld', 12:42:37 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471375159.372356-354710992', 12:42:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:37 INFO - '_': '/tools/buildbot/bin/python'} 12:42:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:42: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 12:42: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 12:42: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 12:42: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 12:42: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 12:42: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 12:42:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:42:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:42:39 INFO - Installing collected packages: mozsystemmonitor 12:42:39 INFO - Running setup.py install for mozsystemmonitor 12:42:39 INFO - Successfully installed mozsystemmonitor 12:42:39 INFO - Cleaning up... 12:42:39 INFO - Return code: 0 12:42:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:42: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')]} 12:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42: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')]} 12:42:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42: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 0x282c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aea570>, '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 0x2aeb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aeb900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1471375159.372356-354710992', '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 12:42: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 12:42: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 12:42:39 INFO - Using env: {'DISPLAY': ':0', 12:42:39 INFO - 'HOME': '/home/cltbld', 12:42:39 INFO - 'LANG': 'en_US.UTF-8', 12:42:39 INFO - 'LANGUAGE': 'en_US:en', 12:42:39 INFO - 'LOGNAME': 'cltbld', 12:42:39 INFO - 'MAIL': '/var/mail/cltbld', 12:42:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:39 INFO - 'MOZ_NO_REMOTE': '1', 12:42:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:39 INFO - 'NO_EM_RESTART': '1', 12:42:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:39 INFO - 'PWD': '/builds/slave/test', 12:42:39 INFO - 'SHELL': '/bin/bash', 12:42:39 INFO - 'SHLVL': '1', 12:42:39 INFO - 'TERM': 'linux', 12:42:39 INFO - 'TMOUT': '86400', 12:42:39 INFO - 'USER': 'cltbld', 12:42:39 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471375159.372356-354710992', 12:42:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:39 INFO - '_': '/tools/buildbot/bin/python'} 12:42:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:40 INFO - Downloading/unpacking jsonschema==2.5.1 12:42:40 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 12:42:40 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 12:42:40 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 12:42:40 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 12:42:40 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 12:42:40 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 12:42:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:42:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:42: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 12:42: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 12:42: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 12:42: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 12:42: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 12:42: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 12:42:42 INFO - Downloading functools32-3.2.3-2.tar.gz 12:42:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:42:42 INFO - warning: no files found matching '*.txt' 12:42:42 INFO - no previously-included directories found matching 'build' 12:42:42 INFO - no previously-included directories found matching 'dist' 12:42:42 INFO - no previously-included directories found matching '.git*' 12:42:42 INFO - Installing collected packages: jsonschema, functools32 12:42:42 INFO - Running setup.py install for functools32 12:42:42 INFO - warning: no files found matching '*.txt' 12:42:42 INFO - no previously-included directories found matching 'build' 12:42:42 INFO - no previously-included directories found matching 'dist' 12:42:42 INFO - no previously-included directories found matching '.git*' 12:42:42 INFO - Successfully installed jsonschema functools32 12:42:42 INFO - Cleaning up... 12:42:42 INFO - Return code: 0 12:42:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:42: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')]} 12:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42: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')]} 12:42:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42: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 0x282c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aea570>, '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 0x2aeb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aeb900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1471375159.372356-354710992', '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 12:42: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 12:42: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 12:42:42 INFO - Using env: {'DISPLAY': ':0', 12:42:42 INFO - 'HOME': '/home/cltbld', 12:42:42 INFO - 'LANG': 'en_US.UTF-8', 12:42:42 INFO - 'LANGUAGE': 'en_US:en', 12:42:42 INFO - 'LOGNAME': 'cltbld', 12:42:42 INFO - 'MAIL': '/var/mail/cltbld', 12:42:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:42 INFO - 'MOZ_NO_REMOTE': '1', 12:42:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:42 INFO - 'NO_EM_RESTART': '1', 12:42:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:42 INFO - 'PWD': '/builds/slave/test', 12:42:42 INFO - 'SHELL': '/bin/bash', 12:42:42 INFO - 'SHLVL': '1', 12:42:42 INFO - 'TERM': 'linux', 12:42:42 INFO - 'TMOUT': '86400', 12:42:42 INFO - 'USER': 'cltbld', 12:42:42 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471375159.372356-354710992', 12:42:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:42 INFO - '_': '/tools/buildbot/bin/python'} 12:42:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:42:42 INFO - Cleaning up... 12:42:42 INFO - Return code: 0 12:42:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:42: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')]} 12:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42: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')]} 12:42:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42: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 0x282c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aea570>, '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 0x2aeb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aeb900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1471375159.372356-354710992', '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 12:42: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 12:42: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 12:42:42 INFO - Using env: {'DISPLAY': ':0', 12:42:42 INFO - 'HOME': '/home/cltbld', 12:42:42 INFO - 'LANG': 'en_US.UTF-8', 12:42:42 INFO - 'LANGUAGE': 'en_US:en', 12:42:42 INFO - 'LOGNAME': 'cltbld', 12:42:42 INFO - 'MAIL': '/var/mail/cltbld', 12:42:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:42 INFO - 'MOZ_NO_REMOTE': '1', 12:42:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:42 INFO - 'NO_EM_RESTART': '1', 12:42:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:42 INFO - 'PWD': '/builds/slave/test', 12:42:42 INFO - 'SHELL': '/bin/bash', 12:42:42 INFO - 'SHLVL': '1', 12:42:42 INFO - 'TERM': 'linux', 12:42:42 INFO - 'TMOUT': '86400', 12:42:42 INFO - 'USER': 'cltbld', 12:42:42 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471375159.372356-354710992', 12:42:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:42 INFO - '_': '/tools/buildbot/bin/python'} 12:42:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:42 INFO - Downloading/unpacking blobuploader==1.2.4 12:42: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 12:42: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 12:42: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 12:42: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 12:42: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 12:42: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 12:42:44 INFO - Downloading blobuploader-1.2.4.tar.gz 12:42:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:42:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:42: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 12:42: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 12:42: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 12:42: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 12:42: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 12:42: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 12:42:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:42:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:42:45 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 12:42:45 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 12:42:45 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 12:42:45 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 12:42:45 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 12:42:45 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 12:42:45 INFO - Downloading docopt-0.6.1.tar.gz 12:42:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:42:45 INFO - Installing collected packages: blobuploader, requests, docopt 12:42:45 INFO - Running setup.py install for blobuploader 12:42:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:42:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:42:45 INFO - Running setup.py install for requests 12:42:45 INFO - Running setup.py install for docopt 12:42:46 INFO - Successfully installed blobuploader requests docopt 12:42:46 INFO - Cleaning up... 12:42:46 INFO - Return code: 0 12:42:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:42:46 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')]} 12:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:46 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')]} 12:42:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:46 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 0x282c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aea570>, '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 0x2aeb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aeb900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1471375159.372356-354710992', '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 12:42:46 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 12:42:46 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 12:42:46 INFO - Using env: {'DISPLAY': ':0', 12:42:46 INFO - 'HOME': '/home/cltbld', 12:42:46 INFO - 'LANG': 'en_US.UTF-8', 12:42:46 INFO - 'LANGUAGE': 'en_US:en', 12:42:46 INFO - 'LOGNAME': 'cltbld', 12:42:46 INFO - 'MAIL': '/var/mail/cltbld', 12:42:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:46 INFO - 'MOZ_NO_REMOTE': '1', 12:42:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:46 INFO - 'NO_EM_RESTART': '1', 12:42:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:46 INFO - 'PWD': '/builds/slave/test', 12:42:46 INFO - 'SHELL': '/bin/bash', 12:42:46 INFO - 'SHLVL': '1', 12:42:46 INFO - 'TERM': 'linux', 12:42:46 INFO - 'TMOUT': '86400', 12:42:46 INFO - 'USER': 'cltbld', 12:42:46 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471375159.372356-354710992', 12:42:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:46 INFO - '_': '/tools/buildbot/bin/python'} 12:42:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:42:46 INFO - Running setup.py (path:/tmp/pip-o5lovY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:42:46 INFO - Running setup.py (path:/tmp/pip-63cA0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:42:46 INFO - Running setup.py (path:/tmp/pip-fM3C5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:42:46 INFO - Running setup.py (path:/tmp/pip-ckADcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:42:46 INFO - Running setup.py (path:/tmp/pip-LWNJ3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:42:46 INFO - Running setup.py (path:/tmp/pip-rUNJeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:42:46 INFO - Running setup.py (path:/tmp/pip-ZliaO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:42:46 INFO - Running setup.py (path:/tmp/pip-rSNA1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:42:46 INFO - Running setup.py (path:/tmp/pip-xfdIaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:42:46 INFO - Running setup.py (path:/tmp/pip-sKX0Lf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:42:46 INFO - Running setup.py (path:/tmp/pip-bWg_nZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:42:47 INFO - Running setup.py (path:/tmp/pip-w2Di4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:42:47 INFO - Running setup.py (path:/tmp/pip-Cnapm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:42:47 INFO - Running setup.py (path:/tmp/pip-4AXCTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:42:47 INFO - Running setup.py (path:/tmp/pip-_AZriz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:42:47 INFO - Running setup.py (path:/tmp/pip-8VSJpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:42:47 INFO - Running setup.py (path:/tmp/pip-9epjhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:42:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:42:47 INFO - Running setup.py install for manifestparser 12:42:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:42:47 INFO - Running setup.py install for mozcrash 12:42:47 INFO - Running setup.py install for mozdebug 12:42:47 INFO - Running setup.py install for mozdevice 12:42:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:42:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:42:47 INFO - Running setup.py install for mozfile 12:42:48 INFO - Running setup.py install for mozhttpd 12:42:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:42:48 INFO - Running setup.py install for mozinfo 12:42:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:42:48 INFO - Running setup.py install for mozInstall 12:42:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:42:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:42:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:42:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:42:48 INFO - Running setup.py install for mozleak 12:42:48 INFO - Running setup.py install for mozlog 12:42:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:42:48 INFO - Running setup.py install for moznetwork 12:42:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:42:48 INFO - Running setup.py install for mozprocess 12:42:48 INFO - Running setup.py install for mozprofile 12:42:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:42:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:42:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:42:48 INFO - Running setup.py install for mozrunner 12:42:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:42:48 INFO - Running setup.py install for mozscreenshot 12:42:49 INFO - Running setup.py install for moztest 12:42:49 INFO - Running setup.py install for mozversion 12:42:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:42:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:42:49 INFO - Cleaning up... 12:42:49 INFO - Return code: 0 12:42:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:42: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')]} 12:42:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42: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')]} 12:42:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42: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 0x282c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aea570>, '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 0x2aeb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aeb900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1471375159.372356-354710992', '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 12:42: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 12:42: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 12:42:49 INFO - Using env: {'DISPLAY': ':0', 12:42:49 INFO - 'HOME': '/home/cltbld', 12:42:49 INFO - 'LANG': 'en_US.UTF-8', 12:42:49 INFO - 'LANGUAGE': 'en_US:en', 12:42:49 INFO - 'LOGNAME': 'cltbld', 12:42:49 INFO - 'MAIL': '/var/mail/cltbld', 12:42:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:49 INFO - 'MOZ_NO_REMOTE': '1', 12:42:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:49 INFO - 'NO_EM_RESTART': '1', 12:42:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:49 INFO - 'PWD': '/builds/slave/test', 12:42:49 INFO - 'SHELL': '/bin/bash', 12:42:49 INFO - 'SHLVL': '1', 12:42:49 INFO - 'TERM': 'linux', 12:42:49 INFO - 'TMOUT': '86400', 12:42:49 INFO - 'USER': 'cltbld', 12:42:49 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471375159.372356-354710992', 12:42:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:49 INFO - '_': '/tools/buildbot/bin/python'} 12:42:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:42:49 INFO - Running setup.py (path:/tmp/pip-_i8wGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:42: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)) 12:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:42:49 INFO - Running setup.py (path:/tmp/pip-rYcCNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:42: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)) 12:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:42:49 INFO - Running setup.py (path:/tmp/pip-oIGRl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:42: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)) 12:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:42:49 INFO - Running setup.py (path:/tmp/pip-oOdfGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:42: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)) 12:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:42:49 INFO - Running setup.py (path:/tmp/pip-lxwWk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:42: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)) 12:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:42:49 INFO - Running setup.py (path:/tmp/pip-ERfMwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:42: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)) 12:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:42:49 INFO - Running setup.py (path:/tmp/pip-l210Vy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:42:50 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)) 12:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:42:50 INFO - Running setup.py (path:/tmp/pip-UE2Blr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:42:50 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)) 12:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:42:50 INFO - Running setup.py (path:/tmp/pip-eX4BZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:42:50 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)) 12:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:42:50 INFO - Running setup.py (path:/tmp/pip-vvc8oQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:42:50 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)) 12:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:42:50 INFO - Running setup.py (path:/tmp/pip-3v3k_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:42: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)) 12:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:42:50 INFO - Running setup.py (path:/tmp/pip-KZKGC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:42: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)) 12:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:42:50 INFO - Running setup.py (path:/tmp/pip-PkJLwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:42: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)) 12:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:42:50 INFO - Running setup.py (path:/tmp/pip-8w3sz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:42: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)) 12:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:42:50 INFO - Running setup.py (path:/tmp/pip-OKAwcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:42: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)) 12:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:42:50 INFO - Running setup.py (path:/tmp/pip-DmRpQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:42: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)) 12:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:42:50 INFO - Running setup.py (path:/tmp/pip-8VbUko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:42: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)) 12:42: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)) 12:42: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)) 12:42: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)) 12:42: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)) 12:42: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)) 12:42:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:42: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 12:42: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 12:42: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 12:42: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 12:42: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 12:42: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 12:42:52 INFO - Downloading blessings-1.6.tar.gz 12:42:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:42:52 INFO - Installing collected packages: blessings 12:42:52 INFO - Running setup.py install for blessings 12:42:52 INFO - Successfully installed blessings 12:42:52 INFO - Cleaning up... 12:42:52 INFO - Return code: 0 12:42:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:42:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:42:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:42:53 INFO - Reading from file tmpfile_stdout 12:42:53 INFO - Current package versions: 12:42:53 INFO - argparse == 1.2.1 12:42:53 INFO - blessings == 1.6 12:42:53 INFO - blobuploader == 1.2.4 12:42:53 INFO - docopt == 0.6.1 12:42:53 INFO - functools32 == 3.2.3-2 12:42:53 INFO - jsonschema == 2.5.1 12:42:53 INFO - manifestparser == 1.1 12:42:53 INFO - mozInstall == 1.12 12:42:53 INFO - mozcrash == 0.17 12:42:53 INFO - mozdebug == 0.1 12:42:53 INFO - mozdevice == 0.48 12:42:53 INFO - mozfile == 1.2 12:42:53 INFO - mozhttpd == 0.7 12:42:53 INFO - mozinfo == 0.9 12:42:53 INFO - mozleak == 0.1 12:42:53 INFO - mozlog == 3.3 12:42:53 INFO - moznetwork == 0.27 12:42:53 INFO - mozprocess == 0.23 12:42:53 INFO - mozprofile == 0.28 12:42:53 INFO - mozrunner == 6.12 12:42:53 INFO - mozscreenshot == 0.1 12:42:53 INFO - mozsystemmonitor == 0.3 12:42:53 INFO - moztest == 0.7 12:42:53 INFO - mozversion == 1.4 12:42:53 INFO - psutil == 3.1.1 12:42:53 INFO - requests == 1.2.3 12:42:53 INFO - wsgiref == 0.1.2 12:42:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:42: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')]} 12:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42: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')]} 12:42:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:53 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 0x282c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aea570>, '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 0x2aeb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aeb900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1471375159.372356-354710992', '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 12:42:53 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 12:42:53 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 12:42:53 INFO - Using env: {'DISPLAY': ':0', 12:42:53 INFO - 'HOME': '/home/cltbld', 12:42:53 INFO - 'LANG': 'en_US.UTF-8', 12:42:53 INFO - 'LANGUAGE': 'en_US:en', 12:42:53 INFO - 'LOGNAME': 'cltbld', 12:42:53 INFO - 'MAIL': '/var/mail/cltbld', 12:42:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:53 INFO - 'MOZ_NO_REMOTE': '1', 12:42:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:53 INFO - 'NO_EM_RESTART': '1', 12:42:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:53 INFO - 'PWD': '/builds/slave/test', 12:42:53 INFO - 'SHELL': '/bin/bash', 12:42:53 INFO - 'SHLVL': '1', 12:42:53 INFO - 'TERM': 'linux', 12:42:53 INFO - 'TMOUT': '86400', 12:42:53 INFO - 'USER': 'cltbld', 12:42:53 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471375159.372356-354710992', 12:42:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:53 INFO - '_': '/tools/buildbot/bin/python'} 12:42:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:53 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)) 12:42:53 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)) 12:42:53 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)) 12:42:53 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)) 12:42:53 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)) 12:42:53 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)) 12:42:53 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)) 12:42:53 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)) 12:42:53 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)) 12:42:53 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)) 12:42:53 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)) 12:42:53 INFO - Cleaning up... 12:42:53 INFO - Return code: 0 12:42:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:42: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')]} 12:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42: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')]} 12:42:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42: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 0x282c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aea570>, '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 0x2aeb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aeb900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1471375159.372356-354710992', '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 12:42: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 12:42: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 12:42:53 INFO - Using env: {'DISPLAY': ':0', 12:42:53 INFO - 'HOME': '/home/cltbld', 12:42:53 INFO - 'LANG': 'en_US.UTF-8', 12:42:53 INFO - 'LANGUAGE': 'en_US:en', 12:42:53 INFO - 'LOGNAME': 'cltbld', 12:42:53 INFO - 'MAIL': '/var/mail/cltbld', 12:42:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:53 INFO - 'MOZ_NO_REMOTE': '1', 12:42:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:53 INFO - 'NO_EM_RESTART': '1', 12:42:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:53 INFO - 'PWD': '/builds/slave/test', 12:42:53 INFO - 'SHELL': '/bin/bash', 12:42:53 INFO - 'SHLVL': '1', 12:42:53 INFO - 'TERM': 'linux', 12:42:53 INFO - 'TMOUT': '86400', 12:42:53 INFO - 'USER': 'cltbld', 12:42:53 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471375159.372356-354710992', 12:42:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:53 INFO - '_': '/tools/buildbot/bin/python'} 12:42:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:42:53 INFO - Cleaning up... 12:42:53 INFO - Return code: 0 12:42:53 INFO - Running post-action listener: _resource_record_post_action 12:42:53 INFO - Running post-action listener: _start_resource_monitoring 12:42:53 INFO - Starting resource monitoring. 12:42:53 INFO - [mozharness: 2016-08-16 19:42:53.576774Z] Finished create-virtualenv step (success) 12:42:53 INFO - [mozharness: 2016-08-16 19:42:53.577303Z] Running install step. 12:42:53 INFO - Running pre-action listener: _resource_record_pre_action 12:42:53 INFO - Running main action method: install 12:42:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:42:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:42:53 INFO - Reading from file tmpfile_stdout 12:42:53 INFO - Detecting whether we're running mozinstall >=1.0... 12:42:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:42:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:42:53 INFO - Reading from file tmpfile_stdout 12:42:53 INFO - Output received: 12:42:53 INFO - Usage: mozinstall [options] installer 12:42:53 INFO - Options: 12:42:53 INFO - -h, --help show this help message and exit 12:42:53 INFO - -d DEST, --destination=DEST 12:42:53 INFO - Directory to install application into. [default: 12:42:53 INFO - "/builds/slave/test"] 12:42:53 INFO - --app=APP Application being installed. [default: firefox] 12:42:53 INFO - mkdir: /builds/slave/test/build/application 12:42: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'] 12:42: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 12:43:10 INFO - Reading from file tmpfile_stdout 12:43:10 INFO - Output received: 12:43:10 INFO - /builds/slave/test/build/application/firefox/firefox 12:43:10 INFO - Running post-action listener: _resource_record_post_action 12:43:10 INFO - [mozharness: 2016-08-16 19:43:10.478675Z] Finished install step (success) 12:43:10 INFO - [mozharness: 2016-08-16 19:43:10.478947Z] Running run-tests step. 12:43:10 INFO - Running pre-action listener: _resource_record_pre_action 12:43:10 INFO - Running main action method: run_tests 12:43:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:43:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:43:10 INFO - Python 2.7.3 12:43:10 INFO - Return code: 0 12:43:10 INFO - grabbing minidump binary from tooltool 12:43: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')]} 12:43: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 0x2aea570>, '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 0x2aeb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aeb900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:43: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 12:43: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 12:43: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 12:43:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:43:10 INFO - Return code: 0 12:43:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:43:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:43:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:43:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:43:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:43: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/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 12:43: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/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 12:43:10 INFO - Using env: {'DISPLAY': ':0', 12:43:10 INFO - 'HOME': '/home/cltbld', 12:43:10 INFO - 'LANG': 'en_US.UTF-8', 12:43:10 INFO - 'LANGUAGE': 'en_US:en', 12:43:10 INFO - 'LOGNAME': 'cltbld', 12:43:10 INFO - 'MAIL': '/var/mail/cltbld', 12:43:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:43:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:43:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:10 INFO - 'MOZ_NO_REMOTE': '1', 12:43:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:43:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:10 INFO - 'NO_EM_RESTART': '1', 12:43:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:10 INFO - 'PWD': '/builds/slave/test', 12:43:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:43:10 INFO - 'SHELL': '/bin/bash', 12:43:10 INFO - 'SHLVL': '1', 12:43:10 INFO - 'TERM': 'linux', 12:43:10 INFO - 'TMOUT': '86400', 12:43:10 INFO - 'USER': 'cltbld', 12:43:10 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471375159.372356-354710992', 12:43:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:10 INFO - '_': '/tools/buildbot/bin/python'} 12:43: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/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 12:43:10 INFO - mozversion application_buildid: 20160816111017 12:43:10 INFO - mozversion application_changeset: 26538451d2729e8f2447b35c2d3ee58be0d6a5f4 12:43:10 INFO - mozversion application_display_name: FirefoxDeveloperEdition 12:43:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:43:10 INFO - mozversion application_name: Firefox 12:43:10 INFO - mozversion application_remotingname: firefox-dev 12:43:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:43:10 INFO - mozversion application_vendor: Mozilla 12:43:10 INFO - mozversion application_version: 50.0a2 12:43:10 INFO - mozversion platform_buildid: 20160816111017 12:43:10 INFO - mozversion platform_changeset: 26538451d2729e8f2447b35c2d3ee58be0d6a5f4 12:43:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:43:10 INFO - mozversion platform_version: 50.0a2 12:43:10 INFO - using testdate: 1471376590 12:43:10 INFO - actual date: 1471376590 12:43:10 INFO - starting webserver on 'localhost:40978' 12:43:10 INFO - SUITE-START | Running 2 tests 12:43:10 INFO - TEST-START | dromaeo_css 12:43:10 INFO - operating with platform_type : linux_ 12:43:10 INFO - Initialising browser for dromaeo_css test... 12:43:10 INFO - TEST-INFO | started process 4065 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiWKSjt/profile http://localhost:40978/getInfo.html) 12:43:15 INFO - PROCESS | 4065 | __metrics Screen width/height:1600/1200 12:43:15 INFO - PROCESS | 4065 | colorDepth:24 12:43:15 INFO - PROCESS | 4065 | Browser inner width/height: 1024/697 12:43:15 INFO - PROCESS | 4065 | __metrics 12:43:16 ERROR - PROCESS | 4065 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 12:43:16 INFO - TEST-INFO | 4065: exit 0 12:43:16 INFO - Browser initialized. 12:43:16 INFO - Running cycle 1/1 for dromaeo_css test... 12:43:16 INFO - TEST-INFO | started process 4186 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiWKSjt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:43:28 INFO - PROCESS | 4186 | RSS: Main: 152473600 12:43:28 INFO - PROCESS | 4186 | 12:44:18 INFO - PROCESS | 4186 | 1471376658334 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:46:27 INFO - PROCESS | 4186 | Cycle 1(1): loaded http://localhost:40978/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40978/tests/dromaeo/cssquery-ext.html) 12:46:28 INFO - PROCESS | 4186 | RSS: Main: 157769728 12:46:28 INFO - PROCESS | 4186 | 12:49:30 INFO - PROCESS | 4186 | Cycle 1(1): loaded http://localhost:40978/tests/dromaeo/cssquery-ext.html (next: http://localhost:40978/tests/dromaeo/cssquery-jquery.html) 12:49:30 INFO - PROCESS | 4186 | RSS: Main: 153747456 12:49:30 INFO - PROCESS | 4186 | 12:52:32 INFO - PROCESS | 4186 | Cycle 1(1): loaded http://localhost:40978/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40978/tests/dromaeo/cssquery-mootools.html) 12:52:33 INFO - PROCESS | 4186 | RSS: Main: 154509312 12:52:33 INFO - PROCESS | 4186 | 12:55:35 INFO - PROCESS | 4186 | Cycle 1(1): loaded http://localhost:40978/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40978/tests/dromaeo/cssquery-prototype.html) 12:55:35 INFO - PROCESS | 4186 | RSS: Main: 152440832 12:55:35 INFO - PROCESS | 4186 | 12:58:38 INFO - PROCESS | 4186 | Cycle 1(1): loaded http://localhost:40978/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40978/tests/dromaeo/cssquery-yui.html) 12:58:38 INFO - PROCESS | 4186 | RSS: Main: 155107328 12:58:38 INFO - PROCESS | 4186 | 13:01:41 INFO - PROCESS | 4186 | Cycle 1(1): loaded http://localhost:40978/tests/dromaeo/cssquery-yui.html (next: http://localhost:40978/tests/dromaeo/cssquery-dojo.html) 13:01:41 INFO - PROCESS | 4186 | RSS: Main: 155561984 13:01:41 INFO - PROCESS | 4186 | 13:01:41 INFO - PROCESS | 4186 | __start_tp_report 13:01:41 INFO - PROCESS | 4186 | _x_x_mozilla_page_load 13:01:41 INFO - PROCESS | 4186 | _x_x_mozilla_page_load_details 13:01:41 INFO - PROCESS | 4186 | |i|pagename|runs| 13:01:41 INFO - PROCESS | 4186 | |0;dojo.html;3310.5861767279107;3319.6182439019512;3334.233126380931;3336.2159892425275;3357.1103657530743;5769.076947688371;5804.129380592914;5833.154192642064;5837.854053648661;5840.824775256739;5754.395788442216;5785.710714464281;5799.565032622549;5804.245448091753;5806.419358064202;5233.031889100519;5259.211118332261;5273.8945221095555;5277;5292.708901010443;5133.666311689747;5142.974285128569;5143.974280128594;5234.6859188448625;5266.683998960075;5279.9208011879855;5295.523402893738;5298.708571028592;5300.655457395276;5318.494742999409;5352.090144675414;5362.758675859595;5365.704886231256;5375.569954403638;5382;5036;5102.285680004802;5220.1647736362;5275.920861187085;5338.466153384669;5666.150077488369;5753.597248192628;5766.336871259817;5770.394108618577;5797.710114494258;6139.508839292846;6143.569950103494;6184.752609895599;6189.195404597373;6194.566380353377;6006.189164462785;6108.602940808833;6225.470834979033;6232.065190221458;6233.906491402633;5716.171155182476;5808.448197421239;5817.0692689169955;5840.328362238354;5846.824595262149;6288.339724328971;6298.307186209513;6328;6339.683015849189;6351.904721429182;5872.060470324727;6010.128531362928;6013.729382177812;6067.635941843415;6126.479249263773;6101.176341193882;6232.283287421914;6232.376762323732;6233.065040243909;6244.2819075805955;6145.508359331243;6167.537434692416;6170.043643235305;6193.721282542297;6207.037909124093;5885.234919460443;6104.236970378703;6130.478909292671;6133.110698948627;6191.94736894729;4668.253079507263;4743.976280118577;4745.264484004984;4763.214069678534;4780.330753694486;4183.686223533247;4212.978935105305;4213.747175169499;4232.576742325804;4247.51153617338;5707.857303567444;5864.413558644102;5936.168936348915;5980.940190598125;5998.040313549811;6131.325554189036;6243.500519958392;6267.2479302484;6275.905861412082;6282.057691346243;5961.612495187799;5980.910286345708;5992.191054207713;5992.940070599238;5999.4900433463645;5134.383873935077;5317.707526086025;5362.544183744348;5365.597580181424;5379.811706590251;6412;6528.738850446024;6537.084808126771;6538.280789113289;6547.508936829757;6242.656653883898;6299;6318.052292156213;6321.905171422524;6328.715207815567;6163.075538669056;6278.560500764903;6394.104825324365;6451.258105317761;6467.935320646733;5996.820095397145;6139.43080903429;6165.5375846810775;6174;6175.166352542349;6242.937570624417;6258.687065646608;6261.906071408841;6276.843078923063;6277.529185311211;5940.108983652487;5977.043673012297;6073.514118870391;6095.664738439428;6117.235345581802;5984.611000284967;6118.357572454828;6118.388161183846;6118.938810611837;6136.386361363828;6014.36849130835;6014.909776353271;6020.6989650516425;6024.307204671343;6046.123312119806;5968.522518198447;6064.818055458343;6114.785982490592;6122.571420000557;6131.172291740736;5922.763089476545;6033.18551995475;6044.425779550936;6058.030715085565;6076.422739839708 13:01:41 INFO - PROCESS | 4186 | |1;ext.html;584.7982446056109;586.4721750424617;629.5907660020989;632.3992207402966;662.1094627725711;42100.36849447257;46947.53052469475;47032.58902232934;47223.291650625266;47345.28982065272;47063.76468117663;47948.76025619876;48089;48153.518464815344;48155.27767083496;9068.274538036958;9248.398854074498;9293.814123717522;9294;9332.720018399425;9226.492542910137;9334.859977100348;9366.578503967305;9377.296702747288;9418.340716149873;9410.388324758904;9427.811443771121;9429.669961551346;9439.622415103388;9447.433154010747;9312.068793120701;9390.248780097576;9397.436153830758;9405.811883762355;9425.434473931586;9125.543722813833;9168.220701240403;9245.167934885825;9251.583678734472;9254.352195346328;45449.77275113636;45576.3163552547;45841.77079114583;45892.77053614711;45946.54053459456;3608;3887.844486220548;4036.3945408188715;4072.6741860651077;4387.605115539584;35647.64352356469;35699;35951;37242.4413633793;37472.25055498902;4304;4378.10248898975;4502.662300327455;4522.592966632986;4584.564466375689;369812.9999999973;373495;374292;374473;375567.12216439017;37858.81070594629;62500;62910.685446572475;62950.37049629536;62993.37006629966;38048.239035219696;40439.797801011395;40585.79707101505;40736.38895416571;40821.79589102035;15576;15705.45030923935;15722;15807.209639518209;16183.676326473405;12592.74814503723;12600.4329805159;12677.556285529961;12701.110922235355;12705.17416367933;9095;9211.447313161232;9228.95385523068;9240.445573265626;9264.490453025013;3537.4693795930816;3552.1652411683235;3559.733020023457;3592.6586974237407;3608.909777255537;1099.4777480696605;1118.59730497021;1132.3545579020044;1137.9260348077514;1217.2939694976892;34808;35455.11362215965;35645.28709425797;35786.28427431437;35910.8204458976;1174.94712737927;1207.0946789907568;1234.1422711215619;1262.482382223284;1305.556110922291;18057.71298840963;18257.087145642665;18471;18702.625947480974;18741.062946852602;613588;617315;618852;621548;624025;65697.67151164309;65831.34168658347;66137.33862661407;66230.33769662338;66339.66830165914;1422.2177802208744;1444.6893917807722;1446.0600609603841;1465.201465201489;1469.7427950108902;33152.66847331496;34191.65808341885;34426.139346515534;34543.13642158866;34777;54743.45256547384;54922;54929.077482287925;55339;55576.16635750386;509356;514674;516063;516810;518467;30741.53887691731;30766.53850192204;31820.204494887814;31892.202694932814;31906.840465797522;53091;53438.19842702285;53521.73239133779;54295.72852135714;54443;43989.560104398544;44548.876879158015;44990.325145123505;45716.31425528686;46620.53379466297;47336.28995565138;47381.76309118432;47827.76086119547;47961;48800;45202.321965171206;46094.7695261535;46799.76600116977;47505.762471188806;49482.505174947786;38629.22741545209;39732.801335993136;39926;40836.59163408328;41171;30242.395152097273;31812.5228121583;31840.203994900312;32017.67982320147;32165 13:01:41 INFO - PROCESS | 4186 | |2;jquery.html;410.5012409921944;411.1181515648933;413.86342506972704;429.5446826364054;442.14445048830515;20493.897530512346;20765.857877816714;21063.789362106374;21141.471463213427;21752.564948701016;20639;20750.792492075074;20755.377338679828;20955;21093.894530527363;5908.999999999989;6058.636481811083;6062.181605483247;6075.997460419026;6122.877542449149;6003.699815009254;6027.276726792791;6044.66754328514;6047.092936059605;6051.546134039942;5833.533317334603;5918.763249470016;5956.374580669032;5963.701814909259;6003.6697981611;5820.476157145835;5845.85385365365;5846.532277417818;5866.76532938682;5917.289925208981;5334.333208348957;5343.412224655285;5363.329583802025;5365.839024829262;5378.946210537883;24699;24837;24904.626430603555;25115.62326565103;25385.238442846745;2576.2013775729397;2727;2769.8338099714083;2901.086157860267;3275.901722948315;15540.06759594428;15732.842671573253;15735;15762;16148.59628509285;2069.6590363057358;2076.3459510254374;2116.2593092417683;2145.6996020557135;2190.288156349193;81393.18606813916;83248;84039;94265;94847;11331.43342832855;11858.703532411586;12010;12078.456469458895;12320.938395307967;16930.746038809426;16933.15334233308;16947.830521694872;16961.15194240283;16982.150892455575;8265.586720663943;8291.626876790559;8485.40602157843;8623.611937462829;8632.093630168742;8054.959725201454;8081.717139900075;8087.757367278991;8191.631376588068;8275.83448331042;4732.0772449372735;4930.704157750546;5122.282880396748;5149.120570991561;5178.456262092502;2084.1871670048695;2116.9470763231043;2174.3476956913178;2192.134107027747;2215.711957445522;1010.2322235101376;1034.3018462537907;1088.8911108889047;1100.9009189173014;1116.2855772305732;20459.59080818405;20808.791912080684;21105;21184.894075529523;21302.147914083573;1004.8090862736057;1023.6263763726187;1049.5644307612256;1055.6674647486018;1066.919981001428;11191.720206994727;11689;11843.526258949718;11874.406279685982;11881.287122772488;165743.1712841428;211096;515315;516676;525369;75480;88105;97366.53950190752;99356.50321748345;100139;1012.579779391559;1031.1544533482622;1034.2450011491503;1048.6801525534634;1050.4485145298627;17617.295308187528;18542.258309668003;18585.53536161607;18708.345207917657;18807.341743038927;31144.688553114178;36684.633153668125;44655.10689786251;46749.29876051794;47056.52943470521;65297.673511632136;65571.37714491367;66370.66814665895;66860.6656966712;67279;7773.18381569927;7936;8180.386471014816;8534.402591818762;8871.334649901155;10092.444915529717;13093.934530327668;13568.660783480493;13654.385552650354;13797.379117939918;11817;12097.939510302393;12221.938890305491;12258.141930065167;12366.814497782361;10336.0697537222;10816.729581760204;11332.660020199408;11406.714832129263;11412.71468213268;9662.371945823781;11452.541898323974;11518.424078796193;11581.478833452684;11969.401529923294;7339.706411743684;7383.741569045058;7413.9258607415395;7470.4770666052855;7669.578173200527;7932.762017139495;9264.95367523185;9497.43015419077;9524.904750952403;11196.328220306808 13:01:41 INFO - PROCESS | 4186 | |3;mootools.html;1541.2910061371772;1579.81042274927;1732.1685590916359;1874.3439796071386;1878.0891267735155;8293.460925039868;8854.380193386458;9572.6649567265;9614.855777163348;9692.903070969298;9660.468674222915;9710.465924374157;9756.512174391288;9758.512074396269;9773.26700497462;2468.4816188600416;2496.8377055491424;2505.8496490210646;2507.059852555292;2522.1676846640567;2431.3192306154306;2505.4112283613335;2521.9117330893423;2525.1162093267303;2529.152733834168;2475.4801491686676;2493.0152589727045;2509.8619575923317;2519.735427780084;2524.2805800346905;2422.8061755059553;2429.6112621980487;2440.8779561021965;2445.3764290106087;2462.212092130519;2402.1592442644933;2408.506256217471;2413.9034438622434;2420.4674971506242;2428.7449817769057;9757.853632195523;9870.506474676238;9938.15525680318;9943.75140621483;9979.80040399188;5552.250446189753;5767.913481297784;5793.188953546507;5796.275465566804;5799;3376.3247350529746;3468.9306213875834;3515.9472607910648;3521.366154092262;3587.0852932502044;1059.8887116852698;1100.2298391126244;1122.2032357026521;1131.0555686002199;1145.455908443491;13956.092853964561;13980.72038559223;13986.16083035011;14010.019298649098;14060.08609440383;4900.289458028566;4908.730019848943;4911.582515486224;4984.327115839388;5079.87300317495;11642.825357619642;11696.415179241174;11713.765724685458;11755.529778808752;11757.176997610086;5694.658320500783;5698.088305871041;5718.428157184248;5732.226149469851;5736.799212027559;4552.6813123081065;5109.259157422153;5324.04167249891;5324.148136298174;5325.547328477045;4376.059147283349;4433.911321773547;4441.977790111029;4492.932606010912;4495.955040449619;1343.563341913882;1368.185929372022;1392.192528333564;1394.7907813827803;1405.6415614018565;997.9950100249597;1033.3748082410184;1059.777446736194;1070.1866581398194;1095.0856035210688;6505.934940650627;6524.836879077966;6756.932430675729;6798.76204332846;6838.316168383122;502.08369725250833;502.7285265956416;509.9923501147486;520.6537652461146;523.2543625333884;4562.612177964844;4665.346851440801;4713.552212539803;4715.24556071027;4764.571188592974;11945.70135746596;12264.509419623115;12311;12356.25862448256;12391.070669699808;11485.885141148481;12099.213551119148;12124.272543647234;12133.272003679807;12242.204256723284;9000.684976025808;9075.773105672279;9163.450192988443;9224.262059035262;9231.676891308773;6495.382938620824;6495.870082598227;6746.460283177236;6837.555558888656;6902.792916212522;10768.892311076788;11170;11278.774424511628;11338.14963877729;11437.199396042197;11450.37022963745;11505.597304094317;11543.076553875837;11567.710807229887;11654.825177622173;7817.296443320129;8363.790905227175;8645.221930026328;8716.869246961174;8920;9554.378965367228;9589.808203836024;9633.807323853624;9661.323707340418;9674.85487717699;8290.917090829014;8363.874541881998;8364.66541338364;8453.36599755033;8633.784155396166;8335.374846886387;8413.200745929127;8431.620577073923;8448.239658430524;8483.406161568631;7740.26467485588;7795.883061753965;7832.490888092256;7886.171951944963;7899.407544434075;5397.325334333208;5421.891562168814;5467.125259958388;5488.1493368527945;5538.861528461821;5715.2855893013375;5758.769649213985;5867.647941123546;5874.618149820248;5964.9105263420215 13:01:41 INFO - PROCESS | 4186 | |4;prototype.html;347.4510273767448;349.14633720553246;353.8973697627689;363.0651073485775;368.77504722119517;5594.866874550245;5769.221155144054;5850.3564607893095;5908.379620139888;5961.433663801938;5735.541156707463;5778.122110314143;5778.508826749731;5778.942210577893;5811.331696854863;4528.637708983273;4531.592156705896;4535.591796738293;4554.134714404253;4576.954230457703;4425.424694789689;4472.642188624918;4507.4365704286965;4523.575073851743;4566.360709500673;4481.3726078349055;4487.9551204488025;4489.451139356916;4500.887477813065;4521.276595744682;4523.208438523246;4525.456945166568;4540.364348991144;4542.591166794988;4549.636029117696;3828;3932.5674175840636;3950.4469374287623;3953.2686453006286;3983.24318379507;5629.746661400247;5630.943690563124;5637.8590535236535;5667.914981275284;5690;5107.489251074863;5167.3282473278605;5213.6089793265655;5225.712585807779;5234.842954711365;6028.728707208186;6062.96968515159;6069.787557435468;6073.4533891949495;6089.451949324582;4334.501532323791;4398.076403955173;4400.801963911632;4409.603135717801;4415.785658943816;6074.665893375863;6203.41067598582;6353.269374021954;6425;6445.355464453564;4233.703640745119;4301.591348821857;4323.524412314643;4358.106588149421;4371.846985355497;4398.73607583546;4403.757793321398;4443.555644435595;4449.621782148553;4459.9331010034875;5012.674176178537;5122.871928201825;5137.17805151174;5153.484651534892;5170.844874653766;5911.674857882772;6137.877242455215;6147.2480343102;6159.3224745277985;6184.165137706442;1550.2636247782214;1567.91376474295;1572.4968010236614;1576.7871337369538;1581.7152912475865;968.6077138758814;986.5363279258737;1004.2167109654481;1004.598160735697;1018.9643362482277;5267.578593712494;5281.313429254173;5296.629235953446;5365.54392876602;5366.91949620756;5549.556035517149;5601.243832082617;5611.6071874969175;5615.747291371898;5688.573356998241;4947.604191664658;5184.48155184486;5288.92066619001;5297.258383826267;5382.30030096085;2983.568391760708;2993.3265015371803;3023.2744141405906;3038.3315670552442;3045.573619693245;5719.399463056319;5787.803842214361;5790.652560846363;5808.738606762706;5866.472017518444;6052.636841789506;6466.838329041811;6487.2539657939;6550.508711846631;6559.770408035696;6568.540202185801;6577.934220657732;6599.637019963852;6602;6685.866282674417;6201.3178550358525;6343.619382837044;6387.808365749035;6396.680165991775;6412.583182093149;6287.74849006053;6343.619382837044;6345.7144428499905;6361.586496877688;6376.4580010697755;6299.937000629935;6529.804105876831;6544.705488252945;6650.235222949229;6679.76620818269;4442;4488.169688607618;4493.236149854467;4532.161550113239;4552.567506086916;6162.969185154046;6199.628022318675;6513.576617519846;6530.88974874263;6553.901691474727;6182.783602573888;6186.906546726636;6213.5339849512375;6216.264843468859;6253.749850005949;6158.784442544668;6210.285817131088;6232.158658581034;6278.560500765086;6337.9366206337345;6150.50795936333;6181.84545386369;6183.81448556544;6203.875922481616;6268.2478102626155;6291.811245662454;6326.671399006076;6332.733453309264;6369.554131210771;6375.362463753773;5886.882262354643;6080.270367555921;6081.179040829431;6100.908486372619;6140.17107690456 13:01:41 INFO - PROCESS | 4186 | |5;yui.html;808.8099296665283;834.4159088637955;847.7499137754362;870.3298460185657;951.4243882451121;16794.580135496617;16883.493495195147;17635.20641571129;17635.470935871945;18236.726449103273;17968.820311796877;18127.81872181278;18140.455786326398;18301.725474117866;18333.724994125067;891.9999999999984;916.1022198245723;918.5820451694497;919.1635611593451;920.779013036873;861.995690021549;882.1531329923281;882.2412725056446;905.1129892705153;907.1427501011547;954.5561313988994;955.7515046087998;957.9856302155439;960.3757557587554;961.5961296255555;951.4481600671594;952.4951775558931;955.1022039283121;956.1251454918742;957.2246480350938;698.068079114383;701.0745815523511;704.126882665491;704.9883417296196;706.8409607838247;17083;17099;17129.91435042829;17171.399001034904;17188.398406055854;15186.316615752317;15382.311240689325;15828.013237430268;16689.24898379564;16815.0751708656;13330.733385332336;13714.451421943111;13853;13906.93046534771;13987.090839095528;4199.4330765346895;4242.66058715302;4260.573942605745;4304.870853874389;4344.956550434518;86021.56989215076;86877;88149;89821.55089224578;90123;12323.630291091282;12461.439235234437;12494.312812795384;12499.687507812196;12649.114561980574;23482.76517234806;23534.7646523536;23560.175393861133;23744.40638984039;24595.262142135765;9208.493532855624;9427.764305892408;9449.43303401798;9453.76365590852;9746.171575416027;5196.896062078813;5223.190405487156;5249.107651699221;5318.414974352818;5374.946250537523;3960.6039396060164;4069.8372065117655;4086.7752273625238;4089;4098.2418252622765;675.4933799650262;688.6074937285799;693.5907814389534;697.8255436140964;723.4935545118439;821.1706176761514;826.4751882554501;830.2901019628131;836.7196989008751;855.6748435594434;10353.585856565653;10849;10860.728481788019;11114.499847506882;11192.216544841784;695.3567949646557;728.5992704012772;772.9719473100763;800.4956877167348;826.7478419082238;4924.857686906135;5376.489233522809;5422.810201643002;5472.945270547323;5489.64317319373;127046;131106;132497;134261;138156;110515;113819.43090284661;113846;114216;114870.4256478729;80871;81921.59039204766;100124.49937750265;100290.49854750825;100582.49708751556;10322.48387580633;10513.264071514921;10662.306950048222;11079.667609971713;11514.884851151717;55676.443235568746;56190;56508;56768.43231567631;57409.71295143497;80127.19872801431;80538.59730701309;80761.59619201867;82459;83260;14314.355853986805;14752.262386880828;14799.260036998323;14900.18049007315;15095.39618415295;15416.383344666088;15600.453984110502;16210.27053782559;16399.590010249838;16575.668486630442;13905.791413129013;13912.860871391562;14097.436102556194;15340.616484587974;15407.922960385127;13669.179849209078;13875;14230;15117.697646047238;15367.615809604402;14129.152250864981;14688.853111469176;15550;15609.141497217763;16128.838711612734;12012.75974480488;13049.673758156123;13050.15174013686;13189.80215296752;13276.800847987095;12190.817137743119;12671.159419566788;13133.737325253633;13423.530176443777;13547.119437236548 13:01:41 INFO - PROCESS | 4186 | __end_tp_report 13:01:41 INFO - PROCESS | 4186 | __start_cc_report 13:01:41 INFO - PROCESS | 4186 | _x_x_mozilla_cycle_collect,337 13:01:41 INFO - PROCESS | 4186 | __end_cc_report 13:01:41 INFO - PROCESS | 4186 | __startTimestamp1471377701500__endTimestamp 13:01:41 INFO - PROCESS | 4186 | 13:01:41 INFO - PROCESS | 4186 | ------- Summary: start ------- 13:01:41 INFO - PROCESS | 4186 | Number of tests: 6 13:01:41 INFO - PROCESS | 4186 | 13:01:41 INFO - PROCESS | 4186 | [#0] dojo.html Cycles:165 Average:5762.82 Median:5999.49 stddev:663.17 (11.1%) stddev-sans-first:636.69 13:01:41 INFO - PROCESS | 4186 | Values: 3310.6 3319.6 3334.2 3336.2 3357.1 5769.1 5804.1 5833.2 5837.9 5840.8 5754.4 5785.7 5799.6 5804.2 5806.4 5233.0 5259.2 5273.9 5277.0 5292.7 5133.7 5143.0 5144.0 5234.7 5266.7 5279.9 5295.5 5298.7 5300.7 5318.5 5352.1 5362.8 5365.7 5375.6 5382.0 5036.0 5102.3 5220.2 5275.9 5338.5 5666.2 5753.6 5766.3 5770.4 5797.7 6139.5 6143.6 6184.8 6189.2 6194.6 6006.2 6108.6 6225.5 6232.1 6233.9 5716.2 5808.4 5817.1 5840.3 5846.8 6288.3 6298.3 6328.0 6339.7 6351.9 5872.1 6010.1 6013.7 6067.6 6126.5 6101.2 6232.3 6232.4 6233.1 6244.3 6145.5 6167.5 6170.0 6193.7 6207.0 5885.2 6104.2 6130.5 6133.1 6191.9 4668.3 4744.0 4745.3 4763.2 4780.3 4183.7 4213.0 4213.7 4232.6 4247.5 5707.9 5864.4 5936.2 5980.9 5998.0 6131.3 6243.5 6267.2 6275.9 6282.1 5961.6 5980.9 5992.2 5992.9 5999.5 5134.4 5317.7 5362.5 5365.6 5379.8 6412.0 6528.7 6537.1 6538.3 6547.5 6242.7 6299.0 6318.1 6321.9 6328.7 6163.1 6278.6 6394.1 6451.3 6467.9 5996.8 6139.4 6165.5 6174.0 6175.2 6242.9 6258.7 6261.9 6276.8 6277.5 5940.1 5977.0 6073.5 6095.7 6117.2 5984.6 6118.4 6118.4 6118.9 6136.4 6014.4 6014.9 6020.7 6024.3 6046.1 5968.5 6064.8 6114.8 6122.6 6131.2 5922.8 6033.2 6044.4 6058.0 6076.4 13:01:41 INFO - PROCESS | 4186 | 13:01:41 INFO - PROCESS | 4186 | [#1] ext.html Cycles:180 Average:66355.30 Median:45513.04 stddev:136462.49 (299.8%) stddev-sans-first:136755.96 13:01:41 INFO - PROCESS | 4186 | Values: 584.8 586.5 629.6 632.4 662.1 42100.4 46947.5 47032.6 47223.3 47345.3 47063.8 47948.8 48089.0 48153.5 48155.3 9068.3 9248.4 9293.8 9294.0 9332.7 9226.5 9334.9 9366.6 9377.3 9418.3 9410.4 9427.8 9429.7 9439.6 9447.4 9312.1 9390.2 9397.4 9405.8 9425.4 9125.5 9168.2 9245.2 9251.6 9254.4 45449.8 45576.3 45841.8 45892.8 45946.5 3608.0 3887.8 4036.4 4072.7 4387.6 35647.6 35699.0 35951.0 37242.4 37472.3 4304.0 4378.1 4502.7 4522.6 4584.6 369813.0 373495.0 374292.0 374473.0 375567.1 37858.8 62500.0 62910.7 62950.4 62993.4 38048.2 40439.8 40585.8 40736.4 40821.8 15576.0 15705.5 15722.0 15807.2 16183.7 12592.7 12600.4 12677.6 12701.1 12705.2 9095.0 9211.4 9229.0 9240.4 9264.5 3537.5 3552.2 3559.7 3592.7 3608.9 1099.5 1118.6 1132.4 1137.9 1217.3 34808.0 35455.1 35645.3 35786.3 35910.8 1174.9 1207.1 1234.1 1262.5 1305.6 18057.7 18257.1 18471.0 18702.6 18741.1 613588.0 617315.0 618852.0 621548.0 624025.0 65697.7 65831.3 66137.3 66230.3 66339.7 1422.2 1444.7 1446.1 1465.2 1469.7 33152.7 34191.7 34426.1 34543.1 34777.0 54743.5 54922.0 54929.1 55339.0 55576.2 509356.0 514674.0 516063.0 516810.0 518467.0 30741.5 30766.5 31820.2 31892.2 31906.8 53091.0 53438.2 53521.7 54295.7 54443.0 43989.6 44548.9 44990.3 45716.3 46620.5 47336.3 47381.8 47827.8 47961.0 48800.0 45202.3 46094.8 46799.8 47505.8 49482.5 38629.2 39732.8 39926.0 40836.6 41171.0 30242.4 31812.5 31840.2 32017.7 32165.0 13:01:41 INFO - PROCESS | 4186 | 13:01:41 INFO - PROCESS | 4186 | [#2] jquery.html Cycles:180 Average:26963.97 Median:25010.12 stddev:70229.18 (280.8%) stddev-sans-first:70397.89 13:01:41 INFO - PROCESS | 4186 | Values: 410.5 411.1 413.9 429.5 442.1 20493.9 20765.9 21063.8 21141.5 21752.6 20639.0 20750.8 20755.4 20955.0 21093.9 5909.0 6058.6 6062.2 6076.0 6122.9 6003.7 6027.3 6044.7 6047.1 6051.5 5833.5 5918.8 5956.4 5963.7 6003.7 5820.5 5845.9 5846.5 5866.8 5917.3 5334.3 5343.4 5363.3 5365.8 5378.9 24699.0 24837.0 24904.6 25115.6 25385.2 2576.2 2727.0 2769.8 2901.1 3275.9 15540.1 15732.8 15735.0 15762.0 16148.6 2069.7 2076.3 2116.3 2145.7 2190.3 81393.2 83248.0 84039.0 94265.0 94847.0 11331.4 11858.7 12010.0 12078.5 12320.9 16930.7 16933.2 16947.8 16961.2 16982.2 8265.6 8291.6 8485.4 8623.6 8632.1 8055.0 8081.7 8087.8 8191.6 8275.8 4732.1 4930.7 5122.3 5149.1 5178.5 2084.2 2116.9 2174.3 2192.1 2215.7 1010.2 1034.3 1088.9 1100.9 1116.3 20459.6 20808.8 21105.0 21184.9 21302.1 1004.8 1023.6 1049.6 1055.7 1066.9 11191.7 11689.0 11843.5 11874.4 11881.3 165743.2 211096.0 515315.0 516676.0 525369.0 75480.0 88105.0 97366.5 99356.5 100139.0 1012.6 1031.2 1034.2 1048.7 1050.4 17617.3 18542.3 18585.5 18708.3 18807.3 31144.7 36684.6 44655.1 46749.3 47056.5 65297.7 65571.4 66370.7 66860.7 67279.0 7773.2 7936.0 8180.4 8534.4 8871.3 10092.4 13093.9 13568.7 13654.4 13797.4 11817.0 12097.9 12221.9 12258.1 12366.8 10336.1 10816.7 11332.7 11406.7 11412.7 9662.4 11452.5 11518.4 11581.5 11969.4 7339.7 7383.7 7413.9 7470.5 7669.6 7932.8 9265.0 9497.4 9524.9 11196.3 13:01:41 INFO - PROCESS | 4186 | 13:01:41 INFO - PROCESS | 4186 | [#3] mootools.html Cycles:180 Average:6402.13 Median:4904.51 stddev:3746.32 (76.4%) stddev-sans-first:3739.02 13:01:41 INFO - PROCESS | 4186 | Values: 1541.3 1579.8 1732.2 1874.3 1878.1 8293.5 8854.4 9572.7 9614.9 9692.9 9660.5 9710.5 9756.5 9758.5 9773.3 2468.5 2496.8 2505.8 2507.1 2522.2 2431.3 2505.4 2521.9 2525.1 2529.2 2475.5 2493.0 2509.9 2519.7 2524.3 2422.8 2429.6 2440.9 2445.4 2462.2 2402.2 2408.5 2413.9 2420.5 2428.7 9757.9 9870.5 9938.2 9943.8 9979.8 5552.3 5767.9 5793.2 5796.3 5799.0 3376.3 3468.9 3515.9 3521.4 3587.1 1059.9 1100.2 1122.2 1131.1 1145.5 13956.1 13980.7 13986.2 14010.0 14060.1 4900.3 4908.7 4911.6 4984.3 5079.9 11642.8 11696.4 11713.8 11755.5 11757.2 5694.7 5698.1 5718.4 5732.2 5736.8 4552.7 5109.3 5324.0 5324.1 5325.5 4376.1 4433.9 4442.0 4492.9 4496.0 1343.6 1368.2 1392.2 1394.8 1405.6 998.0 1033.4 1059.8 1070.2 1095.1 6505.9 6524.8 6756.9 6798.8 6838.3 502.1 502.7 510.0 520.7 523.3 4562.6 4665.3 4713.6 4715.2 4764.6 11945.7 12264.5 12311.0 12356.3 12391.1 11485.9 12099.2 12124.3 12133.3 12242.2 9000.7 9075.8 9163.5 9224.3 9231.7 6495.4 6495.9 6746.5 6837.6 6902.8 10768.9 11170.0 11278.8 11338.1 11437.2 11450.4 11505.6 11543.1 11567.7 11654.8 7817.3 8363.8 8645.2 8716.9 8920.0 9554.4 9589.8 9633.8 9661.3 9674.9 8290.9 8363.9 8364.7 8453.4 8633.8 8335.4 8413.2 8431.6 8448.2 8483.4 7740.3 7795.9 7832.5 7886.2 7899.4 5397.3 5421.9 5467.1 5488.1 5538.9 5715.3 5758.8 5867.6 5874.6 5964.9 13:01:41 INFO - PROCESS | 4186 | 13:01:41 INFO - PROCESS | 4186 | [#4] prototype.html Cycles:180 Average:5090.63 Median:5652.89 stddev:1527.47 (27.0%) stddev-sans-first:1489.69 13:01:41 INFO - PROCESS | 4186 | Values: 347.5 349.1 353.9 363.1 368.8 5594.9 5769.2 5850.4 5908.4 5961.4 5735.5 5778.1 5778.5 5778.9 5811.3 4528.6 4531.6 4535.6 4554.1 4577.0 4425.4 4472.6 4507.4 4523.6 4566.4 4481.4 4488.0 4489.5 4500.9 4521.3 4523.2 4525.5 4540.4 4542.6 4549.6 3828.0 3932.6 3950.4 3953.3 3983.2 5629.7 5630.9 5637.9 5667.9 5690.0 5107.5 5167.3 5213.6 5225.7 5234.8 6028.7 6063.0 6069.8 6073.5 6089.5 4334.5 4398.1 4400.8 4409.6 4415.8 6074.7 6203.4 6353.3 6425.0 6445.4 4233.7 4301.6 4323.5 4358.1 4371.8 4398.7 4403.8 4443.6 4449.6 4459.9 5012.7 5122.9 5137.2 5153.5 5170.8 5911.7 6137.9 6147.2 6159.3 6184.2 1550.3 1567.9 1572.5 1576.8 1581.7 968.6 986.5 1004.2 1004.6 1019.0 5267.6 5281.3 5296.6 5365.5 5366.9 5549.6 5601.2 5611.6 5615.7 5688.6 4947.6 5184.5 5288.9 5297.3 5382.3 2983.6 2993.3 3023.3 3038.3 3045.6 5719.4 5787.8 5790.7 5808.7 5866.5 6052.6 6466.8 6487.3 6550.5 6559.8 6568.5 6577.9 6599.6 6602.0 6685.9 6201.3 6343.6 6387.8 6396.7 6412.6 6287.7 6343.6 6345.7 6361.6 6376.5 6299.9 6529.8 6544.7 6650.2 6679.8 4442.0 4488.2 4493.2 4532.2 4552.6 6163.0 6199.6 6513.6 6530.9 6553.9 6182.8 6186.9 6213.5 6216.3 6253.7 6158.8 6210.3 6232.2 6278.6 6337.9 6150.5 6181.8 6183.8 6203.9 6268.2 6291.8 6326.7 6332.7 6369.6 6375.4 5886.9 6080.3 6081.2 6100.9 6140.2 13:01:41 INFO - PROCESS | 4186 | 13:01:41 INFO - PROCESS | 4186 | [#5] yui.html Cycles:180 Average:23397.48 Median:23652.29 stddev:33860.62 (143.2%) stddev-sans-first:33913.13 13:01:41 INFO - PROCESS | 4186 | Values: 808.8 834.4 847.7 870.3 951.4 16794.6 16883.5 17635.2 17635.5 18236.7 17968.8 18127.8 18140.5 18301.7 18333.7 892.0 916.1 918.6 919.2 920.8 862.0 882.2 882.2 905.1 907.1 954.6 955.8 958.0 960.4 961.6 951.4 952.5 955.1 956.1 957.2 698.1 701.1 704.1 705.0 706.8 17083.0 17099.0 17129.9 17171.4 17188.4 15186.3 15382.3 15828.0 16689.2 16815.1 13330.7 13714.5 13853.0 13906.9 13987.1 4199.4 4242.7 4260.6 4304.9 4345.0 86021.6 86877.0 88149.0 89821.6 90123.0 12323.6 12461.4 12494.3 12499.7 12649.1 23482.8 23534.8 23560.2 23744.4 24595.3 9208.5 9427.8 9449.4 9453.8 9746.2 5196.9 5223.2 5249.1 5318.4 5374.9 3960.6 4069.8 4086.8 4089.0 4098.2 675.5 688.6 693.6 697.8 723.5 821.2 826.5 830.3 836.7 855.7 10353.6 10849.0 10860.7 11114.5 11192.2 695.4 728.6 773.0 800.5 826.7 4924.9 5376.5 5422.8 5472.9 5489.6 127046.0 131106.0 132497.0 134261.0 138156.0 110515.0 113819.4 113846.0 114216.0 114870.4 80871.0 81921.6 100124.5 100290.5 100582.5 10322.5 10513.3 10662.3 11079.7 11514.9 55676.4 56190.0 56508.0 56768.4 57409.7 80127.2 80538.6 80761.6 82459.0 83260.0 14314.4 14752.3 14799.3 14900.2 15095.4 15416.4 15600.5 16210.3 16399.6 16575.7 13905.8 13912.9 14097.4 15340.6 15407.9 13669.2 13875.0 14230.0 15117.7 15367.6 14129.2 14688.9 15550.0 15609.1 16128.8 12012.8 13049.7 13050.2 13189.8 13276.8 12190.8 12671.2 13133.7 13423.5 13547.1 13:01:41 INFO - PROCESS | 4186 | -------- Summary: end -------- 13:01:41 INFO - PROCESS | 4186 | 13:01:42 INFO - TEST-INFO | 4186: exit 0 13:01:42 INFO - TEST-OK | dromaeo_css | took 1111467ms 13:01:42 INFO - TEST-START | kraken 13:01:42 INFO - operating with platform_type : linux_ 13:01:42 INFO - Initialising browser for kraken test... 13:01:42 INFO - TEST-INFO | started process 4448 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_JKakI/profile http://localhost:40978/getInfo.html) 13:01:46 INFO - PROCESS | 4448 | __metrics Screen width/height:1600/1200 13:01:46 INFO - PROCESS | 4448 | colorDepth:24 13:01:46 INFO - PROCESS | 4448 | Browser inner width/height: 1024/697 13:01:46 INFO - PROCESS | 4448 | __metrics 13:01:47 ERROR - PROCESS | 4448 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 13:01:48 INFO - TEST-INFO | 4448: exit 0 13:01:48 INFO - Browser initialized. 13:01:48 INFO - Running cycle 1/1 for kraken test... 13:01:48 INFO - TEST-INFO | started process 4572 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_JKakI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:02:00 INFO - PROCESS | 4572 | RSS: Main: 152592384 13:02:00 INFO - PROCESS | 4572 | 13:02:02 INFO - PROCESS | 4572 | Cycle 1(1): loaded http://localhost:40978/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40978/tests/kraken/driver.html?testName=audio-beat-detection) 13:02:03 INFO - PROCESS | 4572 | RSS: Main: 157786112 13:02:03 INFO - PROCESS | 4572 | 13:02:05 INFO - PROCESS | 4572 | Cycle 1(1): loaded http://localhost:40978/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40978/tests/kraken/driver.html?testName=audio-dft) 13:02:06 INFO - PROCESS | 4572 | RSS: Main: 156286976 13:02:06 INFO - PROCESS | 4572 | 13:02:09 INFO - PROCESS | 4572 | Cycle 1(1): loaded http://localhost:40978/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40978/tests/kraken/driver.html?testName=audio-fft) 13:02:10 INFO - PROCESS | 4572 | RSS: Main: 156905472 13:02:10 INFO - PROCESS | 4572 | 13:02:12 INFO - PROCESS | 4572 | Cycle 1(1): loaded http://localhost:40978/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40978/tests/kraken/driver.html?testName=audio-oscillator) 13:02:12 INFO - PROCESS | 4572 | RSS: Main: 156659712 13:02:12 INFO - PROCESS | 4572 | 13:02:14 INFO - PROCESS | 4572 | Cycle 1(1): loaded http://localhost:40978/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40978/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:02:15 INFO - PROCESS | 4572 | RSS: Main: 156528640 13:02:15 INFO - PROCESS | 4572 | 13:02:18 INFO - PROCESS | 4572 | Cycle 1(1): loaded http://localhost:40978/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40978/tests/kraken/driver.html?testName=imaging-darkroom) 13:02:19 INFO - PROCESS | 4572 | RSS: Main: 156119040 13:02:19 INFO - PROCESS | 4572 | 13:02:22 INFO - PROCESS | 4572 | Cycle 1(1): loaded http://localhost:40978/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40978/tests/kraken/driver.html?testName=imaging-desaturate) 13:02:23 INFO - PROCESS | 4572 | RSS: Main: 155234304 13:02:23 INFO - PROCESS | 4572 | 13:02:26 INFO - PROCESS | 4572 | Cycle 1(1): loaded http://localhost:40978/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40978/tests/kraken/driver.html?testName=json-parse-financial) 13:02:26 INFO - PROCESS | 4572 | RSS: Main: 156368896 13:02:26 INFO - PROCESS | 4572 | 13:02:28 INFO - PROCESS | 4572 | Cycle 1(1): loaded http://localhost:40978/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40978/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:02:28 INFO - PROCESS | 4572 | RSS: Main: 156639232 13:02:28 INFO - PROCESS | 4572 | 13:02:30 INFO - PROCESS | 4572 | Cycle 1(1): loaded http://localhost:40978/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40978/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:02:31 INFO - PROCESS | 4572 | RSS: Main: 156594176 13:02:31 INFO - PROCESS | 4572 | 13:02:33 INFO - PROCESS | 4572 | Cycle 1(1): loaded http://localhost:40978/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40978/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:02:34 INFO - PROCESS | 4572 | RSS: Main: 157106176 13:02:34 INFO - PROCESS | 4572 | 13:02:36 INFO - PROCESS | 4572 | Cycle 1(1): loaded http://localhost:40978/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40978/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:02:37 INFO - PROCESS | 4572 | RSS: Main: 157609984 13:02:37 INFO - PROCESS | 4572 | 13:02:39 INFO - PROCESS | 4572 | Cycle 1(1): loaded http://localhost:40978/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40978/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:02:40 INFO - PROCESS | 4572 | RSS: Main: 157478912 13:02:40 INFO - PROCESS | 4572 | 13:02:42 INFO - PROCESS | 4572 | Cycle 1(1): loaded http://localhost:40978/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40978/tests/kraken/driver.html?testName=ai-astar) 13:02:42 INFO - PROCESS | 4572 | RSS: Main: 158457856 13:02:42 INFO - PROCESS | 4572 | 13:02:42 INFO - PROCESS | 4572 | __start_tp_report 13:02:42 INFO - PROCESS | 4572 | _x_x_mozilla_page_load 13:02:42 INFO - PROCESS | 4572 | _x_x_mozilla_page_load_details 13:02:42 INFO - PROCESS | 4572 | |i|pagename|runs| 13:02:42 INFO - PROCESS | 4572 | |0;ai-astar;100;113;106;111;111;111;111;111;111;112 13:02:42 INFO - PROCESS | 4572 | |1;audio-beat-detection;146;116;146;164;121;147;141;118;178;116 13:02:42 INFO - PROCESS | 4572 | |2;audio-dft;166;162;163;161;162;162;161;162;165;161 13:02:42 INFO - PROCESS | 4572 | |3;audio-fft;75;75;77;170;76;74;75;76;174;75 13:02:42 INFO - PROCESS | 4572 | |4;audio-oscillator;84;83;143;84;83;85;142;84;84;144 13:02:42 INFO - PROCESS | 4572 | |5;imaging-gaussian-blur;119;117;118;118;117;118;117;117;117;118 13:02:42 INFO - PROCESS | 4572 | |6;imaging-darkroom;148;148;149;147;147;146;156;147;148;146 13:02:42 INFO - PROCESS | 4572 | |7;imaging-desaturate;95;95;97;95;95;95;96;96;95;95 13:02:42 INFO - PROCESS | 4572 | |8;json-parse-financial;56;51;55;53;52;51;51;52;53;51 13:02:42 INFO - PROCESS | 4572 | |9;json-stringify-tinderbox;59;61;61;61;61;60;60;60;59;61 13:02:42 INFO - PROCESS | 4572 | |10;stanford-crypto-aes;73;76;81;74;80;74;73;73;77;72 13:02:42 INFO - PROCESS | 4572 | |11;stanford-crypto-ccm;122;131;131;121;121;120;127;120;149;135 13:02:42 INFO - PROCESS | 4572 | |12;stanford-crypto-pbkdf2;150;150;153;150;153;152;148;149;153;154 13:02:42 INFO - PROCESS | 4572 | |13;stanford-crypto-sha256-iterative;64;63;63;63;65;65;63;71;62;62 13:02:42 INFO - PROCESS | 4572 | __end_tp_report 13:02:42 INFO - PROCESS | 4572 | __start_cc_report 13:02:42 INFO - PROCESS | 4572 | _x_x_mozilla_cycle_collect,861 13:02:42 INFO - PROCESS | 4572 | __end_cc_report 13:02:42 INFO - PROCESS | 4572 | __startTimestamp1471377762417__endTimestamp 13:02:42 INFO - PROCESS | 4572 | 13:02:42 INFO - PROCESS | 4572 | ------- Summary: start ------- 13:02:42 INFO - PROCESS | 4572 | Number of tests: 14 13:02:42 INFO - PROCESS | 4572 | 13:02:42 INFO - PROCESS | 4572 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:3.86 (3.5%) stddev-sans-first:1.92 13:02:42 INFO - PROCESS | 4572 | Values: 100.0 113.0 106.0 111.0 111.0 111.0 111.0 111.0 111.0 112.0 13:02:42 INFO - PROCESS | 4572 | 13:02:42 INFO - PROCESS | 4572 | [#1] audio-beat-detection Cycles:10 Average:139.30 Median:146.00 stddev:21.43 (14.7%) stddev-sans-first:22.59 13:02:42 INFO - PROCESS | 4572 | Values: 146.0 116.0 146.0 164.0 121.0 147.0 141.0 118.0 178.0 116.0 13:02:42 INFO - PROCESS | 4572 | 13:02:42 INFO - PROCESS | 4572 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.00 stddev:1.72 (1.1%) stddev-sans-first:1.27 13:02:42 INFO - PROCESS | 4572 | Values: 166.0 162.0 163.0 161.0 162.0 162.0 161.0 162.0 165.0 161.0 13:02:42 INFO - PROCESS | 4572 | 13:02:42 INFO - PROCESS | 4572 | [#3] audio-fft Cycles:10 Average:94.70 Median:75.00 stddev:40.76 (54.3%) stddev-sans-first:42.60 13:02:42 INFO - PROCESS | 4572 | Values: 75.0 75.0 77.0 170.0 76.0 74.0 75.0 76.0 174.0 75.0 13:02:42 INFO - PROCESS | 4572 | 13:02:42 INFO - PROCESS | 4572 | [#4] audio-oscillator Cycles:10 Average:101.60 Median:84.00 stddev:28.58 (34.0%) stddev-sans-first:29.59 13:02:42 INFO - PROCESS | 4572 | Values: 84.0 83.0 143.0 84.0 83.0 85.0 142.0 84.0 84.0 144.0 13:02:42 INFO - PROCESS | 4572 | 13:02:42 INFO - PROCESS | 4572 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.53 13:02:42 INFO - PROCESS | 4572 | Values: 119.0 117.0 118.0 118.0 117.0 118.0 117.0 117.0 117.0 118.0 13:02:42 INFO - PROCESS | 4572 | 13:02:42 INFO - PROCESS | 4572 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:2.90 (2.0%) stddev-sans-first:3.07 13:02:42 INFO - PROCESS | 4572 | Values: 148.0 148.0 149.0 147.0 147.0 146.0 156.0 147.0 148.0 146.0 13:02:42 INFO - PROCESS | 4572 | 13:02:42 INFO - PROCESS | 4572 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 13:02:42 INFO - PROCESS | 4572 | Values: 95.0 95.0 97.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 13:02:42 INFO - PROCESS | 4572 | 13:02:42 INFO - PROCESS | 4572 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:52.50 stddev:1.78 (3.4%) stddev-sans-first:1.36 13:02:42 INFO - PROCESS | 4572 | Values: 56.0 51.0 55.0 53.0 52.0 51.0 51.0 52.0 53.0 51.0 13:02:42 INFO - PROCESS | 4572 | 13:02:42 INFO - PROCESS | 4572 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:61.00 stddev:0.82 (1.3%) stddev-sans-first:0.73 13:02:42 INFO - PROCESS | 4572 | Values: 59.0 61.0 61.0 61.0 61.0 60.0 60.0 60.0 59.0 61.0 13:02:42 INFO - PROCESS | 4572 | 13:02:42 INFO - PROCESS | 4572 | [#10] stanford-crypto-aes Cycles:10 Average:75.30 Median:75.00 stddev:3.13 (4.2%) stddev-sans-first:3.21 13:02:42 INFO - PROCESS | 4572 | Values: 73.0 76.0 81.0 74.0 80.0 74.0 73.0 73.0 77.0 72.0 13:02:42 INFO - PROCESS | 4572 | 13:02:42 INFO - PROCESS | 4572 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:129.00 stddev:9.25 (7.2%) stddev-sans-first:9.58 13:02:42 INFO - PROCESS | 4572 | Values: 122.0 131.0 131.0 121.0 121.0 120.0 127.0 120.0 149.0 135.0 13:02:42 INFO - PROCESS | 4572 | 13:02:42 INFO - PROCESS | 4572 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.20 Median:152.50 stddev:2.04 (1.3%) stddev-sans-first:2.12 13:02:42 INFO - PROCESS | 4572 | Values: 150.0 150.0 153.0 150.0 153.0 152.0 148.0 149.0 153.0 154.0 13:02:42 INFO - PROCESS | 4572 | 13:02:42 INFO - PROCESS | 4572 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:63.50 stddev:2.64 (4.2%) stddev-sans-first:2.80 13:02:42 INFO - PROCESS | 4572 | Values: 64.0 63.0 63.0 63.0 65.0 65.0 63.0 71.0 62.0 62.0 13:02:42 INFO - PROCESS | 4572 | -------- Summary: end -------- 13:02:42 INFO - PROCESS | 4572 | 13:02:43 INFO - TEST-INFO | 4572: exit 0 13:02:43 INFO - TEST-OK | kraken | took 61236ms 13:02:43 INFO - SUITE-END | took 1172s 13:02:43 INFO - Completed test suite (00:19:32) 13:02:43 INFO - javascript benchmark 13:02:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7769.507674849383, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3310.5861767279107, 3319.6182439019512, 3334.233126380931, 3336.2159892425275, 3357.1103657530743, 5769.076947688371, 5804.129380592914, 5833.154192642064, 5837.854053648661, 5840.824775256739, 5754.395788442216, 5785.710714464281, 5799.565032622549, 5804.245448091753, 5806.419358064202, 5233.031889100519, 5259.211118332261, 5273.8945221095555, 5277.0, 5292.708901010443, 5133.666311689747, 5142.974285128569, 5143.974280128594, 5234.6859188448625, 5266.683998960075, 5279.9208011879855, 5295.523402893738, 5298.708571028592, 5300.655457395276, 5318.494742999409, 5352.090144675414, 5362.758675859595, 5365.704886231256, 5375.569954403638, 5382.0, 5036.0, 5102.285680004802, 5220.1647736362, 5275.920861187085, 5338.466153384669, 5666.150077488369, 5753.597248192628, 5766.336871259817, 5770.394108618577, 5797.710114494258, 6139.508839292846, 6143.569950103494, 6184.752609895599, 6189.195404597373, 6194.566380353377, 6006.189164462785, 6108.602940808833, 6225.470834979033, 6232.065190221458, 6233.906491402633, 5716.171155182476, 5808.448197421239, 5817.0692689169955, 5840.328362238354, 5846.824595262149, 6288.339724328971, 6298.307186209513, 6328.0, 6339.683015849189, 6351.904721429182, 5872.060470324727, 6010.128531362928, 6013.729382177812, 6067.635941843415, 6126.479249263773, 6101.176341193882, 6232.283287421914, 6232.376762323732, 6233.065040243909, 6244.2819075805955, 6145.508359331243, 6167.537434692416, 6170.043643235305, 6193.721282542297, 6207.037909124093, 5885.234919460443, 6104.236970378703, 6130.478909292671, 6133.110698948627, 6191.94736894729, 4668.253079507263, 4743.976280118577, 4745.264484004984, 4763.214069678534, 4780.330753694486, 4183.686223533247, 4212.978935105305, 4213.747175169499, 4232.576742325804, 4247.51153617338, 5707.857303567444, 5864.413558644102, 5936.168936348915, 5980.940190598125, 5998.040313549811, 6131.325554189036, 6243.500519958392, 6267.2479302484, 6275.905861412082, 6282.057691346243, 5961.612495187799, 5980.910286345708, 5992.191054207713, 5992.940070599238, 5999.4900433463645, 5134.383873935077, 5317.707526086025, 5362.544183744348, 5365.597580181424, 5379.811706590251, 6412.0, 6528.738850446024, 6537.084808126771, 6538.280789113289, 6547.508936829757, 6242.656653883898, 6299.0, 6318.052292156213, 6321.905171422524, 6328.715207815567, 6163.075538669056, 6278.560500764903, 6394.104825324365, 6451.258105317761, 6467.935320646733, 5996.820095397145, 6139.43080903429, 6165.5375846810775, 6174.0, 6175.166352542349, 6242.937570624417, 6258.687065646608, 6261.906071408841, 6276.843078923063, 6277.529185311211, 5940.108983652487, 5977.043673012297, 6073.514118870391, 6095.664738439428, 6117.235345581802, 5984.611000284967, 6118.357572454828, 6118.388161183846, 6118.938810611837, 6136.386361363828, 6014.36849130835, 6014.909776353271, 6020.6989650516425, 6024.307204671343, 6046.123312119806, 5968.522518198447, 6064.818055458343, 6114.785982490592, 6122.571420000557, 6131.172291740736, 5922.763089476545, 6033.18551995475, 6044.425779550936, 6058.030715085565, 6076.422739839708], "value": 5717.364229541965, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.7982446056109, 586.4721750424617, 629.5907660020989, 632.3992207402966, 662.1094627725711, 42100.36849447257, 46947.53052469475, 47032.58902232934, 47223.291650625266, 47345.28982065272, 47063.76468117663, 47948.76025619876, 48089.0, 48153.518464815344, 48155.27767083496, 9068.274538036958, 9248.398854074498, 9293.814123717522, 9294.0, 9332.720018399425, 9226.492542910137, 9334.859977100348, 9366.578503967305, 9377.296702747288, 9418.340716149873, 9410.388324758904, 9427.811443771121, 9429.669961551346, 9439.622415103388, 9447.433154010747, 9312.068793120701, 9390.248780097576, 9397.436153830758, 9405.811883762355, 9425.434473931586, 9125.543722813833, 9168.220701240403, 9245.167934885825, 9251.583678734472, 9254.352195346328, 45449.77275113636, 45576.3163552547, 45841.77079114583, 45892.77053614711, 45946.54053459456, 3608.0, 3887.844486220548, 4036.3945408188715, 4072.6741860651077, 4387.605115539584, 35647.64352356469, 35699.0, 35951.0, 37242.4413633793, 37472.25055498902, 4304.0, 4378.10248898975, 4502.662300327455, 4522.592966632986, 4584.564466375689, 369812.9999999973, 373495.0, 374292.0, 374473.0, 375567.12216439017, 37858.81070594629, 62500.0, 62910.685446572475, 62950.37049629536, 62993.37006629966, 38048.239035219696, 40439.797801011395, 40585.79707101505, 40736.38895416571, 40821.79589102035, 15576.0, 15705.45030923935, 15722.0, 15807.209639518209, 16183.676326473405, 12592.74814503723, 12600.4329805159, 12677.556285529961, 12701.110922235355, 12705.17416367933, 9095.0, 9211.447313161232, 9228.95385523068, 9240.445573265626, 9264.490453025013, 3537.4693795930816, 3552.1652411683235, 3559.733020023457, 3592.6586974237407, 3608.909777255537, 1099.4777480696605, 1118.59730497021, 1132.3545579020044, 1137.9260348077514, 1217.2939694976892, 34808.0, 35455.11362215965, 35645.28709425797, 35786.28427431437, 35910.8204458976, 1174.94712737927, 1207.0946789907568, 1234.1422711215619, 1262.482382223284, 1305.556110922291, 18057.71298840963, 18257.087145642665, 18471.0, 18702.625947480974, 18741.062946852602, 613588.0, 617315.0, 618852.0, 621548.0, 624025.0, 65697.67151164309, 65831.34168658347, 66137.33862661407, 66230.33769662338, 66339.66830165914, 1422.2177802208744, 1444.6893917807722, 1446.0600609603841, 1465.201465201489, 1469.7427950108902, 33152.66847331496, 34191.65808341885, 34426.139346515534, 34543.13642158866, 34777.0, 54743.45256547384, 54922.0, 54929.077482287925, 55339.0, 55576.16635750386, 509356.0, 514674.0, 516063.0, 516810.0, 518467.0, 30741.53887691731, 30766.53850192204, 31820.204494887814, 31892.202694932814, 31906.840465797522, 53091.0, 53438.19842702285, 53521.73239133779, 54295.72852135714, 54443.0, 43989.560104398544, 44548.876879158015, 44990.325145123505, 45716.31425528686, 46620.53379466297, 47336.28995565138, 47381.76309118432, 47827.76086119547, 47961.0, 48800.0, 45202.321965171206, 46094.7695261535, 46799.76600116977, 47505.762471188806, 49482.505174947786, 38629.22741545209, 39732.801335993136, 39926.0, 40836.59163408328, 41171.0, 30242.395152097273, 31812.5228121583, 31840.203994900312, 32017.67982320147, 32165.0], "value": 20571.364408356658, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.5012409921944, 411.1181515648933, 413.86342506972704, 429.5446826364054, 442.14445048830515, 20493.897530512346, 20765.857877816714, 21063.789362106374, 21141.471463213427, 21752.564948701016, 20639.0, 20750.792492075074, 20755.377338679828, 20955.0, 21093.894530527363, 5908.999999999989, 6058.636481811083, 6062.181605483247, 6075.997460419026, 6122.877542449149, 6003.699815009254, 6027.276726792791, 6044.66754328514, 6047.092936059605, 6051.546134039942, 5833.533317334603, 5918.763249470016, 5956.374580669032, 5963.701814909259, 6003.6697981611, 5820.476157145835, 5845.85385365365, 5846.532277417818, 5866.76532938682, 5917.289925208981, 5334.333208348957, 5343.412224655285, 5363.329583802025, 5365.839024829262, 5378.946210537883, 24699.0, 24837.0, 24904.626430603555, 25115.62326565103, 25385.238442846745, 2576.2013775729397, 2727.0, 2769.8338099714083, 2901.086157860267, 3275.901722948315, 15540.06759594428, 15732.842671573253, 15735.0, 15762.0, 16148.59628509285, 2069.6590363057358, 2076.3459510254374, 2116.2593092417683, 2145.6996020557135, 2190.288156349193, 81393.18606813916, 83248.0, 84039.0, 94265.0, 94847.0, 11331.43342832855, 11858.703532411586, 12010.0, 12078.456469458895, 12320.938395307967, 16930.746038809426, 16933.15334233308, 16947.830521694872, 16961.15194240283, 16982.150892455575, 8265.586720663943, 8291.626876790559, 8485.40602157843, 8623.611937462829, 8632.093630168742, 8054.959725201454, 8081.717139900075, 8087.757367278991, 8191.631376588068, 8275.83448331042, 4732.0772449372735, 4930.704157750546, 5122.282880396748, 5149.120570991561, 5178.456262092502, 2084.1871670048695, 2116.9470763231043, 2174.3476956913178, 2192.134107027747, 2215.711957445522, 1010.2322235101376, 1034.3018462537907, 1088.8911108889047, 1100.9009189173014, 1116.2855772305732, 20459.59080818405, 20808.791912080684, 21105.0, 21184.894075529523, 21302.147914083573, 1004.8090862736057, 1023.6263763726187, 1049.5644307612256, 1055.6674647486018, 1066.919981001428, 11191.720206994727, 11689.0, 11843.526258949718, 11874.406279685982, 11881.287122772488, 165743.1712841428, 211096.0, 515315.0, 516676.0, 525369.0, 75480.0, 88105.0, 97366.53950190752, 99356.50321748345, 100139.0, 1012.579779391559, 1031.1544533482622, 1034.2450011491503, 1048.6801525534634, 1050.4485145298627, 17617.295308187528, 18542.258309668003, 18585.53536161607, 18708.345207917657, 18807.341743038927, 31144.688553114178, 36684.633153668125, 44655.10689786251, 46749.29876051794, 47056.52943470521, 65297.673511632136, 65571.37714491367, 66370.66814665895, 66860.6656966712, 67279.0, 7773.18381569927, 7936.0, 8180.386471014816, 8534.402591818762, 8871.334649901155, 10092.444915529717, 13093.934530327668, 13568.660783480493, 13654.385552650354, 13797.379117939918, 11817.0, 12097.939510302393, 12221.938890305491, 12258.141930065167, 12366.814497782361, 10336.0697537222, 10816.729581760204, 11332.660020199408, 11406.714832129263, 11412.71468213268, 9662.371945823781, 11452.541898323974, 11518.424078796193, 11581.478833452684, 11969.401529923294, 7339.706411743684, 7383.741569045058, 7413.9258607415395, 7470.4770666052855, 7669.578173200527, 7932.762017139495, 9264.95367523185, 9497.43015419077, 9524.904750952403, 11196.328220306808], "value": 9598.206904892702, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1541.2910061371772, 1579.81042274927, 1732.1685590916359, 1874.3439796071386, 1878.0891267735155, 8293.460925039868, 8854.380193386458, 9572.6649567265, 9614.855777163348, 9692.903070969298, 9660.468674222915, 9710.465924374157, 9756.512174391288, 9758.512074396269, 9773.26700497462, 2468.4816188600416, 2496.8377055491424, 2505.8496490210646, 2507.059852555292, 2522.1676846640567, 2431.3192306154306, 2505.4112283613335, 2521.9117330893423, 2525.1162093267303, 2529.152733834168, 2475.4801491686676, 2493.0152589727045, 2509.8619575923317, 2519.735427780084, 2524.2805800346905, 2422.8061755059553, 2429.6112621980487, 2440.8779561021965, 2445.3764290106087, 2462.212092130519, 2402.1592442644933, 2408.506256217471, 2413.9034438622434, 2420.4674971506242, 2428.7449817769057, 9757.853632195523, 9870.506474676238, 9938.15525680318, 9943.75140621483, 9979.80040399188, 5552.250446189753, 5767.913481297784, 5793.188953546507, 5796.275465566804, 5799.0, 3376.3247350529746, 3468.9306213875834, 3515.9472607910648, 3521.366154092262, 3587.0852932502044, 1059.8887116852698, 1100.2298391126244, 1122.2032357026521, 1131.0555686002199, 1145.455908443491, 13956.092853964561, 13980.72038559223, 13986.16083035011, 14010.019298649098, 14060.08609440383, 4900.289458028566, 4908.730019848943, 4911.582515486224, 4984.327115839388, 5079.87300317495, 11642.825357619642, 11696.415179241174, 11713.765724685458, 11755.529778808752, 11757.176997610086, 5694.658320500783, 5698.088305871041, 5718.428157184248, 5732.226149469851, 5736.799212027559, 4552.6813123081065, 5109.259157422153, 5324.04167249891, 5324.148136298174, 5325.547328477045, 4376.059147283349, 4433.911321773547, 4441.977790111029, 4492.932606010912, 4495.955040449619, 1343.563341913882, 1368.185929372022, 1392.192528333564, 1394.7907813827803, 1405.6415614018565, 997.9950100249597, 1033.3748082410184, 1059.777446736194, 1070.1866581398194, 1095.0856035210688, 6505.934940650627, 6524.836879077966, 6756.932430675729, 6798.76204332846, 6838.316168383122, 502.08369725250833, 502.7285265956416, 509.9923501147486, 520.6537652461146, 523.2543625333884, 4562.612177964844, 4665.346851440801, 4713.552212539803, 4715.24556071027, 4764.571188592974, 11945.70135746596, 12264.509419623115, 12311.0, 12356.25862448256, 12391.070669699808, 11485.885141148481, 12099.213551119148, 12124.272543647234, 12133.272003679807, 12242.204256723284, 9000.684976025808, 9075.773105672279, 9163.450192988443, 9224.262059035262, 9231.676891308773, 6495.382938620824, 6495.870082598227, 6746.460283177236, 6837.555558888656, 6902.792916212522, 10768.892311076788, 11170.0, 11278.774424511628, 11338.14963877729, 11437.199396042197, 11450.37022963745, 11505.597304094317, 11543.076553875837, 11567.710807229887, 11654.825177622173, 7817.296443320129, 8363.790905227175, 8645.221930026328, 8716.869246961174, 8920.0, 9554.378965367228, 9589.808203836024, 9633.807323853624, 9661.323707340418, 9674.85487717699, 8290.917090829014, 8363.874541881998, 8364.66541338364, 8453.36599755033, 8633.784155396166, 8335.374846886387, 8413.200745929127, 8431.620577073923, 8448.239658430524, 8483.406161568631, 7740.26467485588, 7795.883061753965, 7832.490888092256, 7886.171951944963, 7899.407544434075, 5397.325334333208, 5421.891562168814, 5467.125259958388, 5488.1493368527945, 5538.861528461821, 5715.2855893013375, 5758.769649213985, 5867.647941123546, 5874.618149820248, 5964.9105263420215], "value": 4985.484261936555, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.4510273767448, 349.14633720553246, 353.8973697627689, 363.0651073485775, 368.77504722119517, 5594.866874550245, 5769.221155144054, 5850.3564607893095, 5908.379620139888, 5961.433663801938, 5735.541156707463, 5778.122110314143, 5778.508826749731, 5778.942210577893, 5811.331696854863, 4528.637708983273, 4531.592156705896, 4535.591796738293, 4554.134714404253, 4576.954230457703, 4425.424694789689, 4472.642188624918, 4507.4365704286965, 4523.575073851743, 4566.360709500673, 4481.3726078349055, 4487.9551204488025, 4489.451139356916, 4500.887477813065, 4521.276595744682, 4523.208438523246, 4525.456945166568, 4540.364348991144, 4542.591166794988, 4549.636029117696, 3828.0, 3932.5674175840636, 3950.4469374287623, 3953.2686453006286, 3983.24318379507, 5629.746661400247, 5630.943690563124, 5637.8590535236535, 5667.914981275284, 5690.0, 5107.489251074863, 5167.3282473278605, 5213.6089793265655, 5225.712585807779, 5234.842954711365, 6028.728707208186, 6062.96968515159, 6069.787557435468, 6073.4533891949495, 6089.451949324582, 4334.501532323791, 4398.076403955173, 4400.801963911632, 4409.603135717801, 4415.785658943816, 6074.665893375863, 6203.41067598582, 6353.269374021954, 6425.0, 6445.355464453564, 4233.703640745119, 4301.591348821857, 4323.524412314643, 4358.106588149421, 4371.846985355497, 4398.73607583546, 4403.757793321398, 4443.555644435595, 4449.621782148553, 4459.9331010034875, 5012.674176178537, 5122.871928201825, 5137.17805151174, 5153.484651534892, 5170.844874653766, 5911.674857882772, 6137.877242455215, 6147.2480343102, 6159.3224745277985, 6184.165137706442, 1550.2636247782214, 1567.91376474295, 1572.4968010236614, 1576.7871337369538, 1581.7152912475865, 968.6077138758814, 986.5363279258737, 1004.2167109654481, 1004.598160735697, 1018.9643362482277, 5267.578593712494, 5281.313429254173, 5296.629235953446, 5365.54392876602, 5366.91949620756, 5549.556035517149, 5601.243832082617, 5611.6071874969175, 5615.747291371898, 5688.573356998241, 4947.604191664658, 5184.48155184486, 5288.92066619001, 5297.258383826267, 5382.30030096085, 2983.568391760708, 2993.3265015371803, 3023.2744141405906, 3038.3315670552442, 3045.573619693245, 5719.399463056319, 5787.803842214361, 5790.652560846363, 5808.738606762706, 5866.472017518444, 6052.636841789506, 6466.838329041811, 6487.2539657939, 6550.508711846631, 6559.770408035696, 6568.540202185801, 6577.934220657732, 6599.637019963852, 6602.0, 6685.866282674417, 6201.3178550358525, 6343.619382837044, 6387.808365749035, 6396.680165991775, 6412.583182093149, 6287.74849006053, 6343.619382837044, 6345.7144428499905, 6361.586496877688, 6376.4580010697755, 6299.937000629935, 6529.804105876831, 6544.705488252945, 6650.235222949229, 6679.76620818269, 4442.0, 4488.169688607618, 4493.236149854467, 4532.161550113239, 4552.567506086916, 6162.969185154046, 6199.628022318675, 6513.576617519846, 6530.88974874263, 6553.901691474727, 6182.783602573888, 6186.906546726636, 6213.5339849512375, 6216.264843468859, 6253.749850005949, 6158.784442544668, 6210.285817131088, 6232.158658581034, 6278.560500765086, 6337.9366206337345, 6150.50795936333, 6181.84545386369, 6183.81448556544, 6203.875922481616, 6268.2478102626155, 6291.811245662454, 6326.671399006076, 6332.733453309264, 6369.554131210771, 6375.362463753773, 5886.882262354643, 6080.270367555921, 6081.179040829431, 6100.908486372619, 6140.17107690456], "value": 4601.719769511691, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [808.8099296665283, 834.4159088637955, 847.7499137754362, 870.3298460185657, 951.4243882451121, 16794.580135496617, 16883.493495195147, 17635.20641571129, 17635.470935871945, 18236.726449103273, 17968.820311796877, 18127.81872181278, 18140.455786326398, 18301.725474117866, 18333.724994125067, 891.9999999999984, 916.1022198245723, 918.5820451694497, 919.1635611593451, 920.779013036873, 861.995690021549, 882.1531329923281, 882.2412725056446, 905.1129892705153, 907.1427501011547, 954.5561313988994, 955.7515046087998, 957.9856302155439, 960.3757557587554, 961.5961296255555, 951.4481600671594, 952.4951775558931, 955.1022039283121, 956.1251454918742, 957.2246480350938, 698.068079114383, 701.0745815523511, 704.126882665491, 704.9883417296196, 706.8409607838247, 17083.0, 17099.0, 17129.91435042829, 17171.399001034904, 17188.398406055854, 15186.316615752317, 15382.311240689325, 15828.013237430268, 16689.24898379564, 16815.0751708656, 13330.733385332336, 13714.451421943111, 13853.0, 13906.93046534771, 13987.090839095528, 4199.4330765346895, 4242.66058715302, 4260.573942605745, 4304.870853874389, 4344.956550434518, 86021.56989215076, 86877.0, 88149.0, 89821.55089224578, 90123.0, 12323.630291091282, 12461.439235234437, 12494.312812795384, 12499.687507812196, 12649.114561980574, 23482.76517234806, 23534.7646523536, 23560.175393861133, 23744.40638984039, 24595.262142135765, 9208.493532855624, 9427.764305892408, 9449.43303401798, 9453.76365590852, 9746.171575416027, 5196.896062078813, 5223.190405487156, 5249.107651699221, 5318.414974352818, 5374.946250537523, 3960.6039396060164, 4069.8372065117655, 4086.7752273625238, 4089.0, 4098.2418252622765, 675.4933799650262, 688.6074937285799, 693.5907814389534, 697.8255436140964, 723.4935545118439, 821.1706176761514, 826.4751882554501, 830.2901019628131, 836.7196989008751, 855.6748435594434, 10353.585856565653, 10849.0, 10860.728481788019, 11114.499847506882, 11192.216544841784, 695.3567949646557, 728.5992704012772, 772.9719473100763, 800.4956877167348, 826.7478419082238, 4924.857686906135, 5376.489233522809, 5422.810201643002, 5472.945270547323, 5489.64317319373, 127046.0, 131106.0, 132497.0, 134261.0, 138156.0, 110515.0, 113819.43090284661, 113846.0, 114216.0, 114870.4256478729, 80871.0, 81921.59039204766, 100124.49937750265, 100290.49854750825, 100582.49708751556, 10322.48387580633, 10513.264071514921, 10662.306950048222, 11079.667609971713, 11514.884851151717, 55676.443235568746, 56190.0, 56508.0, 56768.43231567631, 57409.71295143497, 80127.19872801431, 80538.59730701309, 80761.59619201867, 82459.0, 83260.0, 14314.355853986805, 14752.262386880828, 14799.260036998323, 14900.18049007315, 15095.39618415295, 15416.383344666088, 15600.453984110502, 16210.27053782559, 16399.590010249838, 16575.668486630442, 13905.791413129013, 13912.860871391562, 14097.436102556194, 15340.616484587974, 15407.922960385127, 13669.179849209078, 13875.0, 14230.0, 15117.697646047238, 15367.615809604402, 14129.152250864981, 14688.853111469176, 15550.0, 15609.141497217763, 16128.838711612734, 12012.75974480488, 13049.673758156123, 13050.15174013686, 13189.80215296752, 13276.800847987095, 12190.817137743119, 12671.159419566788, 13133.737325253633, 13423.530176443777, 13547.119437236548], "value": 8492.68205490545, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1500.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 113.0, 106.0, 111.0, 111.0, 111.0, 111.0, 111.0, 111.0, 112.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 116.0, 146.0, 164.0, 121.0, 147.0, 141.0, 118.0, 178.0, 116.0], "value": 139.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 162.0, 163.0, 161.0, 162.0, 162.0, 161.0, 162.0, 165.0, 161.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 170.0, 76.0, 74.0, 75.0, 76.0, 174.0, 75.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 143.0, 84.0, 83.0, 85.0, 142.0, 84.0, 84.0, 144.0], "value": 101.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 149.0, 147.0, 147.0, 146.0, 156.0, 147.0, 148.0, 146.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 51.0, 55.0, 53.0, 52.0, 51.0, 51.0, 52.0, 53.0, 51.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 61.0, 61.0, 61.0, 60.0, 60.0, 60.0, 59.0, 61.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 81.0, 74.0, 80.0, 74.0, 73.0, 73.0, 77.0, 72.0], "value": 75.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 131.0, 131.0, 121.0, 121.0, 120.0, 127.0, 120.0, 149.0, 135.0], "value": 127.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 153.0, 150.0, 153.0, 152.0, 148.0, 149.0, 153.0, 154.0], "value": 151.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 63.0, 65.0, 65.0, 63.0, 71.0, 62.0, 62.0], "value": 64.1, "unit": "score"}]}]} 13:02:43 INFO - Return code: 0 13:02:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:02:43 ERROR - # TBPL SUCCESS # 13:02:43 INFO - Running post-action listener: _resource_record_post_action 13:02:43 INFO - [mozharness: 2016-08-16 20:02:43.710611Z] Finished run-tests step (success) 13:02:43 INFO - Running post-run listener: _resource_record_post_run 13:02:43 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 326926336; Read time: 12; Write time: 219296 13:02:43 INFO - TinderboxPrint: CPU usage
13.3% 13:02:43 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 13:02:43 INFO - TinderboxPrint: I/O write bytes / time
326,926,336 / 219,296 13:02:43 INFO - TinderboxPrint: CPU idle
8,236.4 (86.7%) 13:02:43 INFO - TinderboxPrint: CPU user
1,201.7 (12.7%) 13:02:43 INFO - TinderboxPrint: Swap in / out
0 / 0 13:02:43 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 77103104; Read time: 0; Write time: 44224 13:02:43 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 249561088; Read time: 12; Write time: 175048 13:02:44 INFO - Running post-run listener: _upload_blobber_files 13:02:44 INFO - Blob upload gear active. 13:02:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:02:44 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 13:02:44 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'] 13:02:44 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 13:02:44 INFO - (blobuploader) - INFO - Open directory for files ... 13:02:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:02:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:02:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:02:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:02:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:02:45 INFO - (blobuploader) - INFO - Done attempting. 13:02:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:02:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:02:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:02:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:02:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:02:46 INFO - (blobuploader) - INFO - Done attempting. 13:02:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:02:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:02:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:02:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:02:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:02:57 INFO - (blobuploader) - INFO - Done attempting. 13:02:57 INFO - (blobuploader) - INFO - Iteration through files over. 13:02:57 INFO - Return code: 0 13:02:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:02:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:02:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/03893af8490abcf2c726a2944f80933ee55efe97844eddb48c9978176639df73e3e4776456a57ee4f1195e545bc0501ced78db3a71f8bffeed8ff4eba287f93a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/54fe38cb91afefcc5563145cd94736e606bbd01dd3c2079f030006f96d119f2c4ec1010b80627d9e4be04d46c6b5eee3726fcef09e3d26335647ef2cb69a835d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fbd99021f6d3ce546cad4241835c817dcce4589ff7011911803102aab9a39d33a558bd048ea9701048f563a9915043bf3d092d5aab9df9a499f5475102e6c170"} 13:02:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:02:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:02:57 INFO - Contents: 13:02:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/03893af8490abcf2c726a2944f80933ee55efe97844eddb48c9978176639df73e3e4776456a57ee4f1195e545bc0501ced78db3a71f8bffeed8ff4eba287f93a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/54fe38cb91afefcc5563145cd94736e606bbd01dd3c2079f030006f96d119f2c4ec1010b80627d9e4be04d46c6b5eee3726fcef09e3d26335647ef2cb69a835d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fbd99021f6d3ce546cad4241835c817dcce4589ff7011911803102aab9a39d33a558bd048ea9701048f563a9915043bf3d092d5aab9df9a499f5475102e6c170"} 13:02:57 INFO - Running post-run listener: copy_logs_to_upload_dir 13:02:57 INFO - Copying logs to upload dir... 13:02:57 INFO - mkdir: /builds/slave/test/build/upload/logs 13:02:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1685.394136 ========= master_lag: 7.99 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 13 secs) (at 2016-08-16 13:03:05.251365) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 19 secs) (at 2016-08-16 13:03:05.254544) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1471375159.372356-354710992 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/03893af8490abcf2c726a2944f80933ee55efe97844eddb48c9978176639df73e3e4776456a57ee4f1195e545bc0501ced78db3a71f8bffeed8ff4eba287f93a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/54fe38cb91afefcc5563145cd94736e606bbd01dd3c2079f030006f96d119f2c4ec1010b80627d9e4be04d46c6b5eee3726fcef09e3d26335647ef2cb69a835d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fbd99021f6d3ce546cad4241835c817dcce4589ff7011911803102aab9a39d33a558bd048ea9701048f563a9915043bf3d092d5aab9df9a499f5475102e6c170"} build_url:https://queue.taskcluster.net/v1/task/aghdPOPzRMSxvm8uXDdp2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010430 build_url: 'https://queue.taskcluster.net/v1/task/aghdPOPzRMSxvm8uXDdp2A/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/03893af8490abcf2c726a2944f80933ee55efe97844eddb48c9978176639df73e3e4776456a57ee4f1195e545bc0501ced78db3a71f8bffeed8ff4eba287f93a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/54fe38cb91afefcc5563145cd94736e606bbd01dd3c2079f030006f96d119f2c4ec1010b80627d9e4be04d46c6b5eee3726fcef09e3d26335647ef2cb69a835d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fbd99021f6d3ce546cad4241835c817dcce4589ff7011911803102aab9a39d33a558bd048ea9701048f563a9915043bf3d092d5aab9df9a499f5475102e6c170"}' ========= master_lag: 19.64 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 19 secs) (at 2016-08-16 13:03:24.908957) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 13:03:24.909292) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1471375159.372356-354710992 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004555 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 13:03:24.930516) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 13:03:24.930836) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 13:03:24.931132) ========= ========= Total master_lag: 27.76 =========