builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-025 starttime: 1471658510.98 results: success (0) buildid: 20160819162415 builduid: cd734351005c45fb84e1098e5aabc176 revision: 9aea5a70f2679e59ad80a66785215a10c7073928 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 19:01:50.976133) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 19:01:50.976778) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 19:01:50.977116) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 19:01:50.992601) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 19:01:50.993626) ========= 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=232498196343f89f466a4a9a000001c8-1471658434.74224-2027292900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-19 19:01: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% 220M=0s 2016-08-19 19:01:51 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095235 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 19:01:51.106973) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 19:01:51.107701) ========= 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=232498196343f89f466a4a9a000001c8-1471658434.74224-2027292900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017169 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 19:01:51.161138) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 19:01:51.161793) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9aea5a70f2679e59ad80a66785215a10c7073928 --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 9aea5a70f2679e59ad80a66785215a10c7073928 --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=232498196343f89f466a4a9a000001c8-1471658434.74224-2027292900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-19 19:01:51,674 truncating revision to first 12 chars 2016-08-19 19:01:51,674 Setting DEBUG logging. 2016-08-19 19:01:51,674 attempt 1/10 2016-08-19 19:01:51,674 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9aea5a70f267?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-19 19:01:51,975 unpacking tar archive at: mozilla-aurora-9aea5a70f267/testing/mozharness/ program finished with exit code 0 elapsedTime=0.675145 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 19:01:51.854314) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 19:01:51.854740) ========= script_repo_revision: 9aea5a70f2679e59ad80a66785215a10c7073928 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 19:01:51.855419) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 19:01:51.856079) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 19:01:51.866958) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 58 secs) (at 2016-08-19 19:01:51.867642) ========= /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=232498196343f89f466a4a9a000001c8-1471658434.74224-2027292900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:01:52 INFO - MultiFileLogger online at 20160819 19:01:52 in /builds/slave/test 19:01: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 19:01:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:01:52 INFO - {'append_to_log': False, 19:01:52 INFO - 'base_work_dir': '/builds/slave/test', 19:01:52 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 19:01:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:01:52 INFO - 'branch': 'Mozilla-Aurora', 19:01:52 INFO - 'buildbot_json_path': 'buildprops.json', 19:01:52 INFO - 'config_files': ('talos/linux_config.py',), 19:01:52 INFO - 'default_actions': ('clobber', 19:01:52 INFO - 'read-buildbot-config', 19:01:52 INFO - 'download-and-extract', 19:01:52 INFO - 'populate-webroot', 19:01:52 INFO - 'create-virtualenv', 19:01:52 INFO - 'install', 19:01:52 INFO - 'run-tests'), 19:01:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:01:52 INFO - 'download_minidump_stackwalk': True, 19:01:52 INFO - 'download_symbols': 'ondemand', 19:01:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:01:52 INFO - 'tooltool.py': '/tools/tooltool.py', 19:01:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:01:52 INFO - '/tools/misc-python/virtualenv.py')}, 19:01:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:01:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:01:52 INFO - 'installer_path': 'installer.exe', 19:01:52 INFO - 'log_level': 'info', 19:01:52 INFO - 'log_name': 'talos', 19:01:52 INFO - 'log_to_console': True, 19:01:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:01:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:01:52 INFO - 'opt_config_files': (), 19:01:52 INFO - 'pip_index': False, 19:01:52 INFO - 'sps_profile': False, 19:01:52 INFO - 'sps_profile_interval': 0, 19:01:52 INFO - 'suite': 'dromaeojs-e10s', 19:01:52 INFO - 'system_bits': '32', 19:01:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:01:52 INFO - 'title': 'talos-linux64-ix-025', 19:01:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:01:52 INFO - 'use_talos_json': True, 19:01:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:01:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:01:52 INFO - 'work_dir': 'build'} 19:01:52 INFO - [mozharness: 2016-08-20 02:01:52.470434Z] Running clobber step. 19:01:52 INFO - Running pre-action listener: _resource_record_pre_action 19:01:52 INFO - Running main action method: clobber 19:01:52 INFO - rmtree: /builds/slave/test/build 19:01:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:01:52 INFO - Running post-action listener: _resource_record_post_action 19:01:52 INFO - [mozharness: 2016-08-20 02:01:52.923624Z] Finished clobber step (success) 19:01:52 INFO - [mozharness: 2016-08-20 02:01:52.923724Z] Running read-buildbot-config step. 19:01:52 INFO - Running pre-action listener: _resource_record_pre_action 19:01:52 INFO - Running main action method: read_buildbot_config 19:01:52 INFO - Using buildbot properties: 19:01:52 INFO - { 19:01:52 INFO - "project": "", 19:01:52 INFO - "product": "firefox", 19:01:52 INFO - "script_repo_revision": "production", 19:01:52 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 19:01:52 INFO - "repository": "", 19:01:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 19:01:52 INFO - "buildid": "20160819162415", 19:01:52 INFO - "pgo_build": "True", 19:01:52 INFO - "basedir": "/builds/slave/test", 19:01:52 INFO - "buildnumber": 493, 19:01:52 INFO - "slavename": "talos-linux64-ix-025", 19:01:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:01:52 INFO - "platform": "ubuntu64_hw", 19:01:52 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 19:01:52 INFO - "branch": "mozilla-aurora", 19:01:52 INFO - "repo_path": "releases/mozilla-aurora", 19:01:52 INFO - "revision": "9aea5a70f2679e59ad80a66785215a10c7073928", 19:01:52 INFO - "stage_platform": "linux64-pgo", 19:01:52 INFO - "builduid": "cd734351005c45fb84e1098e5aabc176", 19:01:52 INFO - "slavebuilddir": "test" 19:01:52 INFO - } 19:01:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 19:01:52 INFO - Running post-action listener: _resource_record_post_action 19:01:52 INFO - [mozharness: 2016-08-20 02:01:52.926228Z] Finished read-buildbot-config step (success) 19:01:52 INFO - [mozharness: 2016-08-20 02:01:52.926318Z] Running download-and-extract step. 19:01:52 INFO - Running pre-action listener: _resource_record_pre_action 19:01:52 INFO - Running main action method: download_and_extract 19:01:52 INFO - mkdir: /builds/slave/test/build/tests 19:01: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')]} 19:01:52 INFO - https://queue.taskcluster.net/v1/task/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:01:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 19:01:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 19:01:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/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 19:01:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/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 19:01:52 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 19:01:52 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 19:01:52 INFO - retry: Failed, sleeping 30 seconds before retrying 19:02:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/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 19:02:22 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 19:02:22 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 19:02:22 INFO - retry: Failed, sleeping 60 seconds before retrying 19:03:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/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 19:03:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 19:03:23 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 19:03:23 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/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! 19:03:23 INFO - Caught exception: HTTP Error 404: Not Found 19:03:23 INFO - Caught exception: HTTP Error 404: Not Found 19:03:23 INFO - Caught exception: HTTP Error 404: Not Found 19:03:23 INFO - trying https://queue.taskcluster.net/v1/task/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 19:03:23 INFO - Downloading https://queue.taskcluster.net/v1/task/T0IkbK3NTECacQ_W7ljJAQ/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 19:03:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T0IkbK3NTECacQ_W7ljJAQ/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 19:03:23 INFO - Downloaded 1361 bytes. 19:03:23 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 19:03:23 INFO - Using the following test package requirements: 19:03:23 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 19:03:23 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 19:03:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 19:03:23 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 19:03:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 19:03:23 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 19:03:23 INFO - u'jsshell-linux-x86_64.zip'], 19:03:23 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 19:03:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 19:03:23 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 19:03:23 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 19:03:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 19:03:23 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 19:03:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 19:03:23 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 19:03:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 19:03:23 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 19:03:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 19:03:23 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:03: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')]} 19:03:23 INFO - https://queue.taskcluster.net/v1/task/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:03:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 19:03:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 19:03:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/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 19:03:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/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 19:03:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 19:03:23 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 19:03:23 INFO - retry: Failed, sleeping 30 seconds before retrying 19:03:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/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 19:03:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 19:03:53 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 19:03:53 INFO - retry: Failed, sleeping 60 seconds before retrying 19:04:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/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 19:04:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 19:04:53 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 19:04:53 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/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! 19:04:53 INFO - Caught exception: HTTP Error 404: Not Found 19:04:53 INFO - Caught exception: HTTP Error 404: Not Found 19:04:53 INFO - Caught exception: HTTP Error 404: Not Found 19:04:53 INFO - trying https://queue.taskcluster.net/v1/task/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 19:04:53 INFO - Downloading https://queue.taskcluster.net/v1/task/T0IkbK3NTECacQ_W7ljJAQ/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 19:04:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T0IkbK3NTECacQ_W7ljJAQ/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 19:04:54 INFO - Downloaded 21766203 bytes. 19:04: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'] 19:04: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 19:04:55 INFO - Return code: 0 19:04: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 19:04: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')]} 19:04:55 INFO - https://queue.taskcluster.net/v1/task/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:04:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 19:04:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 19:04:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/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 19:04:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/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 19:04:55 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 19:04:55 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 19:04:55 INFO - retry: Failed, sleeping 30 seconds before retrying 19:05:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/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 19:05:25 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 19:05:25 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 19:05:25 INFO - retry: Failed, sleeping 60 seconds before retrying 19:06:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/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 19:06:25 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 19:06:25 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 19:06:25 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/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! 19:06:25 INFO - Caught exception: HTTP Error 404: Not Found 19:06:25 INFO - Caught exception: HTTP Error 404: Not Found 19:06:25 INFO - Caught exception: HTTP Error 404: Not Found 19:06:25 INFO - trying https://queue.taskcluster.net/v1/task/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 19:06:25 INFO - Downloading https://queue.taskcluster.net/v1/task/T0IkbK3NTECacQ_W7ljJAQ/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 19:06:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T0IkbK3NTECacQ_W7ljJAQ/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 19:06:26 INFO - Downloaded 21766203 bytes. 19:06:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:06:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:06:28 INFO - Return code: 0 19:06: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')]} 19:06:28 INFO - https://queue.taskcluster.net/v1/task/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:06:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 19:06:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 19:06:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/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 19:06:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/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 19:06:28 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 19:06:28 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 19:06:28 INFO - retry: Failed, sleeping 30 seconds before retrying 19:06:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/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 19:06:58 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 19:06:58 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 19:06:58 INFO - retry: Failed, sleeping 60 seconds before retrying 19:07:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/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 19:07:58 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 19:07:58 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 19:07:58 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/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! 19:07:58 INFO - Caught exception: HTTP Error 404: Not Found 19:07:58 INFO - Caught exception: HTTP Error 404: Not Found 19:07:58 INFO - Caught exception: HTTP Error 404: Not Found 19:07:58 INFO - trying https://queue.taskcluster.net/v1/task/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 19:07:58 INFO - Downloading https://queue.taskcluster.net/v1/task/T0IkbK3NTECacQ_W7ljJAQ/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 19:07:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T0IkbK3NTECacQ_W7ljJAQ/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 19:07:59 INFO - Downloaded 14413723 bytes. 19:07: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'] 19:07: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 19:08:00 INFO - Return code: 0 19:08: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')]} 19:08:00 INFO - https://queue.taskcluster.net/v1/task/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:08:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 19:08:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 19:08:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/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 19:08:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/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 19:08:00 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 19:08:00 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 19:08:00 INFO - retry: Failed, sleeping 30 seconds before retrying 19:08:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/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 19:08:30 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 19:08:30 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 19:08:30 INFO - retry: Failed, sleeping 60 seconds before retrying 19:09:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/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 19:09:30 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 19:09:30 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 19:09:30 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0IkbK3NTECacQ_W7ljJAQ/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! 19:09:30 INFO - Caught exception: HTTP Error 404: Not Found 19:09:30 INFO - Caught exception: HTTP Error 404: Not Found 19:09:30 INFO - Caught exception: HTTP Error 404: Not Found 19:09:30 INFO - trying https://queue.taskcluster.net/v1/task/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 19:09:30 INFO - Downloading https://queue.taskcluster.net/v1/task/T0IkbK3NTECacQ_W7ljJAQ/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 19:09:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T0IkbK3NTECacQ_W7ljJAQ/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 19:09:31 INFO - Downloaded 63744870 bytes. 19:09:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 19:09:31 INFO - mkdir: /builds/slave/test/properties 19:09:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:09:31 INFO - Writing to file /builds/slave/test/properties/build_url 19:09:31 INFO - Contents: 19:09:31 INFO - build_url:https://queue.taskcluster.net/v1/task/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 19:09:32 INFO - Running post-action listener: _resource_record_post_action 19:09:32 INFO - Running post-action listener: set_extra_try_arguments 19:09:32 INFO - [mozharness: 2016-08-20 02:09:32.078337Z] Finished download-and-extract step (success) 19:09:32 INFO - [mozharness: 2016-08-20 02:09:32.078570Z] Running populate-webroot step. 19:09:32 INFO - Running pre-action listener: _resource_record_pre_action 19:09:32 INFO - Running main action method: populate_webroot 19:09:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:09:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:09:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:09:32 INFO - '--tppagecycles', 19:09:32 INFO - '7'], 19:09:32 INFO - 'tests': ['tsvgm']}}, 19:09:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:09:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:09:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:09:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:09:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:09:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:09:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:32 INFO - 'talos_options': ['--disable-e10s'], 19:09:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:09:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:09:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:32 INFO - 'talos_options': ['--disable-e10s'], 19:09:32 INFO - 'tests': ['damp', 'tps']}, 19:09:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:32 INFO - 'tests': ['damp', 'tps']}, 19:09:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:09:32 INFO - 'tests': ['dromaeo_dom']}, 19:09:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:09:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:09:32 INFO - 'tests': ['basic_compositor_video']}, 19:09:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:09:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:09:32 INFO - 'tests': ['a11yr', 19:09:32 INFO - 'ts_paint', 19:09:32 INFO - 'tpaint', 19:09:32 INFO - 'sessionrestore', 19:09:32 INFO - 'sessionrestore_no_auto_restore', 19:09:32 INFO - 'tabpaint']}, 19:09:32 INFO - 'other-e10s': {'tests': ['a11yr', 19:09:32 INFO - 'ts_paint', 19:09:32 INFO - 'tpaint', 19:09:32 INFO - 'sessionrestore', 19:09:32 INFO - 'sessionrestore_no_auto_restore', 19:09:32 INFO - 'tabpaint']}, 19:09:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:09:32 INFO - 'ts_paint', 19:09:32 INFO - 'tpaint', 19:09:32 INFO - 'sessionrestore', 19:09:32 INFO - 'sessionrestore_no_auto_restore', 19:09:32 INFO - 'tabpaint']}, 19:09:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:09:32 INFO - 'ts_paint', 19:09:32 INFO - 'tpaint', 19:09:32 INFO - 'sessionrestore', 19:09:32 INFO - 'sessionrestore_no_auto_restore', 19:09:32 INFO - 'tabpaint']}, 19:09:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:09:32 INFO - 'tests': ['a11yr', 19:09:32 INFO - 'ts_paint', 19:09:32 INFO - 'tpaint', 19:09:32 INFO - 'sessionrestore', 19:09:32 INFO - 'sessionrestore_no_auto_restore', 19:09:32 INFO - 'tabpaint']}, 19:09:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:09:32 INFO - 'tests': ['a11yr', 19:09:32 INFO - 'ts_paint', 19:09:32 INFO - 'tpaint', 19:09:32 INFO - 'sessionrestore', 19:09:32 INFO - 'sessionrestore_no_auto_restore', 19:09:32 INFO - 'tabpaint']}, 19:09:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:09:32 INFO - 'tests': ['tsvgx', 19:09:32 INFO - 'tsvgr_opacity', 19:09:32 INFO - 'tart', 19:09:32 INFO - 'tscrollx', 19:09:32 INFO - 'cart']}, 19:09:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:09:32 INFO - 'tsvgr_opacity', 19:09:32 INFO - 'tart', 19:09:32 INFO - 'tscrollx', 19:09:32 INFO - 'cart']}, 19:09:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:32 INFO - 'talos_options': ['--disable-e10s'], 19:09:32 INFO - 'tests': ['tp5o']}, 19:09:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:32 INFO - 'tests': ['tp5o']}, 19:09:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:32 INFO - 'talos_options': ['--disable-e10s', 19:09:32 INFO - '--xperf_path', 19:09:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:09:32 INFO - 'tests': ['tp5n']}, 19:09:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:32 INFO - 'talos_options': ['--xperf_path', 19:09:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:09:32 INFO - 'tests': ['tp5n']}}, 19:09:32 INFO - 'talos.zip': {'path': '', 19:09:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:09:32 INFO - Running post-action listener: _resource_record_post_action 19:09:32 INFO - [mozharness: 2016-08-20 02:09:32.100958Z] Finished populate-webroot step (success) 19:09:32 INFO - [mozharness: 2016-08-20 02:09:32.101048Z] Running create-virtualenv step. 19:09:32 INFO - Running pre-action listener: _resource_record_pre_action 19:09:32 INFO - Running main action method: create_virtualenv 19:09:32 INFO - Creating virtualenv /builds/slave/test/build/venv 19:09:32 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 19:09:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:09:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:09:32 INFO - Using real prefix '/usr' 19:09:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:09:32 INFO - Installing distribute.............................................................................................................................................................................................done. 19:09:34 INFO - Installing pip.................done. 19:09:34 INFO - Return code: 0 19:09:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:09: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')]} 19:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09: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')]} 19:09:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09: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 0x231a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2549400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d8570>, '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 0x25d9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d9900>, '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': '232498196343f89f466a4a9a000001c8-1471658434.74224-2027292900', '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 19:09: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 19:09: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 19:09:34 INFO - Using env: {'DISPLAY': ':0', 19:09:34 INFO - 'HOME': '/home/cltbld', 19:09:34 INFO - 'LANG': 'en_US.UTF-8', 19:09:34 INFO - 'LANGUAGE': 'en_US:en', 19:09:34 INFO - 'LOGNAME': 'cltbld', 19:09:34 INFO - 'MAIL': '/var/mail/cltbld', 19:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:34 INFO - 'MOZ_NO_REMOTE': '1', 19:09:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:34 INFO - 'NO_EM_RESTART': '1', 19:09:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:34 INFO - 'PWD': '/builds/slave/test', 19:09:34 INFO - 'SHELL': '/bin/bash', 19:09:34 INFO - 'SHLVL': '1', 19:09:34 INFO - 'TERM': 'linux', 19:09:34 INFO - 'TMOUT': '86400', 19:09:34 INFO - 'USER': 'cltbld', 19:09:34 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471658434.74224-2027292900', 19:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:34 INFO - '_': '/tools/buildbot/bin/python'} 19:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09: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 19:09:34 INFO - Cleaning up... 19:09:34 INFO - Return code: 0 19:09:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:09: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')]} 19:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09: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')]} 19:09:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09: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 0x231a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2549400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d8570>, '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 0x25d9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d9900>, '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': '232498196343f89f466a4a9a000001c8-1471658434.74224-2027292900', '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 19:09: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 19:09: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 19:09:34 INFO - Using env: {'DISPLAY': ':0', 19:09:34 INFO - 'HOME': '/home/cltbld', 19:09:34 INFO - 'LANG': 'en_US.UTF-8', 19:09:34 INFO - 'LANGUAGE': 'en_US:en', 19:09:34 INFO - 'LOGNAME': 'cltbld', 19:09:34 INFO - 'MAIL': '/var/mail/cltbld', 19:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:34 INFO - 'MOZ_NO_REMOTE': '1', 19:09:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:34 INFO - 'NO_EM_RESTART': '1', 19:09:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:34 INFO - 'PWD': '/builds/slave/test', 19:09:34 INFO - 'SHELL': '/bin/bash', 19:09:34 INFO - 'SHLVL': '1', 19:09:34 INFO - 'TERM': 'linux', 19:09:34 INFO - 'TMOUT': '86400', 19:09:34 INFO - 'USER': 'cltbld', 19:09:34 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471658434.74224-2027292900', 19:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:34 INFO - '_': '/tools/buildbot/bin/python'} 19:09:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:35 INFO - Downloading/unpacking psutil>=3.1.1 19:09:35 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 19:09:35 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 19:09:35 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 19:09:35 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 19:09:35 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 19:09:35 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 19:09:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:09:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:09:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:09:37 INFO - Installing collected packages: psutil 19:09:37 INFO - Running setup.py install for psutil 19:09:37 INFO - building 'psutil._psutil_linux' extension 19:09: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 19:09: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 19:09:37 INFO - building 'psutil._psutil_posix' extension 19:09: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 19:09: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 19:09:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:09:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:09:37 INFO - Successfully installed psutil 19:09:37 INFO - Cleaning up... 19:09:37 INFO - Return code: 0 19:09:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:09: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')]} 19:09:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09: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')]} 19:09:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09: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 0x231a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2549400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d8570>, '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 0x25d9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d9900>, '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': '232498196343f89f466a4a9a000001c8-1471658434.74224-2027292900', '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 19:09: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 19:09: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 19:09:37 INFO - Using env: {'DISPLAY': ':0', 19:09:37 INFO - 'HOME': '/home/cltbld', 19:09:37 INFO - 'LANG': 'en_US.UTF-8', 19:09:37 INFO - 'LANGUAGE': 'en_US:en', 19:09:37 INFO - 'LOGNAME': 'cltbld', 19:09:37 INFO - 'MAIL': '/var/mail/cltbld', 19:09:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:37 INFO - 'MOZ_NO_REMOTE': '1', 19:09:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:37 INFO - 'NO_EM_RESTART': '1', 19:09:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:37 INFO - 'PWD': '/builds/slave/test', 19:09:37 INFO - 'SHELL': '/bin/bash', 19:09:37 INFO - 'SHLVL': '1', 19:09:37 INFO - 'TERM': 'linux', 19:09:37 INFO - 'TMOUT': '86400', 19:09:37 INFO - 'USER': 'cltbld', 19:09:37 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471658434.74224-2027292900', 19:09:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:37 INFO - '_': '/tools/buildbot/bin/python'} 19:09:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:09: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 19:09: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 19:09: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 19:09: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 19:09: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 19:09: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 19:09:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:09:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:09:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:09:39 INFO - Installing collected packages: mozsystemmonitor 19:09:39 INFO - Running setup.py install for mozsystemmonitor 19:09:39 INFO - Successfully installed mozsystemmonitor 19:09:39 INFO - Cleaning up... 19:09:39 INFO - Return code: 0 19:09:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:09: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')]} 19:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09: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')]} 19:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09: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 0x231a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2549400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d8570>, '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 0x25d9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d9900>, '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': '232498196343f89f466a4a9a000001c8-1471658434.74224-2027292900', '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 19:09: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 19:09: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 19:09:39 INFO - Using env: {'DISPLAY': ':0', 19:09:39 INFO - 'HOME': '/home/cltbld', 19:09:39 INFO - 'LANG': 'en_US.UTF-8', 19:09:39 INFO - 'LANGUAGE': 'en_US:en', 19:09:39 INFO - 'LOGNAME': 'cltbld', 19:09:39 INFO - 'MAIL': '/var/mail/cltbld', 19:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:39 INFO - 'MOZ_NO_REMOTE': '1', 19:09:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:39 INFO - 'NO_EM_RESTART': '1', 19:09:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:39 INFO - 'PWD': '/builds/slave/test', 19:09:39 INFO - 'SHELL': '/bin/bash', 19:09:39 INFO - 'SHLVL': '1', 19:09:39 INFO - 'TERM': 'linux', 19:09:39 INFO - 'TMOUT': '86400', 19:09:39 INFO - 'USER': 'cltbld', 19:09:39 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471658434.74224-2027292900', 19:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:39 INFO - '_': '/tools/buildbot/bin/python'} 19:09:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:40 INFO - Downloading/unpacking jsonschema==2.5.1 19:09: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 19:09: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 19:09: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 19:09: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 19:09: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 19:09: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 19:09:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:09:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:09: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 19:09: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 19:09: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 19:09: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 19:09: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 19:09: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 19:09:42 INFO - Downloading functools32-3.2.3-2.tar.gz 19:09:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:09:42 INFO - warning: no files found matching '*.txt' 19:09:42 INFO - no previously-included directories found matching 'build' 19:09:42 INFO - no previously-included directories found matching 'dist' 19:09:42 INFO - no previously-included directories found matching '.git*' 19:09:42 INFO - Installing collected packages: jsonschema, functools32 19:09:42 INFO - Running setup.py install for functools32 19:09:42 INFO - warning: no files found matching '*.txt' 19:09:42 INFO - no previously-included directories found matching 'build' 19:09:42 INFO - no previously-included directories found matching 'dist' 19:09:42 INFO - no previously-included directories found matching '.git*' 19:09:42 INFO - Successfully installed jsonschema functools32 19:09:42 INFO - Cleaning up... 19:09:42 INFO - Return code: 0 19:09:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:09: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')]} 19:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09: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')]} 19:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09: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 0x231a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2549400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d8570>, '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 0x25d9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d9900>, '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': '232498196343f89f466a4a9a000001c8-1471658434.74224-2027292900', '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 19:09: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 19:09: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 19:09:42 INFO - Using env: {'DISPLAY': ':0', 19:09:42 INFO - 'HOME': '/home/cltbld', 19:09:42 INFO - 'LANG': 'en_US.UTF-8', 19:09:42 INFO - 'LANGUAGE': 'en_US:en', 19:09:42 INFO - 'LOGNAME': 'cltbld', 19:09:42 INFO - 'MAIL': '/var/mail/cltbld', 19:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:42 INFO - 'MOZ_NO_REMOTE': '1', 19:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:42 INFO - 'NO_EM_RESTART': '1', 19:09:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:42 INFO - 'PWD': '/builds/slave/test', 19:09:42 INFO - 'SHELL': '/bin/bash', 19:09:42 INFO - 'SHLVL': '1', 19:09:42 INFO - 'TERM': 'linux', 19:09:42 INFO - 'TMOUT': '86400', 19:09:42 INFO - 'USER': 'cltbld', 19:09:42 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471658434.74224-2027292900', 19:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:42 INFO - '_': '/tools/buildbot/bin/python'} 19:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:09:42 INFO - Cleaning up... 19:09:42 INFO - Return code: 0 19:09:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:09: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')]} 19:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09: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')]} 19:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09: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 0x231a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2549400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d8570>, '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 0x25d9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d9900>, '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': '232498196343f89f466a4a9a000001c8-1471658434.74224-2027292900', '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 19:09: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 19:09: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 19:09:42 INFO - Using env: {'DISPLAY': ':0', 19:09:42 INFO - 'HOME': '/home/cltbld', 19:09:42 INFO - 'LANG': 'en_US.UTF-8', 19:09:42 INFO - 'LANGUAGE': 'en_US:en', 19:09:42 INFO - 'LOGNAME': 'cltbld', 19:09:42 INFO - 'MAIL': '/var/mail/cltbld', 19:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:42 INFO - 'MOZ_NO_REMOTE': '1', 19:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:42 INFO - 'NO_EM_RESTART': '1', 19:09:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:42 INFO - 'PWD': '/builds/slave/test', 19:09:42 INFO - 'SHELL': '/bin/bash', 19:09:42 INFO - 'SHLVL': '1', 19:09:42 INFO - 'TERM': 'linux', 19:09:42 INFO - 'TMOUT': '86400', 19:09:42 INFO - 'USER': 'cltbld', 19:09:42 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471658434.74224-2027292900', 19:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:42 INFO - '_': '/tools/buildbot/bin/python'} 19:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:42 INFO - Downloading/unpacking blobuploader==1.2.4 19:09: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 19:09: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 19:09: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 19:09: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 19:09: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 19:09: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 19:09:44 INFO - Downloading blobuploader-1.2.4.tar.gz 19:09:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:09:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:09: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 19:09: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 19:09: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 19:09: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 19:09: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 19:09: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 19:09:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:09:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:09: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 19:09: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 19:09: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 19:09: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 19:09: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 19:09: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 19:09:45 INFO - Downloading docopt-0.6.1.tar.gz 19:09:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:09:45 INFO - Installing collected packages: blobuploader, requests, docopt 19:09:45 INFO - Running setup.py install for blobuploader 19:09:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:09:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:09:45 INFO - Running setup.py install for requests 19:09:46 INFO - Running setup.py install for docopt 19:09:46 INFO - Successfully installed blobuploader requests docopt 19:09:46 INFO - Cleaning up... 19:09:46 INFO - Return code: 0 19:09:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:09: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')]} 19:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09: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')]} 19:09:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09: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 0x231a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2549400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d8570>, '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 0x25d9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d9900>, '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': '232498196343f89f466a4a9a000001c8-1471658434.74224-2027292900', '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 19:09: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 19:09: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 19:09:46 INFO - Using env: {'DISPLAY': ':0', 19:09:46 INFO - 'HOME': '/home/cltbld', 19:09:46 INFO - 'LANG': 'en_US.UTF-8', 19:09:46 INFO - 'LANGUAGE': 'en_US:en', 19:09:46 INFO - 'LOGNAME': 'cltbld', 19:09:46 INFO - 'MAIL': '/var/mail/cltbld', 19:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:46 INFO - 'MOZ_NO_REMOTE': '1', 19:09:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:46 INFO - 'NO_EM_RESTART': '1', 19:09:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:46 INFO - 'PWD': '/builds/slave/test', 19:09:46 INFO - 'SHELL': '/bin/bash', 19:09:46 INFO - 'SHLVL': '1', 19:09:46 INFO - 'TERM': 'linux', 19:09:46 INFO - 'TMOUT': '86400', 19:09:46 INFO - 'USER': 'cltbld', 19:09:46 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471658434.74224-2027292900', 19:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:46 INFO - '_': '/tools/buildbot/bin/python'} 19:09:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:09:46 INFO - Running setup.py (path:/tmp/pip-1nGdhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:09:46 INFO - Running setup.py (path:/tmp/pip-thsozH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:09:46 INFO - Running setup.py (path:/tmp/pip-inExZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:09:46 INFO - Running setup.py (path:/tmp/pip-T8pQ59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:09:46 INFO - Running setup.py (path:/tmp/pip-tICmnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:09:46 INFO - Running setup.py (path:/tmp/pip-qTDJLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:09:46 INFO - Running setup.py (path:/tmp/pip-nrcH2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:09:46 INFO - Running setup.py (path:/tmp/pip-2kjstM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:09:46 INFO - Running setup.py (path:/tmp/pip-53h1Z4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:09:47 INFO - Running setup.py (path:/tmp/pip-9VLIfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:09:47 INFO - Running setup.py (path:/tmp/pip-XqqsO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:09:47 INFO - Running setup.py (path:/tmp/pip-9vc4KN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:09:47 INFO - Running setup.py (path:/tmp/pip-zRBhOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:09:47 INFO - Running setup.py (path:/tmp/pip-rQsThi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:09:47 INFO - Running setup.py (path:/tmp/pip-NxGkF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:09:47 INFO - Running setup.py (path:/tmp/pip-nOesh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:09:47 INFO - Running setup.py (path:/tmp/pip-QXimnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:09:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:09:47 INFO - Running setup.py install for manifestparser 19:09:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:09:47 INFO - Running setup.py install for mozcrash 19:09:47 INFO - Running setup.py install for mozdebug 19:09:47 INFO - Running setup.py install for mozdevice 19:09:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:09:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:09:48 INFO - Running setup.py install for mozfile 19:09:48 INFO - Running setup.py install for mozhttpd 19:09:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:09:48 INFO - Running setup.py install for mozinfo 19:09:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:09:48 INFO - Running setup.py install for mozInstall 19:09:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:09:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:09:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:09:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:09:48 INFO - Running setup.py install for mozleak 19:09:48 INFO - Running setup.py install for mozlog 19:09:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:09:48 INFO - Running setup.py install for moznetwork 19:09:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:09:48 INFO - Running setup.py install for mozprocess 19:09:48 INFO - Running setup.py install for mozprofile 19:09:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:09:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:09:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:09:48 INFO - Running setup.py install for mozrunner 19:09:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:09:49 INFO - Running setup.py install for mozscreenshot 19:09:49 INFO - Running setup.py install for moztest 19:09:49 INFO - Running setup.py install for mozversion 19:09:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:09:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:09:49 INFO - Cleaning up... 19:09:49 INFO - Return code: 0 19:09:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:09: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')]} 19:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09: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')]} 19:09:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09: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 0x231a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2549400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d8570>, '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 0x25d9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d9900>, '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': '232498196343f89f466a4a9a000001c8-1471658434.74224-2027292900', '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 19:09: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 19:09: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 19:09:49 INFO - Using env: {'DISPLAY': ':0', 19:09:49 INFO - 'HOME': '/home/cltbld', 19:09:49 INFO - 'LANG': 'en_US.UTF-8', 19:09:49 INFO - 'LANGUAGE': 'en_US:en', 19:09:49 INFO - 'LOGNAME': 'cltbld', 19:09:49 INFO - 'MAIL': '/var/mail/cltbld', 19:09:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:49 INFO - 'MOZ_NO_REMOTE': '1', 19:09:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:49 INFO - 'NO_EM_RESTART': '1', 19:09:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:49 INFO - 'PWD': '/builds/slave/test', 19:09:49 INFO - 'SHELL': '/bin/bash', 19:09:49 INFO - 'SHLVL': '1', 19:09:49 INFO - 'TERM': 'linux', 19:09:49 INFO - 'TMOUT': '86400', 19:09:49 INFO - 'USER': 'cltbld', 19:09:49 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471658434.74224-2027292900', 19:09:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:49 INFO - '_': '/tools/buildbot/bin/python'} 19:09:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:09:49 INFO - Running setup.py (path:/tmp/pip-6dadwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:09: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)) 19:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:09:49 INFO - Running setup.py (path:/tmp/pip-97qOnY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:09: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)) 19:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:09:49 INFO - Running setup.py (path:/tmp/pip-gBxEDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:09: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)) 19:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:09:49 INFO - Running setup.py (path:/tmp/pip-cGCIFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:09: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)) 19:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:09:49 INFO - Running setup.py (path:/tmp/pip-YXKZmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:09:50 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)) 19:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:09:50 INFO - Running setup.py (path:/tmp/pip-wMLWX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:09:50 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)) 19:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:09:50 INFO - Running setup.py (path:/tmp/pip-aMD9Ac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:09: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)) 19:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:09:50 INFO - Running setup.py (path:/tmp/pip-cKvKJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:09: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)) 19:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:09:50 INFO - Running setup.py (path:/tmp/pip-BzzVIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:09: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)) 19:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:09:50 INFO - Running setup.py (path:/tmp/pip-s41f4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:09: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)) 19:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:09:50 INFO - Running setup.py (path:/tmp/pip-QNu1aq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:09: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)) 19:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:09:50 INFO - Running setup.py (path:/tmp/pip-rF4lgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:09: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)) 19:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:09:50 INFO - Running setup.py (path:/tmp/pip-ZHx36J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:09: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)) 19:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:09:50 INFO - Running setup.py (path:/tmp/pip-JyGchV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:09: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)) 19:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:09:50 INFO - Running setup.py (path:/tmp/pip-ltElCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:09: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)) 19:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:09:50 INFO - Running setup.py (path:/tmp/pip-lVeLJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:09: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)) 19:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:09:50 INFO - Running setup.py (path:/tmp/pip-lg4SLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:09: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)) 19:09: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)) 19:09: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)) 19:09: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)) 19:09: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)) 19:09: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)) 19:09:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:09: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 19:09: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 19:09: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 19:09: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 19:09: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 19:09: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 19:09:52 INFO - Downloading blessings-1.6.tar.gz 19:09:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:09:52 INFO - Installing collected packages: blessings 19:09:52 INFO - Running setup.py install for blessings 19:09:52 INFO - Successfully installed blessings 19:09:52 INFO - Cleaning up... 19:09:53 INFO - Return code: 0 19:09:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:09:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:09:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:09:53 INFO - Reading from file tmpfile_stdout 19:09:53 INFO - Current package versions: 19:09:53 INFO - argparse == 1.2.1 19:09:53 INFO - blessings == 1.6 19:09:53 INFO - blobuploader == 1.2.4 19:09:53 INFO - docopt == 0.6.1 19:09:53 INFO - functools32 == 3.2.3-2 19:09:53 INFO - jsonschema == 2.5.1 19:09:53 INFO - manifestparser == 1.1 19:09:53 INFO - mozInstall == 1.12 19:09:53 INFO - mozcrash == 0.17 19:09:53 INFO - mozdebug == 0.1 19:09:53 INFO - mozdevice == 0.48 19:09:53 INFO - mozfile == 1.2 19:09:53 INFO - mozhttpd == 0.7 19:09:53 INFO - mozinfo == 0.9 19:09:53 INFO - mozleak == 0.1 19:09:53 INFO - mozlog == 3.3 19:09:53 INFO - moznetwork == 0.27 19:09:53 INFO - mozprocess == 0.23 19:09:53 INFO - mozprofile == 0.28 19:09:53 INFO - mozrunner == 6.12 19:09:53 INFO - mozscreenshot == 0.1 19:09:53 INFO - mozsystemmonitor == 0.3 19:09:53 INFO - moztest == 0.7 19:09:53 INFO - mozversion == 1.4 19:09:53 INFO - psutil == 3.1.1 19:09:53 INFO - requests == 1.2.3 19:09:53 INFO - wsgiref == 0.1.2 19:09:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:09: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')]} 19:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09: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')]} 19:09:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09: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 0x231a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2549400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d8570>, '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 0x25d9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d9900>, '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': '232498196343f89f466a4a9a000001c8-1471658434.74224-2027292900', '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 19:09: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 19:09: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 19:09:53 INFO - Using env: {'DISPLAY': ':0', 19:09:53 INFO - 'HOME': '/home/cltbld', 19:09:53 INFO - 'LANG': 'en_US.UTF-8', 19:09:53 INFO - 'LANGUAGE': 'en_US:en', 19:09:53 INFO - 'LOGNAME': 'cltbld', 19:09:53 INFO - 'MAIL': '/var/mail/cltbld', 19:09:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:53 INFO - 'MOZ_NO_REMOTE': '1', 19:09:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:53 INFO - 'NO_EM_RESTART': '1', 19:09:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:53 INFO - 'PWD': '/builds/slave/test', 19:09:53 INFO - 'SHELL': '/bin/bash', 19:09:53 INFO - 'SHLVL': '1', 19:09:53 INFO - 'TERM': 'linux', 19:09:53 INFO - 'TMOUT': '86400', 19:09:53 INFO - 'USER': 'cltbld', 19:09:53 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471658434.74224-2027292900', 19:09:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:53 INFO - '_': '/tools/buildbot/bin/python'} 19:09:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09: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)) 19:09: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)) 19:09: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)) 19:09: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)) 19:09: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)) 19:09: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)) 19:09: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)) 19:09: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)) 19:09: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)) 19:09: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)) 19:09: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)) 19:09:53 INFO - Cleaning up... 19:09:53 INFO - Return code: 0 19:09:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:09: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')]} 19:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09: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')]} 19:09:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09: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 0x231a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2549400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d8570>, '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 0x25d9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d9900>, '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': '232498196343f89f466a4a9a000001c8-1471658434.74224-2027292900', '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 19:09: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 19:09: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 19:09:53 INFO - Using env: {'DISPLAY': ':0', 19:09:53 INFO - 'HOME': '/home/cltbld', 19:09:53 INFO - 'LANG': 'en_US.UTF-8', 19:09:53 INFO - 'LANGUAGE': 'en_US:en', 19:09:53 INFO - 'LOGNAME': 'cltbld', 19:09:53 INFO - 'MAIL': '/var/mail/cltbld', 19:09:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:53 INFO - 'MOZ_NO_REMOTE': '1', 19:09:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:53 INFO - 'NO_EM_RESTART': '1', 19:09:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:53 INFO - 'PWD': '/builds/slave/test', 19:09:53 INFO - 'SHELL': '/bin/bash', 19:09:53 INFO - 'SHLVL': '1', 19:09:53 INFO - 'TERM': 'linux', 19:09:53 INFO - 'TMOUT': '86400', 19:09:53 INFO - 'USER': 'cltbld', 19:09:53 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471658434.74224-2027292900', 19:09:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:53 INFO - '_': '/tools/buildbot/bin/python'} 19:09:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:09:53 INFO - Cleaning up... 19:09:53 INFO - Return code: 0 19:09:53 INFO - Running post-action listener: _resource_record_post_action 19:09:53 INFO - Running post-action listener: _start_resource_monitoring 19:09:53 INFO - Starting resource monitoring. 19:09:53 INFO - [mozharness: 2016-08-20 02:09:53.722169Z] Finished create-virtualenv step (success) 19:09:53 INFO - [mozharness: 2016-08-20 02:09:53.722605Z] Running install step. 19:09:53 INFO - Running pre-action listener: _resource_record_pre_action 19:09:53 INFO - Running main action method: install 19:09:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:09:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:09:53 INFO - Reading from file tmpfile_stdout 19:09:53 INFO - Detecting whether we're running mozinstall >=1.0... 19:09:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:09:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:09:54 INFO - Reading from file tmpfile_stdout 19:09:54 INFO - Output received: 19:09:54 INFO - Usage: mozinstall [options] installer 19:09:54 INFO - Options: 19:09:54 INFO - -h, --help show this help message and exit 19:09:54 INFO - -d DEST, --destination=DEST 19:09:54 INFO - Directory to install application into. [default: 19:09:54 INFO - "/builds/slave/test"] 19:09:54 INFO - --app=APP Application being installed. [default: firefox] 19:09:54 INFO - mkdir: /builds/slave/test/build/application 19:09:54 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'] 19:09:54 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 19:10:10 INFO - Reading from file tmpfile_stdout 19:10:10 INFO - Output received: 19:10:10 INFO - /builds/slave/test/build/application/firefox/firefox 19:10:10 INFO - Running post-action listener: _resource_record_post_action 19:10:10 INFO - [mozharness: 2016-08-20 02:10:10.521445Z] Finished install step (success) 19:10:10 INFO - [mozharness: 2016-08-20 02:10:10.521721Z] Running run-tests step. 19:10:10 INFO - Running pre-action listener: _resource_record_pre_action 19:10:10 INFO - Running main action method: run_tests 19:10:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:10:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:10:10 INFO - Python 2.7.3 19:10:10 INFO - Return code: 0 19:10:10 INFO - grabbing minidump binary from tooltool 19:10: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')]} 19:10: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 0x25d8570>, '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 0x25d9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d9900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:10: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 19:10: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 19:10: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 19:10:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:10:10 INFO - Return code: 0 19:10:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:10:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:10:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:10:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:10:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:10: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/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 19:10: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/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 19:10:10 INFO - Using env: {'DISPLAY': ':0', 19:10:10 INFO - 'HOME': '/home/cltbld', 19:10:10 INFO - 'LANG': 'en_US.UTF-8', 19:10:10 INFO - 'LANGUAGE': 'en_US:en', 19:10:10 INFO - 'LOGNAME': 'cltbld', 19:10:10 INFO - 'MAIL': '/var/mail/cltbld', 19:10:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:10:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:10:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:10 INFO - 'MOZ_NO_REMOTE': '1', 19:10:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:10:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:10 INFO - 'NO_EM_RESTART': '1', 19:10:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:10 INFO - 'PWD': '/builds/slave/test', 19:10:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:10:10 INFO - 'SHELL': '/bin/bash', 19:10:10 INFO - 'SHLVL': '1', 19:10:10 INFO - 'TERM': 'linux', 19:10:10 INFO - 'TMOUT': '86400', 19:10:10 INFO - 'USER': 'cltbld', 19:10:10 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471658434.74224-2027292900', 19:10:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:10 INFO - '_': '/tools/buildbot/bin/python'} 19:10: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/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 19:10:10 INFO - mozversion application_buildid: 20160819162415 19:10:10 INFO - mozversion application_changeset: 9aea5a70f2679e59ad80a66785215a10c7073928 19:10:10 INFO - mozversion application_display_name: FirefoxDeveloperEdition 19:10:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:10:10 INFO - mozversion application_name: Firefox 19:10:10 INFO - mozversion application_remotingname: firefox-dev 19:10:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:10:10 INFO - mozversion application_vendor: Mozilla 19:10:10 INFO - mozversion application_version: 50.0a2 19:10:10 INFO - mozversion platform_buildid: 20160819162415 19:10:10 INFO - mozversion platform_changeset: 9aea5a70f2679e59ad80a66785215a10c7073928 19:10:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:10:10 INFO - mozversion platform_version: 50.0a2 19:10:10 INFO - using testdate: 1471659010 19:10:10 INFO - actual date: 1471659010 19:10:10 INFO - starting webserver on 'localhost:50111' 19:10:10 INFO - SUITE-START | Running 2 tests 19:10:10 INFO - TEST-START | dromaeo_css 19:10:10 INFO - operating with platform_type : linux_ 19:10:10 INFO - Initialising browser for dromaeo_css test... 19:10:10 INFO - TEST-INFO | started process 27116 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5TjUWc/profile http://localhost:50111/getInfo.html) 19:10:15 INFO - PROCESS | 27116 | __metrics Screen width/height:1600/1200 19:10:15 INFO - PROCESS | 27116 | colorDepth:24 19:10:15 INFO - PROCESS | 27116 | Browser inner width/height: 1024/697 19:10:15 INFO - PROCESS | 27116 | __metrics 19:10:16 ERROR - PROCESS | 27116 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 19:10:16 INFO - TEST-INFO | 27116: exit 0 19:10:16 INFO - Browser initialized. 19:10:16 INFO - Running cycle 1/1 for dromaeo_css test... 19:10:16 INFO - TEST-INFO | started process 27241 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5TjUWc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:10:28 INFO - PROCESS | 27241 | RSS: Main: 152584192 19:10:28 INFO - PROCESS | 27241 | 19:11:18 INFO - PROCESS | 27241 | 1471659078307 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] 19:13:27 INFO - PROCESS | 27241 | Cycle 1(1): loaded http://localhost:50111/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50111/tests/dromaeo/cssquery-ext.html) 19:13:28 INFO - PROCESS | 27241 | RSS: Main: 158334976 19:13:28 INFO - PROCESS | 27241 | 19:16:30 INFO - PROCESS | 27241 | Cycle 1(1): loaded http://localhost:50111/tests/dromaeo/cssquery-ext.html (next: http://localhost:50111/tests/dromaeo/cssquery-jquery.html) 19:16:30 INFO - PROCESS | 27241 | RSS: Main: 154845184 19:16:30 INFO - PROCESS | 27241 | 19:19:32 INFO - PROCESS | 27241 | Cycle 1(1): loaded http://localhost:50111/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50111/tests/dromaeo/cssquery-mootools.html) 19:19:33 INFO - PROCESS | 27241 | RSS: Main: 154075136 19:19:33 INFO - PROCESS | 27241 | 19:22:35 INFO - PROCESS | 27241 | Cycle 1(1): loaded http://localhost:50111/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50111/tests/dromaeo/cssquery-prototype.html) 19:22:35 INFO - PROCESS | 27241 | RSS: Main: 153096192 19:22:35 INFO - PROCESS | 27241 | 19:25:38 INFO - PROCESS | 27241 | Cycle 1(1): loaded http://localhost:50111/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50111/tests/dromaeo/cssquery-yui.html) 19:25:38 INFO - PROCESS | 27241 | RSS: Main: 155590656 19:25:38 INFO - PROCESS | 27241 | 19:28:41 INFO - PROCESS | 27241 | Cycle 1(1): loaded http://localhost:50111/tests/dromaeo/cssquery-yui.html (next: http://localhost:50111/tests/dromaeo/cssquery-dojo.html) 19:28:41 INFO - PROCESS | 27241 | RSS: Main: 156123136 19:28:41 INFO - PROCESS | 27241 | 19:28:41 INFO - PROCESS | 27241 | __start_tp_report 19:28:41 INFO - PROCESS | 27241 | _x_x_mozilla_page_load 19:28:41 INFO - PROCESS | 27241 | _x_x_mozilla_page_load_details 19:28:41 INFO - PROCESS | 27241 | |i|pagename|runs| 19:28:41 INFO - PROCESS | 27241 | |0;dojo.html;3342.598888133424;3353.849076791544;3357.882474113406;3378.831058447077;3387.068556147059;5833.183354330392;5885.382034886339;5921.230240068796;5922.763089476416;5962.582619216651;5893.528517718583;5935.436133567315;5939.495142912858;5958.9702051489685;5966.37353077927;5359.812406565771;5365.141577347626;5409.24270602116;5447.700376479292;5515.696636684981;5208.76560554774;5213.817516386927;5255.290535777678;5350.625456218067;5399.136138217886;5368.62419630626;5387.649802762808;5404.08130617794;5407.594430417715;5455.699936503491;5448.237246785433;5450.700211488366;5462.235287059815;5463.754131064112;5499.50504454597;5087.9745601272125;5218.895622087575;5237.031149237403;5368.677879327252;5370.355557333106;5788.710564471801;5851.063829787214;5858.76564937402;5863.325717542494;5936.139259807347;6191.380861913818;6307.432331090178;6311.93688063118;6330.430261276461;6336.651484168369;6084.60450070744;6167.907481387782;6195.163652906845;6324.873502529924;6361.045843123522;5865.501432378253;5895.941040589625;5907.556933230025;5911.970440147815;5947.791827286024;6406.2953075161695;6428.582142160744;6448.097266382711;6454.903176452357;6460.353964603502;6066;6121.788327166048;6139.324674285825;6185.474234690012;6189.96905015481;6292.842678933063;6303.716332765037;6342.714577844008;6346.619202847844;6349.111124442582;6288.434040936338;6302.243730752339;6306.590071645328;6318.399752023551;6321.778737744157;6051.213342265477;6127.372786728296;6174.8147555573405;6278.968605156945;6288.779892703734;4734.360861283752;4736.4316282046375;4766.451858036301;4798.712077275374;4840.177169881129;4219.881731341197;4238.919075635693;4241.257779888507;4241.27898257297;4271.914561708749;5820.388859169726;5938.435848594377;5951.732172052268;6004.309504406961;6089.573729838958;6335.303116657164;6375.968120159369;6378.84052898672;6381.1066450696935;6402.071699603532;6063.120847477091;6063.151158837766;6070.119832624245;6077.483413909778;6095.359987201368;5210.739463026909;5289.127293996525;5300.840974770763;5429.701366424884;5429.782808687608;6430.582012169194;6436.131122298523;6491.058796474485;6619.635920024349;6620.172478440195;6318.778842740482;6353.5870168438905;6367.42693157618;6383.840403989938;6414.967925160531;6328.746850126127;6585.111010013587;6631.801045968628;6634.568753031038;6659.034440006269;6113.719560719409;6121.081837724377;6127.111568822585;6229.972054610938;6247.812565623039;6339;6340.746370145327;6352.523560732871;6353.491720662429;6358.523110766803;6001.609895356788;6151.507879369729;6198.504119670506;6201.751929922752;6213.937860621336;6068.8786224276155;6079.3312735598165;6093.969530152498;6128.900367973482;6159.045347971071;6114.37381806568;6117.672834465228;6120.17287048654;6120.242537778241;6124.697728915742;5954.255718035246;6171.691415429121;6217.658028808459;6266.404691554295;6274.403931626488;5976.133460648269;6016.909746353721;6055.9091613626715;6126.639818174547;6136.274005701014 19:28:41 INFO - PROCESS | 27241 | |1;ext.html;593.2139914613136;655.122136337308;657.0177584511155;677.3632785181926;704.3344039882313;42010.57989420109;46271.76864115675;46354;46641;46695.299570506424;47217;47607;47888;47912.76043619777;48002.51997480024;9123.589438475285;9234.353595248336;9247.26021918245;9279.489628070454;9305.906940930605;9260.907390926106;9395.436273823558;9396.34225604208;9399.295052871028;9406.43561386319;9450.4802235877;9488.952555237214;9500.097490738368;9509.857352139723;9531.761705957371;9438.197753190987;9473.242140628734;9481.383710058824;9482.004389539103;9493.382930109521;9249;9267.073292670746;9325.440473571607;9326.160645541933;9350.859737103949;44419.333709994375;44493.777531112464;44830.551694482965;44841.55158448406;44907.101857962654;3738.2710371477574;3848.2688289224957;4376.452943382077;4429.778511074465;4610.05493873755;34741.82629086864;35149.82425087884;35292.823535882155;35308.117297067525;35310.47034294488;4548.176522698824;4599.747013914233;4611.054733779567;4645.326427668003;4717.080169366975;385021;385349;387280;391375;391654;58151;58303.125453118235;58612;58659.413405865394;58669.11996320059;38519.80740096282;40332.39501407481;40742.388864167064;42824.78587607042;68475;19389.612207755767;19578.902105489666;19593.902030489757;19625.21499140047;19626.31307904245;12759.744805103846;12821.487140514462;12830.230186188859;12873.420696068699;12877.678058048623;20928.267510637055;21039.368818935458;21062.684059739116;21081;21177.258795942067;7526.849463010819;7548.7357942472845;7611.1627720950655;7626.54240745557;7748.728794492278;1088.3306766338644;1095.2442814457997;1157.8321143434155;1172.314275762562;1189.500409827857;34740;35258.11854703653;35289.47065794015;35446.468302975474;35600.821995889855;1146.043054049861;1183.8697743248235;1192.4157162990246;1231.8815322335709;1253.254313683357;18085.276588936296;18537.81462185361;18699.784514006547;18725.625487490175;18813.717794233096;562695;568617;570384;572425;572687;64771.35228647747;64870.67564662241;65249.34750652528;65375.67312163504;65458.672706636164;1414.5924804819272;1432.291015947092;1436.2316160853893;1468.8090548228663;1485.376142020354;32568;33880.15299617529;34273.65726342705;34305;34696.65303347035;57036;57352.71323643355;57432.42567574271;57442.42557574538;57456.712716437825;475646;477408;478097;481668;482332;30797.692023079482;31481.527777083822;31502.684973150892;31777.8411107943;31794.364112717154;52801.471985279655;53648;53736.73131634317;53808.19287710609;54515.72742136422;45431.54568454406;45560.31659525176;45614.543854562355;46811.29783053189;48125;45066.549334506235;46880.29679554878;46887.53112468968;47158.29262561133;47179.29231061605;45709.77145114253;46397.536024639325;46502.76748616235;46577.3013404806;48031.519684802704;39024.80487597544;40299.79850100731;40534.18931621292;40630.95131265421;40777.18445631011;30891.84554077305;30992.070237892898;31092.68907310898;31336;31599 19:28:41 INFO - PROCESS | 27241 | |2;jquery.html;401.23764846791096;411.44249541870784;419.53850764159426;420.1953259508042;434.1079082485491;19591.99999999998;20065.097070631837;20868.478288042807;20882.89558552207;21242.25652102177;15815.604609884758;18792.812071879278;18981.576381771352;19425;20199.798002019976;5855.297364316278;6036.5170786336985;6037.184980027684;6039.728212230439;6063.090536419529;5848.590598658096;5932.169496270526;5956.136360227764;5992.43071908168;5998.520118390518;5781.306243250795;5857.76568937242;5906.05503119501;5938.910916336258;5956.16613674086;5695.316562012544;5877.235959325303;5886.293644762613;5899.970500147515;5916.26046744157;5152.948470515322;5292.523672869422;5317.73411329432;5320.866978325535;5327.840164795062;24237;24428.877855610608;24562.263132106065;24588.262352129284;24642.383940401454;2524.0534799450206;2569.0879737693035;2571.3186005708503;2652.0585192256663;2672.786177105827;15140.470083547134;15269.38922443101;15303;15499.5350139496;15807.288672009787;2033.1460786469718;2061.7835127311714;2091.979080209194;2102.4113248290505;2181.683655869906;80682.59658701728;81374.59312703458;82478.17521824705;83050.16949830485;83067.5846620769;11037.337759734442;11169.888301116885;11201.271917325348;11224.607138750105;11290.266132701348;15516;15551.455699050479;15647.374105035899;15671.216439177995;15681.13753743555;7691.5769632670745;7780.4553681242905;7961.164077771867;8013.11855695873;8045.597720114088;7528.698852045966;7602.619869006528;7701.884471732928;7718.691252349955;7779.8833017504785;6750.898736518956;6910.136232970879;6915.654217289115;6950.339717726909;6962.547434416747;1925.210663627906;2105.610462064523;2110.9472263193543;2122.3526824318733;2163.8160756335888;1038.7922415516928;1063.6277302943909;1103.9668809935715;1138.248755821154;1154.2266681323533;21123;21250.468738281666;21429.89285053565;21443.57112857734;21492.785072149392;1042.6507120114695;1047.4073926432259;1094.6278265389647;1126.8985791278824;1172.2497601535024;11250.943745281222;11873.643790686294;11995.320655108291;12005.63983080509;12338.50645974151;504344;513989;520314;521630;523263;80067;80776.32265599808;80968.59515702502;84712;85431.57284213539;1087.1683162380784;1101.3226865477673;1103.674416047268;1105.4583254205381;1109.2734259060328;18278.81721182771;18489.260429583202;18625.254989800796;18665.44003679892;18948.147333370307;40656.39015414712;40676.3898541528;41057.794711026254;41453.37819932643;42623.14753704971;42870;50022.749886250334;50581.24128138007;54292.72853635706;59714;7972.800679983046;9018.954905225432;9161.358704890594;9175.632974680939;9380.577873995822;12358.44387002569;13969.092009019381;14276.500322488662;14369.784453233;14441.78337324962;11950.402479875798;12048.879511205127;12477.75044499123;12581;12911.806322904977;9085.636574536944;11064.391458469861;12089.879101208875;12368.938155309166;12603.054770892037;12398.13213075076;12585.87414125847;12601.747965040831;12778;12866;7936.6428510716005;8242.340612751086;8435.409521333448;8544.615492302986;8672.869906951275;11580;11614.883851161718;12494.312812795384;12671.746565068832;12855.614331570068 19:28:41 INFO - PROCESS | 27241 | |3;mootools.html;1470.6249906273902;1534.1408811065803;1718.458685514063;1830.8169183081686;1873.615908738708;8382.11987741286;9033.63865445383;9520.904790952089;9900.851487227688;9989.350692205011;9069.637214511411;9346.672866449675;9371.34400591959;9376.531173441335;9396.71809845704;2546.4525127097672;2563.4873025394904;2587;2589.59861221511;2590.0546300600336;2482;2535.366158460385;2545.0837698428645;2545.936351591216;2547.2103647869126;2557.6035714464288;2568.203856804387;2593.0794567928397;2594.092067776282;2596.662433883602;2442.792362649177;2475.10896077412;2477.578811602014;2477.8884950177285;2479.962800557993;2504.6994360676654;2505.8496490210646;2509.5482813093636;2511.0207019262502;2517.25740906433;9446.527673616292;9676.95161524195;9846.163076138537;9849.261305402051;9858.457784821832;5675.886482270332;5830.562707796932;5863.912041319383;5865.413458654143;5872.001759700818;3662.7985460799646;3692.7230457715777;3697.205100903319;3699.5930447650735;3797.8480860765535;1130.7229728716518;1254.5734450286946;1262.1480500662108;1268.422867595242;1273.516063895723;13280.136791108547;13551.728965420636;13711.657208569866;13792.793108103488;14043.578692639237;4829.541193586604;4904.705717656952;4909.410870695468;4926.167453714057;5040.042391945519;10737.83893241602;10780.137588992862;10795.29830561011;10824.621138260123;10844.728881778019;5771.249737534094;5775.451332123442;5788.160716696056;5793.15999180125;5803.042497987869;4775.5224477552665;5154;5297.496737809902;5298.576113910878;5410.729463526808;4095.3530299847234;4128.690348223895;4183.5398106208295;4189.4344263524035;4197.195206061423;1214.0530386298701;1254.5420921363636;1254.6863284178955;1255.9372031398393;1265.038570686285;931.8369285375032;1116.8827273136367;1119.4011204005817;1129.2885482146196;1134.1890548258036;6685.665716714145;6690.498212634072;6790.354916282945;6802.183737951477;7005.264447233069;489.8359049718313;516.4602989875589;519.6102922807894;521.0620882411644;521.7912834866084;4649.883752906205;4703.270992996091;4723.976380118146;4765.547273009059;4799.472058073609;12209.69475763113;12431.875681243253;12493.375331233401;12629.494820207088;12662.986961043094;11596.246243994114;12368.134230603771;12426.130170887951;12438.440270187863;12454.190477618926;8815.471071735716;9229.723108306762;9251.074892510695;9251.07489251083;9256.213221876082;6836.042953986545;6845.863082738417;6928.861422771617;7000.894986575104;7026.086608740831;10754.784904302027;11163.218574699693;11182.66452006441;11270.211085223955;11303.43482825839;11035.117190624891;11353.659390218307;11544.134189935621;11544.422778861192;11634.534618615498;7568.772936811904;8394.202550757669;8659.48043117415;8706.085860984758;8985.685501007434;9705.175060119687;9768.511574421393;9792.706218813448;9798.706038818847;9868.901310987085;8550.230479256898;8585.65657373698;8650.524221167896;8682.739517814476;8764.78088047804;8585.742427727178;8612.267957223707;8636.697715579925;8690.608922598625;8717.346199035224;7782.49413788102;7902.762917112495;7908.090569584341;7926.48477848961;7928.722494712657;5730.197772311796;5804.390538993345;5892.381299963614;5943.673097979653;6021.87956240864;5820.097884827858;5873.5594830388745;5882.323532793613;5918.319393269829;5963.73163207648 19:28:41 INFO - PROCESS | 27241 | |4;prototype.html;357.1606724198134;359.7517712778185;360.72224387221837;361.5390377268982;368.865364142088;5834.387389324123;5841.941580584193;5871.412858714127;5889.528837692985;5924.526037916957;5562.7774889004495;5806.071028635419;5810.738516766745;5815.0810232623235;5841.2114364560775;4587.885302867422;4588.1053194626975;4595.632349412056;4602.2636378179495;4611.19304121779;4612.700174488664;4612.7924243409125;4615.492295847454;4620.838270660528;4625.375574297477;4480.8879778005485;4576.725396476206;4589.862304130865;4590.265557510799;4602.424696912886;4499.797509112082;4524.529527903428;4540.318952157187;4542.636589072867;4588.655850811169;4091.3862920562156;4098.610631989956;4104.322786740214;4120.62914337708;4121.836036081051;5651.858703532444;5669;5701.743421546041;5735.677050794393;5743.540516758691;4922.360093187898;5148.459411761749;5155.922661160085;5168.777425706944;5192.3249977503065;6056.5457590680435;6069.635821850703;6092.329843717188;6099.932511810415;6153.138560601519;4140.503139623264;4392.736435813861;4396.340548917656;4418.624416924566;4421.137878113769;6125.632462052291;6231.937680623181;6244.87510249797;6266.467350275232;6314.305426403138;4425.712328698689;4447.3773671685985;4449.443819522559;4454.465464144323;4459.710118842329;4477.597016268486;4507.8196872124745;4509.255972764523;4517.051419202005;4551.8179272829375;4968.8757781055765;5120.820771272987;5164.579740571373;5201.141811601119;5224.52979231871;6067.332593414721;6071.089336599545;6100.176476175659;6164.3835616438;6167.259928808572;1569.7017566662525;1582.1772678207499;1583.762435634664;1588.9761653575206;1592.3073463043613;961.5817119553017;1004.161525126513;1014.6403818882733;1018.7469412622368;1020.2348238820884;5175.353080864892;5220.92168617471;5249.658772179796;5261.921071183935;5307.7080760557765;5559.9444005560235;5580.693061881636;5587.692676902728;5607;5616.5787565932715;4892.358126611661;5217.087009773274;5263.736813159327;5272.657277276965;5289.68261904287;2952.6161598991994;2961.9703802962126;2976.627921509811;2993.521036634128;2995.5656429817554;5590.5248053915875;5598.18059130776;5696.629719068247;5699.316082070178;5749.913751293734;5981.37195594465;6386.265579458422;6442;6453.870922581522;6476.255230648441;6565.752507023651;6583.539152259296;6587.901181482282;6592.670366481657;6609.900851487231;6105.725242364193;6279.215098112736;6291.559590828598;6302.716377763103;6312.495000399865;6221.1336599019205;6242.3133455320785;6254.937450625617;6268.561200715906;6317.557770955989;6319.589226700434;6542.280349161493;6565.704543295658;6577.717345117656;6616.933830661825;4465.464144302705;4530.207213737517;4546.545345465427;4550.34020067095;4553.908921821611;6178.231278919945;6281.560290779602;6400.487960963205;6403.751268502598;6452.580582262138;6131.816045518642;6161.229846269216;6187.597806142587;6212.161358216764;6213.37866213375;5969.552283578836;6185.41238582334;6186.81439556814;6188.504919606331;6214.471769899609;6044.455998960115;6080.69596520181;6089.604175728564;6090.299615544269;6097.359777223328;6193.194884664965;6210.689465526796;6220.693654332641;6233.937660623335;6285.748570057147;5869.178315035983;5996.580239383201;6081.483073938764;6086.391360863879;6103.572749907464 19:28:41 INFO - PROCESS | 27241 | |5;yui.html;831.3183189784377;839.4711331860926;856.310669910722;893.2362829780537;906.2161230535588;15317.617059573502;15940.681186376265;15945.920270398661;15946.441874534394;16313.184340782973;16250.512484625451;16927.80583221891;17104.74342884858;17216.655666886654;17219.483415497554;880.5905254056862;904.9366544341899;905.8641203819413;905.8777065096226;908.4322298563397;855.7860534866284;894.8881389826272;899.9100089991014;903.7966457547033;905.2938707807921;942.3309450290302;946.342292106986;947.4978261521404;950.8145911547251;951.4101257220533;937.6343226141844;943.1652987106426;943.9716808495722;950.2255661635745;952.2905435450565;699.9615021173834;700.4361489001352;701.2076353720314;702.6732569355274;702.7048639571392;16382.508524744277;16529.090900000494;16531.504054878373;16566.83433165677;16673;14413.423463061465;14594.197319147443;14950.626234344229;15342.156181410019;16238.75641865373;12505;13040.869591304061;13078.673033174151;13418.26199559024;13500.054996150273;4138.668906487474;4153.91692166155;4156.43888075112;4323.891902702426;4340.8697739067875;68389.65805170992;70305.19002209824;71367.64316178438;82009.58995204986;88249;11117.221794474472;11387.544498220144;11595.536178552764;11830.053595712323;12354.567590134482;22383.888080559493;22557.887210563844;22787.544249114926;22835.771642283697;22854;9102.271818254523;9152.588133534007;9202.63189472427;9313.161815436642;9460.101290377403;5078.984203159383;5083.517065878736;5097.286379906816;5138.409082955433;5173.844784656466;3782.8865134046023;3848.4419759134767;3874.2445223181207;3879.0884142226555;3904.4338570907057;716.1334784910317;716.3481232078783;724.6920058974914;733.7541923455595;734.1153909538992;790.1190172957112;819.5779173725537;835.9122292159236;857.438377862501;874;10284.640037598649;10506.392329204984;10971.890281097087;11056.11551075912;11371.204015718986;730.649288341599;786.1548835002395;795.777182388932;800.1198681450358;833.5665453963904;4920.532549407801;5304.814331498379;5357.678539287577;5381.811636592779;5424;82255;99419;135044;135656;136204.31897840448;114033.4298328503;115421;115861.42069289599;116686;117308;59794;97146;97411.51294243483;98474;101375.49312253391;9760.804783904425;9850.60597576089;9928;10039.247056470647;10237.078662920372;49068.263976041104;58398.9999999983;58525.70737146287;59392.406075938685;60293.69853150882;51131.744341278056;69408.95886561605;77258;79336.60331698305;79790.60104699439;13044;13521.391537381038;13594.320283985564;13719.588412347646;13787.448502059806;16487.752683709514;16689.33242670328;16793.664126717642;17019.40432084871;17947.102644867442;15637.687246255238;15789.526314210592;16246.106464144586;16355.100469474293;17062.914685426495;15538.611534711723;15605.687886242438;16103.597410064842;16274.349026038826;16607.667846643242;14091.295435228403;14565.781513277521;14631.707365852837;14721.705565888837;15740.527784166494;12246.448909798903;12355.75288494207;12737.235765854079;12858.0999330046;13064.150830196008;12327.50689972391;12978.156419832681;13074.80387794203;13260.867391325963;13295.66760830987 19:28:41 INFO - PROCESS | 27241 | __end_tp_report 19:28:41 INFO - PROCESS | 27241 | __start_cc_report 19:28:41 INFO - PROCESS | 27241 | _x_x_mozilla_cycle_collect,343 19:28:41 INFO - PROCESS | 27241 | __end_cc_report 19:28:41 INFO - PROCESS | 27241 | __startTimestamp1471660121421__endTimestamp 19:28:41 INFO - PROCESS | 27241 | 19:28:41 INFO - PROCESS | 27241 | ------- Summary: start ------- 19:28:41 INFO - PROCESS | 27241 | Number of tests: 6 19:28:41 INFO - PROCESS | 27241 | 19:28:41 INFO - PROCESS | 27241 | [#0] dojo.html Cycles:165 Average:5850.76 Median:6084.60 stddev:679.56 (11.2%) stddev-sans-first:652.54 19:28:41 INFO - PROCESS | 27241 | Values: 3342.6 3353.8 3357.9 3378.8 3387.1 5833.2 5885.4 5921.2 5922.8 5962.6 5893.5 5935.4 5939.5 5959.0 5966.4 5359.8 5365.1 5409.2 5447.7 5515.7 5208.8 5213.8 5255.3 5350.6 5399.1 5368.6 5387.6 5404.1 5407.6 5455.7 5448.2 5450.7 5462.2 5463.8 5499.5 5088.0 5218.9 5237.0 5368.7 5370.4 5788.7 5851.1 5858.8 5863.3 5936.1 6191.4 6307.4 6311.9 6330.4 6336.7 6084.6 6167.9 6195.2 6324.9 6361.0 5865.5 5895.9 5907.6 5912.0 5947.8 6406.3 6428.6 6448.1 6454.9 6460.4 6066.0 6121.8 6139.3 6185.5 6190.0 6292.8 6303.7 6342.7 6346.6 6349.1 6288.4 6302.2 6306.6 6318.4 6321.8 6051.2 6127.4 6174.8 6279.0 6288.8 4734.4 4736.4 4766.5 4798.7 4840.2 4219.9 4238.9 4241.3 4241.3 4271.9 5820.4 5938.4 5951.7 6004.3 6089.6 6335.3 6376.0 6378.8 6381.1 6402.1 6063.1 6063.2 6070.1 6077.5 6095.4 5210.7 5289.1 5300.8 5429.7 5429.8 6430.6 6436.1 6491.1 6619.6 6620.2 6318.8 6353.6 6367.4 6383.8 6415.0 6328.7 6585.1 6631.8 6634.6 6659.0 6113.7 6121.1 6127.1 6230.0 6247.8 6339.0 6340.7 6352.5 6353.5 6358.5 6001.6 6151.5 6198.5 6201.8 6213.9 6068.9 6079.3 6094.0 6128.9 6159.0 6114.4 6117.7 6120.2 6120.2 6124.7 5954.3 6171.7 6217.7 6266.4 6274.4 5976.1 6016.9 6055.9 6126.6 6136.3 19:28:41 INFO - PROCESS | 27241 | 19:28:41 INFO - PROCESS | 27241 | [#1] ext.html Cycles:180 Average:65057.05 Median:4604.90 stddev:128375.92 (2787.8%) stddev-sans-first:128644.81 19:28:41 INFO - PROCESS | 27241 | Values: 593.2 655.1 657.0 677.4 704.3 42010.6 46271.8 46354.0 46641.0 46695.3 47217.0 47607.0 47888.0 47912.8 48002.5 9123.6 9234.4 9247.3 9279.5 9305.9 9260.9 9395.4 9396.3 9399.3 9406.4 9450.5 9489.0 9500.1 9509.9 9531.8 9438.2 9473.2 9481.4 9482.0 9493.4 9249.0 9267.1 9325.4 9326.2 9350.9 44419.3 44493.8 44830.6 44841.6 44907.1 3738.3 3848.3 4376.5 4429.8 4610.1 34741.8 35149.8 35292.8 35308.1 35310.5 4548.2 4599.7 4611.1 4645.3 4717.1 385021.0 385349.0 387280.0 391375.0 391654.0 58151.0 58303.1 58612.0 58659.4 58669.1 38519.8 40332.4 40742.4 42824.8 68475.0 19389.6 19578.9 19593.9 19625.2 19626.3 12759.7 12821.5 12830.2 12873.4 12877.7 20928.3 21039.4 21062.7 21081.0 21177.3 7526.8 7548.7 7611.2 7626.5 7748.7 1088.3 1095.2 1157.8 1172.3 1189.5 34740.0 35258.1 35289.5 35446.5 35600.8 1146.0 1183.9 1192.4 1231.9 1253.3 18085.3 18537.8 18699.8 18725.6 18813.7 562695.0 568617.0 570384.0 572425.0 572687.0 64771.4 64870.7 65249.3 65375.7 65458.7 1414.6 1432.3 1436.2 1468.8 1485.4 32568.0 33880.2 34273.7 34305.0 34696.7 57036.0 57352.7 57432.4 57442.4 57456.7 475646.0 477408.0 478097.0 481668.0 482332.0 30797.7 31481.5 31502.7 31777.8 31794.4 52801.5 53648.0 53736.7 53808.2 54515.7 45431.5 45560.3 45614.5 46811.3 48125.0 45066.5 46880.3 46887.5 47158.3 47179.3 45709.8 46397.5 46502.8 46577.3 48031.5 39024.8 40299.8 40534.2 40631.0 40777.2 30891.8 30992.1 31092.7 31336.0 31599.0 19:28:41 INFO - PROCESS | 27241 | 19:28:41 INFO - PROCESS | 27241 | [#2] jquery.html Cycles:180 Average:29821.62 Median:24495.57 stddev:84754.76 (346.0%) stddev-sans-first:84963.73 19:28:41 INFO - PROCESS | 27241 | Values: 401.2 411.4 419.5 420.2 434.1 19592.0 20065.1 20868.5 20882.9 21242.3 15815.6 18792.8 18981.6 19425.0 20199.8 5855.3 6036.5 6037.2 6039.7 6063.1 5848.6 5932.2 5956.1 5992.4 5998.5 5781.3 5857.8 5906.1 5938.9 5956.2 5695.3 5877.2 5886.3 5900.0 5916.3 5152.9 5292.5 5317.7 5320.9 5327.8 24237.0 24428.9 24562.3 24588.3 24642.4 2524.1 2569.1 2571.3 2652.1 2672.8 15140.5 15269.4 15303.0 15499.5 15807.3 2033.1 2061.8 2092.0 2102.4 2181.7 80682.6 81374.6 82478.2 83050.2 83067.6 11037.3 11169.9 11201.3 11224.6 11290.3 15516.0 15551.5 15647.4 15671.2 15681.1 7691.6 7780.5 7961.2 8013.1 8045.6 7528.7 7602.6 7701.9 7718.7 7779.9 6750.9 6910.1 6915.7 6950.3 6962.5 1925.2 2105.6 2110.9 2122.4 2163.8 1038.8 1063.6 1104.0 1138.2 1154.2 21123.0 21250.5 21429.9 21443.6 21492.8 1042.7 1047.4 1094.6 1126.9 1172.2 11250.9 11873.6 11995.3 12005.6 12338.5 504344.0 513989.0 520314.0 521630.0 523263.0 80067.0 80776.3 80968.6 84712.0 85431.6 1087.2 1101.3 1103.7 1105.5 1109.3 18278.8 18489.3 18625.3 18665.4 18948.1 40656.4 40676.4 41057.8 41453.4 42623.1 42870.0 50022.7 50581.2 54292.7 59714.0 7972.8 9019.0 9161.4 9175.6 9380.6 12358.4 13969.1 14276.5 14369.8 14441.8 11950.4 12048.9 12477.8 12581.0 12911.8 9085.6 11064.4 12089.9 12368.9 12603.1 12398.1 12585.9 12601.7 12778.0 12866.0 7936.6 8242.3 8435.4 8544.6 8672.9 11580.0 11614.9 12494.3 12671.7 12855.6 19:28:41 INFO - PROCESS | 27241 | 19:28:41 INFO - PROCESS | 27241 | [#3] mootools.html Cycles:180 Average:6417.45 Median:2659.69 stddev:3698.95 (139.1%) stddev-sans-first:3690.64 19:28:41 INFO - PROCESS | 27241 | Values: 1470.6 1534.1 1718.5 1830.8 1873.6 8382.1 9033.6 9520.9 9900.9 9989.4 9069.6 9346.7 9371.3 9376.5 9396.7 2546.5 2563.5 2587.0 2589.6 2590.1 2482.0 2535.4 2545.1 2545.9 2547.2 2557.6 2568.2 2593.1 2594.1 2596.7 2442.8 2475.1 2477.6 2477.9 2480.0 2504.7 2505.8 2509.5 2511.0 2517.3 9446.5 9677.0 9846.2 9849.3 9858.5 5675.9 5830.6 5863.9 5865.4 5872.0 3662.8 3692.7 3697.2 3699.6 3797.8 1130.7 1254.6 1262.1 1268.4 1273.5 13280.1 13551.7 13711.7 13792.8 14043.6 4829.5 4904.7 4909.4 4926.2 5040.0 10737.8 10780.1 10795.3 10824.6 10844.7 5771.2 5775.5 5788.2 5793.2 5803.0 4775.5 5154.0 5297.5 5298.6 5410.7 4095.4 4128.7 4183.5 4189.4 4197.2 1214.1 1254.5 1254.7 1255.9 1265.0 931.8 1116.9 1119.4 1129.3 1134.2 6685.7 6690.5 6790.4 6802.2 7005.3 489.8 516.5 519.6 521.1 521.8 4649.9 4703.3 4724.0 4765.5 4799.5 12209.7 12431.9 12493.4 12629.5 12663.0 11596.2 12368.1 12426.1 12438.4 12454.2 8815.5 9229.7 9251.1 9251.1 9256.2 6836.0 6845.9 6928.9 7000.9 7026.1 10754.8 11163.2 11182.7 11270.2 11303.4 11035.1 11353.7 11544.1 11544.4 11634.5 7568.8 8394.2 8659.5 8706.1 8985.7 9705.2 9768.5 9792.7 9798.7 9868.9 8550.2 8585.7 8650.5 8682.7 8764.8 8585.7 8612.3 8636.7 8690.6 8717.3 7782.5 7902.8 7908.1 7926.5 7928.7 5730.2 5804.4 5892.4 5943.7 6021.9 5820.1 5873.6 5882.3 5918.3 5963.7 19:28:41 INFO - PROCESS | 27241 | 19:28:41 INFO - PROCESS | 27241 | [#4] prototype.html Cycles:180 Average:5080.92 Median:5611.79 stddev:1501.26 (26.8%) stddev-sans-first:1463.00 19:28:41 INFO - PROCESS | 27241 | Values: 357.2 359.8 360.7 361.5 368.9 5834.4 5841.9 5871.4 5889.5 5924.5 5562.8 5806.1 5810.7 5815.1 5841.2 4587.9 4588.1 4595.6 4602.3 4611.2 4612.7 4612.8 4615.5 4620.8 4625.4 4480.9 4576.7 4589.9 4590.3 4602.4 4499.8 4524.5 4540.3 4542.6 4588.7 4091.4 4098.6 4104.3 4120.6 4121.8 5651.9 5669.0 5701.7 5735.7 5743.5 4922.4 5148.5 5155.9 5168.8 5192.3 6056.5 6069.6 6092.3 6099.9 6153.1 4140.5 4392.7 4396.3 4418.6 4421.1 6125.6 6231.9 6244.9 6266.5 6314.3 4425.7 4447.4 4449.4 4454.5 4459.7 4477.6 4507.8 4509.3 4517.1 4551.8 4968.9 5120.8 5164.6 5201.1 5224.5 6067.3 6071.1 6100.2 6164.4 6167.3 1569.7 1582.2 1583.8 1589.0 1592.3 961.6 1004.2 1014.6 1018.7 1020.2 5175.4 5220.9 5249.7 5261.9 5307.7 5559.9 5580.7 5587.7 5607.0 5616.6 4892.4 5217.1 5263.7 5272.7 5289.7 2952.6 2962.0 2976.6 2993.5 2995.6 5590.5 5598.2 5696.6 5699.3 5749.9 5981.4 6386.3 6442.0 6453.9 6476.3 6565.8 6583.5 6587.9 6592.7 6609.9 6105.7 6279.2 6291.6 6302.7 6312.5 6221.1 6242.3 6254.9 6268.6 6317.6 6319.6 6542.3 6565.7 6577.7 6616.9 4465.5 4530.2 4546.5 4550.3 4553.9 6178.2 6281.6 6400.5 6403.8 6452.6 6131.8 6161.2 6187.6 6212.2 6213.4 5969.6 6185.4 6186.8 6188.5 6214.5 6044.5 6080.7 6089.6 6090.3 6097.4 6193.2 6210.7 6220.7 6233.9 6285.7 5869.2 5996.6 6081.5 6086.4 6103.6 19:28:41 INFO - PROCESS | 27241 | 19:28:41 INFO - PROCESS | 27241 | [#5] yui.html Cycles:180 Average:22228.09 Median:4021.55 stddev:31991.57 (795.5%) stddev-sans-first:32040.97 19:28:41 INFO - PROCESS | 27241 | Values: 831.3 839.5 856.3 893.2 906.2 15317.6 15940.7 15945.9 15946.4 16313.2 16250.5 16927.8 17104.7 17216.7 17219.5 880.6 904.9 905.9 905.9 908.4 855.8 894.9 899.9 903.8 905.3 942.3 946.3 947.5 950.8 951.4 937.6 943.2 944.0 950.2 952.3 700.0 700.4 701.2 702.7 702.7 16382.5 16529.1 16531.5 16566.8 16673.0 14413.4 14594.2 14950.6 15342.2 16238.8 12505.0 13040.9 13078.7 13418.3 13500.1 4138.7 4153.9 4156.4 4323.9 4340.9 68389.7 70305.2 71367.6 82009.6 88249.0 11117.2 11387.5 11595.5 11830.1 12354.6 22383.9 22557.9 22787.5 22835.8 22854.0 9102.3 9152.6 9202.6 9313.2 9460.1 5079.0 5083.5 5097.3 5138.4 5173.8 3782.9 3848.4 3874.2 3879.1 3904.4 716.1 716.3 724.7 733.8 734.1 790.1 819.6 835.9 857.4 874.0 10284.6 10506.4 10971.9 11056.1 11371.2 730.6 786.2 795.8 800.1 833.6 4920.5 5304.8 5357.7 5381.8 5424.0 82255.0 99419.0 135044.0 135656.0 136204.3 114033.4 115421.0 115861.4 116686.0 117308.0 59794.0 97146.0 97411.5 98474.0 101375.5 9760.8 9850.6 9928.0 10039.2 10237.1 49068.3 58399.0 58525.7 59392.4 60293.7 51131.7 69409.0 77258.0 79336.6 79790.6 13044.0 13521.4 13594.3 13719.6 13787.4 16487.8 16689.3 16793.7 17019.4 17947.1 15637.7 15789.5 16246.1 16355.1 17062.9 15538.6 15605.7 16103.6 16274.3 16607.7 14091.3 14565.8 14631.7 14721.7 15740.5 12246.4 12355.8 12737.2 12858.1 13064.2 12327.5 12978.2 13074.8 13260.9 13295.7 19:28:41 INFO - PROCESS | 27241 | -------- Summary: end -------- 19:28:41 INFO - PROCESS | 27241 | 19:28:42 INFO - TEST-INFO | 27241: exit 0 19:28:42 INFO - TEST-OK | dromaeo_css | took 1111326ms 19:28:42 INFO - TEST-START | kraken 19:28:42 INFO - operating with platform_type : linux_ 19:28:42 INFO - Initialising browser for kraken test... 19:28:42 INFO - TEST-INFO | started process 27500 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxk7_Pu/profile http://localhost:50111/getInfo.html) 19:28:46 INFO - PROCESS | 27500 | __metrics Screen width/height:1600/1200 19:28:46 INFO - PROCESS | 27500 | colorDepth:24 19:28:46 INFO - PROCESS | 27500 | Browser inner width/height: 1024/697 19:28:46 INFO - PROCESS | 27500 | __metrics 19:28:47 ERROR - PROCESS | 27500 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 19:28:47 INFO - TEST-INFO | 27500: exit 0 19:28:47 INFO - Browser initialized. 19:28:47 INFO - Running cycle 1/1 for kraken test... 19:28:47 INFO - TEST-INFO | started process 27626 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxk7_Pu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:28:59 INFO - PROCESS | 27626 | RSS: Main: 152571904 19:28:59 INFO - PROCESS | 27626 | 19:29:02 INFO - PROCESS | 27626 | Cycle 1(1): loaded http://localhost:50111/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50111/tests/kraken/driver.html?testName=audio-beat-detection) 19:29:03 INFO - PROCESS | 27626 | RSS: Main: 158154752 19:29:03 INFO - PROCESS | 27626 | 19:29:05 INFO - PROCESS | 27626 | Cycle 1(1): loaded http://localhost:50111/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50111/tests/kraken/driver.html?testName=audio-dft) 19:29:06 INFO - PROCESS | 27626 | RSS: Main: 156528640 19:29:06 INFO - PROCESS | 27626 | 19:29:09 INFO - PROCESS | 27626 | Cycle 1(1): loaded http://localhost:50111/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50111/tests/kraken/driver.html?testName=audio-fft) 19:29:09 INFO - PROCESS | 27626 | RSS: Main: 157573120 19:29:09 INFO - PROCESS | 27626 | 19:29:11 INFO - PROCESS | 27626 | Cycle 1(1): loaded http://localhost:50111/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50111/tests/kraken/driver.html?testName=audio-oscillator) 19:29:12 INFO - PROCESS | 27626 | RSS: Main: 156844032 19:29:12 INFO - PROCESS | 27626 | 19:29:14 INFO - PROCESS | 27626 | Cycle 1(1): loaded http://localhost:50111/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50111/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:29:15 INFO - PROCESS | 27626 | RSS: Main: 156884992 19:29:15 INFO - PROCESS | 27626 | 19:29:18 INFO - PROCESS | 27626 | Cycle 1(1): loaded http://localhost:50111/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50111/tests/kraken/driver.html?testName=imaging-darkroom) 19:29:18 INFO - PROCESS | 27626 | RSS: Main: 157044736 19:29:18 INFO - PROCESS | 27626 | 19:29:22 INFO - PROCESS | 27626 | Cycle 1(1): loaded http://localhost:50111/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50111/tests/kraken/driver.html?testName=imaging-desaturate) 19:29:22 INFO - PROCESS | 27626 | RSS: Main: 156536832 19:29:22 INFO - PROCESS | 27626 | 19:29:25 INFO - PROCESS | 27626 | Cycle 1(1): loaded http://localhost:50111/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50111/tests/kraken/driver.html?testName=json-parse-financial) 19:29:26 INFO - PROCESS | 27626 | RSS: Main: 157925376 19:29:26 INFO - PROCESS | 27626 | 19:29:27 INFO - PROCESS | 27626 | Cycle 1(1): loaded http://localhost:50111/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50111/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:29:28 INFO - PROCESS | 27626 | RSS: Main: 157073408 19:29:28 INFO - PROCESS | 27626 | 19:29:30 INFO - PROCESS | 27626 | Cycle 1(1): loaded http://localhost:50111/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50111/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:29:30 INFO - PROCESS | 27626 | RSS: Main: 156594176 19:29:30 INFO - PROCESS | 27626 | 19:29:32 INFO - PROCESS | 27626 | Cycle 1(1): loaded http://localhost:50111/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50111/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:29:33 INFO - PROCESS | 27626 | RSS: Main: 157646848 19:29:33 INFO - PROCESS | 27626 | 19:29:36 INFO - PROCESS | 27626 | Cycle 1(1): loaded http://localhost:50111/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50111/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:29:36 INFO - PROCESS | 27626 | RSS: Main: 157843456 19:29:36 INFO - PROCESS | 27626 | 19:29:39 INFO - PROCESS | 27626 | Cycle 1(1): loaded http://localhost:50111/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50111/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:29:39 INFO - PROCESS | 27626 | RSS: Main: 157650944 19:29:39 INFO - PROCESS | 27626 | 19:29:41 INFO - PROCESS | 27626 | Cycle 1(1): loaded http://localhost:50111/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50111/tests/kraken/driver.html?testName=ai-astar) 19:29:41 INFO - PROCESS | 27626 | RSS: Main: 158150656 19:29:41 INFO - PROCESS | 27626 | 19:29:41 INFO - PROCESS | 27626 | __start_tp_report 19:29:41 INFO - PROCESS | 27626 | _x_x_mozilla_page_load 19:29:41 INFO - PROCESS | 27626 | _x_x_mozilla_page_load_details 19:29:41 INFO - PROCESS | 27626 | |i|pagename|runs| 19:29:41 INFO - PROCESS | 27626 | |0;ai-astar;99;111;105;110;111;113;110;111;111;110 19:29:41 INFO - PROCESS | 27626 | |1;audio-beat-detection;143;114;141;167;116;145;148;118;184;116 19:29:41 INFO - PROCESS | 27626 | |2;audio-dft;163;162;162;163;163;166;162;161;162;162 19:29:41 INFO - PROCESS | 27626 | |3;audio-fft;74;74;76;171;75;74;76;76;165;76 19:29:41 INFO - PROCESS | 27626 | |4;audio-oscillator;86;83;144;84;83;84;136;84;84;146 19:29:41 INFO - PROCESS | 27626 | |5;imaging-gaussian-blur;117;118;118;118;117;118;118;119;117;117 19:29:41 INFO - PROCESS | 27626 | |6;imaging-darkroom;147;147;147;148;150;148;147;148;147;148 19:29:41 INFO - PROCESS | 27626 | |7;imaging-desaturate;95;95;95;96;96;95;95;95;96;95 19:29:41 INFO - PROCESS | 27626 | |8;json-parse-financial;53;51;52;51;52;51;52;56;52;52 19:29:41 INFO - PROCESS | 27626 | |9;json-stringify-tinderbox;61;59;59;59;59;58;58;59;58;64 19:29:41 INFO - PROCESS | 27626 | |10;stanford-crypto-aes;78;72;72;72;71;77;78;72;72;81 19:29:41 INFO - PROCESS | 27626 | |11;stanford-crypto-ccm;121;119;123;120;125;126;126;117;167;129 19:29:41 INFO - PROCESS | 27626 | |12;stanford-crypto-pbkdf2;154;165;154;158;150;154;165;153;156;152 19:29:41 INFO - PROCESS | 27626 | |13;stanford-crypto-sha256-iterative;69;66;66;63;67;63;64;64;62;61 19:29:41 INFO - PROCESS | 27626 | __end_tp_report 19:29:41 INFO - PROCESS | 27626 | __start_cc_report 19:29:41 INFO - PROCESS | 27626 | _x_x_mozilla_cycle_collect,872 19:29:41 INFO - PROCESS | 27626 | __end_cc_report 19:29:41 INFO - PROCESS | 27626 | __startTimestamp1471660181910__endTimestamp 19:29:41 INFO - PROCESS | 27626 | 19:29:41 INFO - PROCESS | 27626 | ------- Summary: start ------- 19:29:41 INFO - PROCESS | 27626 | Number of tests: 14 19:29:41 INFO - PROCESS | 27626 | 19:29:41 INFO - PROCESS | 27626 | [#0] ai-astar Cycles:10 Average:109.10 Median:111.00 stddev:4.09 (3.7%) stddev-sans-first:2.17 19:29:41 INFO - PROCESS | 27626 | Values: 99.0 111.0 105.0 110.0 111.0 113.0 110.0 111.0 111.0 110.0 19:29:41 INFO - PROCESS | 27626 | 19:29:41 INFO - PROCESS | 27626 | [#1] audio-beat-detection Cycles:10 Average:139.20 Median:144.00 stddev:23.73 (16.5%) stddev-sans-first:25.13 19:29:41 INFO - PROCESS | 27626 | Values: 143.0 114.0 141.0 167.0 116.0 145.0 148.0 118.0 184.0 116.0 19:29:41 INFO - PROCESS | 27626 | 19:29:41 INFO - PROCESS | 27626 | [#2] audio-dft Cycles:10 Average:162.60 Median:162.50 stddev:1.35 (0.8%) stddev-sans-first:1.42 19:29:41 INFO - PROCESS | 27626 | Values: 163.0 162.0 162.0 163.0 163.0 166.0 162.0 161.0 162.0 162.0 19:29:41 INFO - PROCESS | 27626 | 19:29:41 INFO - PROCESS | 27626 | [#3] audio-fft Cycles:10 Average:93.70 Median:75.50 stddev:39.19 (51.9%) stddev-sans-first:40.92 19:29:41 INFO - PROCESS | 27626 | Values: 74.0 74.0 76.0 171.0 75.0 74.0 76.0 76.0 165.0 76.0 19:29:41 INFO - PROCESS | 27626 | 19:29:41 INFO - PROCESS | 27626 | [#4] audio-oscillator Cycles:10 Average:101.40 Median:84.00 stddev:28.14 (33.5%) stddev-sans-first:29.29 19:29:41 INFO - PROCESS | 27626 | Values: 86.0 83.0 144.0 84.0 83.0 84.0 136.0 84.0 84.0 146.0 19:29:41 INFO - PROCESS | 27626 | 19:29:41 INFO - PROCESS | 27626 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 19:29:41 INFO - PROCESS | 27626 | Values: 117.0 118.0 118.0 118.0 117.0 118.0 118.0 119.0 117.0 117.0 19:29:41 INFO - PROCESS | 27626 | 19:29:41 INFO - PROCESS | 27626 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 19:29:41 INFO - PROCESS | 27626 | Values: 147.0 147.0 147.0 148.0 150.0 148.0 147.0 148.0 147.0 148.0 19:29:41 INFO - PROCESS | 27626 | 19:29:41 INFO - PROCESS | 27626 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 19:29:41 INFO - PROCESS | 27626 | Values: 95.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 96.0 95.0 19:29:41 INFO - PROCESS | 27626 | 19:29:41 INFO - PROCESS | 27626 | [#8] json-parse-financial Cycles:10 Average:52.20 Median:52.00 stddev:1.48 (2.8%) stddev-sans-first:1.54 19:29:41 INFO - PROCESS | 27626 | Values: 53.0 51.0 52.0 51.0 52.0 51.0 52.0 56.0 52.0 52.0 19:29:41 INFO - PROCESS | 27626 | 19:29:41 INFO - PROCESS | 27626 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.00 stddev:1.84 (3.1%) stddev-sans-first:1.86 19:29:41 INFO - PROCESS | 27626 | Values: 61.0 59.0 59.0 59.0 59.0 58.0 58.0 59.0 58.0 64.0 19:29:41 INFO - PROCESS | 27626 | 19:29:41 INFO - PROCESS | 27626 | [#10] stanford-crypto-aes Cycles:10 Average:74.50 Median:74.50 stddev:3.60 (4.8%) stddev-sans-first:3.59 19:29:41 INFO - PROCESS | 27626 | Values: 78.0 72.0 72.0 72.0 71.0 77.0 78.0 72.0 72.0 81.0 19:29:41 INFO - PROCESS | 27626 | 19:29:41 INFO - PROCESS | 27626 | [#11] stanford-crypto-ccm Cycles:10 Average:127.30 Median:125.50 stddev:14.43 (11.5%) stddev-sans-first:15.12 19:29:41 INFO - PROCESS | 27626 | Values: 121.0 119.0 123.0 120.0 125.0 126.0 126.0 117.0 167.0 129.0 19:29:41 INFO - PROCESS | 27626 | 19:29:41 INFO - PROCESS | 27626 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.10 Median:155.00 stddev:5.15 (3.3%) stddev-sans-first:5.41 19:29:41 INFO - PROCESS | 27626 | Values: 154.0 165.0 154.0 158.0 150.0 154.0 165.0 153.0 156.0 152.0 19:29:41 INFO - PROCESS | 27626 | 19:29:41 INFO - PROCESS | 27626 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:65.00 stddev:2.46 (3.8%) stddev-sans-first:2.00 19:29:41 INFO - PROCESS | 27626 | Values: 69.0 66.0 66.0 63.0 67.0 63.0 64.0 64.0 62.0 61.0 19:29:41 INFO - PROCESS | 27626 | -------- Summary: end -------- 19:29:41 INFO - PROCESS | 27626 | 19:29:42 INFO - TEST-INFO | 27626: exit 0 19:29:42 INFO - TEST-OK | kraken | took 60741ms 19:29:42 INFO - SUITE-END | took 1172s 19:29:43 INFO - Completed test suite (00:19:32) 19:29:43 INFO - javascript benchmark 19:29:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7852.368101711815, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3342.598888133424, 3353.849076791544, 3357.882474113406, 3378.831058447077, 3387.068556147059, 5833.183354330392, 5885.382034886339, 5921.230240068796, 5922.763089476416, 5962.582619216651, 5893.528517718583, 5935.436133567315, 5939.495142912858, 5958.9702051489685, 5966.37353077927, 5359.812406565771, 5365.141577347626, 5409.24270602116, 5447.700376479292, 5515.696636684981, 5208.76560554774, 5213.817516386927, 5255.290535777678, 5350.625456218067, 5399.136138217886, 5368.62419630626, 5387.649802762808, 5404.08130617794, 5407.594430417715, 5455.699936503491, 5448.237246785433, 5450.700211488366, 5462.235287059815, 5463.754131064112, 5499.50504454597, 5087.9745601272125, 5218.895622087575, 5237.031149237403, 5368.677879327252, 5370.355557333106, 5788.710564471801, 5851.063829787214, 5858.76564937402, 5863.325717542494, 5936.139259807347, 6191.380861913818, 6307.432331090178, 6311.93688063118, 6330.430261276461, 6336.651484168369, 6084.60450070744, 6167.907481387782, 6195.163652906845, 6324.873502529924, 6361.045843123522, 5865.501432378253, 5895.941040589625, 5907.556933230025, 5911.970440147815, 5947.791827286024, 6406.2953075161695, 6428.582142160744, 6448.097266382711, 6454.903176452357, 6460.353964603502, 6066.0, 6121.788327166048, 6139.324674285825, 6185.474234690012, 6189.96905015481, 6292.842678933063, 6303.716332765037, 6342.714577844008, 6346.619202847844, 6349.111124442582, 6288.434040936338, 6302.243730752339, 6306.590071645328, 6318.399752023551, 6321.778737744157, 6051.213342265477, 6127.372786728296, 6174.8147555573405, 6278.968605156945, 6288.779892703734, 4734.360861283752, 4736.4316282046375, 4766.451858036301, 4798.712077275374, 4840.177169881129, 4219.881731341197, 4238.919075635693, 4241.257779888507, 4241.27898257297, 4271.914561708749, 5820.388859169726, 5938.435848594377, 5951.732172052268, 6004.309504406961, 6089.573729838958, 6335.303116657164, 6375.968120159369, 6378.84052898672, 6381.1066450696935, 6402.071699603532, 6063.120847477091, 6063.151158837766, 6070.119832624245, 6077.483413909778, 6095.359987201368, 5210.739463026909, 5289.127293996525, 5300.840974770763, 5429.701366424884, 5429.782808687608, 6430.582012169194, 6436.131122298523, 6491.058796474485, 6619.635920024349, 6620.172478440195, 6318.778842740482, 6353.5870168438905, 6367.42693157618, 6383.840403989938, 6414.967925160531, 6328.746850126127, 6585.111010013587, 6631.801045968628, 6634.568753031038, 6659.034440006269, 6113.719560719409, 6121.081837724377, 6127.111568822585, 6229.972054610938, 6247.812565623039, 6339.0, 6340.746370145327, 6352.523560732871, 6353.491720662429, 6358.523110766803, 6001.609895356788, 6151.507879369729, 6198.504119670506, 6201.751929922752, 6213.937860621336, 6068.8786224276155, 6079.3312735598165, 6093.969530152498, 6128.900367973482, 6159.045347971071, 6114.37381806568, 6117.672834465228, 6120.17287048654, 6120.242537778241, 6124.697728915742, 5954.255718035246, 6171.691415429121, 6217.658028808459, 6266.404691554295, 6274.403931626488, 5976.133460648269, 6016.909746353721, 6055.9091613626715, 6126.639818174547, 6136.274005701014], "value": 5803.582142692856, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.2139914613136, 655.122136337308, 657.0177584511155, 677.3632785181926, 704.3344039882313, 42010.57989420109, 46271.76864115675, 46354.0, 46641.0, 46695.299570506424, 47217.0, 47607.0, 47888.0, 47912.76043619777, 48002.51997480024, 9123.589438475285, 9234.353595248336, 9247.26021918245, 9279.489628070454, 9305.906940930605, 9260.907390926106, 9395.436273823558, 9396.34225604208, 9399.295052871028, 9406.43561386319, 9450.4802235877, 9488.952555237214, 9500.097490738368, 9509.857352139723, 9531.761705957371, 9438.197753190987, 9473.242140628734, 9481.383710058824, 9482.004389539103, 9493.382930109521, 9249.0, 9267.073292670746, 9325.440473571607, 9326.160645541933, 9350.859737103949, 44419.333709994375, 44493.777531112464, 44830.551694482965, 44841.55158448406, 44907.101857962654, 3738.2710371477574, 3848.2688289224957, 4376.452943382077, 4429.778511074465, 4610.05493873755, 34741.82629086864, 35149.82425087884, 35292.823535882155, 35308.117297067525, 35310.47034294488, 4548.176522698824, 4599.747013914233, 4611.054733779567, 4645.326427668003, 4717.080169366975, 385021.0, 385349.0, 387280.0, 391375.0, 391654.0, 58151.0, 58303.125453118235, 58612.0, 58659.413405865394, 58669.11996320059, 38519.80740096282, 40332.39501407481, 40742.388864167064, 42824.78587607042, 68475.0, 19389.612207755767, 19578.902105489666, 19593.902030489757, 19625.21499140047, 19626.31307904245, 12759.744805103846, 12821.487140514462, 12830.230186188859, 12873.420696068699, 12877.678058048623, 20928.267510637055, 21039.368818935458, 21062.684059739116, 21081.0, 21177.258795942067, 7526.849463010819, 7548.7357942472845, 7611.1627720950655, 7626.54240745557, 7748.728794492278, 1088.3306766338644, 1095.2442814457997, 1157.8321143434155, 1172.314275762562, 1189.500409827857, 34740.0, 35258.11854703653, 35289.47065794015, 35446.468302975474, 35600.821995889855, 1146.043054049861, 1183.8697743248235, 1192.4157162990246, 1231.8815322335709, 1253.254313683357, 18085.276588936296, 18537.81462185361, 18699.784514006547, 18725.625487490175, 18813.717794233096, 562695.0, 568617.0, 570384.0, 572425.0, 572687.0, 64771.35228647747, 64870.67564662241, 65249.34750652528, 65375.67312163504, 65458.672706636164, 1414.5924804819272, 1432.291015947092, 1436.2316160853893, 1468.8090548228663, 1485.376142020354, 32568.0, 33880.15299617529, 34273.65726342705, 34305.0, 34696.65303347035, 57036.0, 57352.71323643355, 57432.42567574271, 57442.42557574538, 57456.712716437825, 475646.0, 477408.0, 478097.0, 481668.0, 482332.0, 30797.692023079482, 31481.527777083822, 31502.684973150892, 31777.8411107943, 31794.364112717154, 52801.471985279655, 53648.0, 53736.73131634317, 53808.19287710609, 54515.72742136422, 45431.54568454406, 45560.31659525176, 45614.543854562355, 46811.29783053189, 48125.0, 45066.549334506235, 46880.29679554878, 46887.53112468968, 47158.29262561133, 47179.29231061605, 45709.77145114253, 46397.536024639325, 46502.76748616235, 46577.3013404806, 48031.519684802704, 39024.80487597544, 40299.79850100731, 40534.18931621292, 40630.95131265421, 40777.18445631011, 30891.84554077305, 30992.070237892898, 31092.68907310898, 31336.0, 31599.0], "value": 21695.83376589501, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.23764846791096, 411.44249541870784, 419.53850764159426, 420.1953259508042, 434.1079082485491, 19591.99999999998, 20065.097070631837, 20868.478288042807, 20882.89558552207, 21242.25652102177, 15815.604609884758, 18792.812071879278, 18981.576381771352, 19425.0, 20199.798002019976, 5855.297364316278, 6036.5170786336985, 6037.184980027684, 6039.728212230439, 6063.090536419529, 5848.590598658096, 5932.169496270526, 5956.136360227764, 5992.43071908168, 5998.520118390518, 5781.306243250795, 5857.76568937242, 5906.05503119501, 5938.910916336258, 5956.16613674086, 5695.316562012544, 5877.235959325303, 5886.293644762613, 5899.970500147515, 5916.26046744157, 5152.948470515322, 5292.523672869422, 5317.73411329432, 5320.866978325535, 5327.840164795062, 24237.0, 24428.877855610608, 24562.263132106065, 24588.262352129284, 24642.383940401454, 2524.0534799450206, 2569.0879737693035, 2571.3186005708503, 2652.0585192256663, 2672.786177105827, 15140.470083547134, 15269.38922443101, 15303.0, 15499.5350139496, 15807.288672009787, 2033.1460786469718, 2061.7835127311714, 2091.979080209194, 2102.4113248290505, 2181.683655869906, 80682.59658701728, 81374.59312703458, 82478.17521824705, 83050.16949830485, 83067.5846620769, 11037.337759734442, 11169.888301116885, 11201.271917325348, 11224.607138750105, 11290.266132701348, 15516.0, 15551.455699050479, 15647.374105035899, 15671.216439177995, 15681.13753743555, 7691.5769632670745, 7780.4553681242905, 7961.164077771867, 8013.11855695873, 8045.597720114088, 7528.698852045966, 7602.619869006528, 7701.884471732928, 7718.691252349955, 7779.8833017504785, 6750.898736518956, 6910.136232970879, 6915.654217289115, 6950.339717726909, 6962.547434416747, 1925.210663627906, 2105.610462064523, 2110.9472263193543, 2122.3526824318733, 2163.8160756335888, 1038.7922415516928, 1063.6277302943909, 1103.9668809935715, 1138.248755821154, 1154.2266681323533, 21123.0, 21250.468738281666, 21429.89285053565, 21443.57112857734, 21492.785072149392, 1042.6507120114695, 1047.4073926432259, 1094.6278265389647, 1126.8985791278824, 1172.2497601535024, 11250.943745281222, 11873.643790686294, 11995.320655108291, 12005.63983080509, 12338.50645974151, 504344.0, 513989.0, 520314.0, 521630.0, 523263.0, 80067.0, 80776.32265599808, 80968.59515702502, 84712.0, 85431.57284213539, 1087.1683162380784, 1101.3226865477673, 1103.674416047268, 1105.4583254205381, 1109.2734259060328, 18278.81721182771, 18489.260429583202, 18625.254989800796, 18665.44003679892, 18948.147333370307, 40656.39015414712, 40676.3898541528, 41057.794711026254, 41453.37819932643, 42623.14753704971, 42870.0, 50022.749886250334, 50581.24128138007, 54292.72853635706, 59714.0, 7972.800679983046, 9018.954905225432, 9161.358704890594, 9175.632974680939, 9380.577873995822, 12358.44387002569, 13969.092009019381, 14276.500322488662, 14369.784453233, 14441.78337324962, 11950.402479875798, 12048.879511205127, 12477.75044499123, 12581.0, 12911.806322904977, 9085.636574536944, 11064.391458469861, 12089.879101208875, 12368.938155309166, 12603.054770892037, 12398.13213075076, 12585.87414125847, 12601.747965040831, 12778.0, 12866.0, 7936.6428510716005, 8242.340612751086, 8435.409521333448, 8544.615492302986, 8672.869906951275, 11580.0, 11614.883851161718, 12494.312812795384, 12671.746565068832, 12855.614331570068], "value": 9710.141052926716, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1470.6249906273902, 1534.1408811065803, 1718.458685514063, 1830.8169183081686, 1873.615908738708, 8382.11987741286, 9033.63865445383, 9520.904790952089, 9900.851487227688, 9989.350692205011, 9069.637214511411, 9346.672866449675, 9371.34400591959, 9376.531173441335, 9396.71809845704, 2546.4525127097672, 2563.4873025394904, 2587.0, 2589.59861221511, 2590.0546300600336, 2482.0, 2535.366158460385, 2545.0837698428645, 2545.936351591216, 2547.2103647869126, 2557.6035714464288, 2568.203856804387, 2593.0794567928397, 2594.092067776282, 2596.662433883602, 2442.792362649177, 2475.10896077412, 2477.578811602014, 2477.8884950177285, 2479.962800557993, 2504.6994360676654, 2505.8496490210646, 2509.5482813093636, 2511.0207019262502, 2517.25740906433, 9446.527673616292, 9676.95161524195, 9846.163076138537, 9849.261305402051, 9858.457784821832, 5675.886482270332, 5830.562707796932, 5863.912041319383, 5865.413458654143, 5872.001759700818, 3662.7985460799646, 3692.7230457715777, 3697.205100903319, 3699.5930447650735, 3797.8480860765535, 1130.7229728716518, 1254.5734450286946, 1262.1480500662108, 1268.422867595242, 1273.516063895723, 13280.136791108547, 13551.728965420636, 13711.657208569866, 13792.793108103488, 14043.578692639237, 4829.541193586604, 4904.705717656952, 4909.410870695468, 4926.167453714057, 5040.042391945519, 10737.83893241602, 10780.137588992862, 10795.29830561011, 10824.621138260123, 10844.728881778019, 5771.249737534094, 5775.451332123442, 5788.160716696056, 5793.15999180125, 5803.042497987869, 4775.5224477552665, 5154.0, 5297.496737809902, 5298.576113910878, 5410.729463526808, 4095.3530299847234, 4128.690348223895, 4183.5398106208295, 4189.4344263524035, 4197.195206061423, 1214.0530386298701, 1254.5420921363636, 1254.6863284178955, 1255.9372031398393, 1265.038570686285, 931.8369285375032, 1116.8827273136367, 1119.4011204005817, 1129.2885482146196, 1134.1890548258036, 6685.665716714145, 6690.498212634072, 6790.354916282945, 6802.183737951477, 7005.264447233069, 489.8359049718313, 516.4602989875589, 519.6102922807894, 521.0620882411644, 521.7912834866084, 4649.883752906205, 4703.270992996091, 4723.976380118146, 4765.547273009059, 4799.472058073609, 12209.69475763113, 12431.875681243253, 12493.375331233401, 12629.494820207088, 12662.986961043094, 11596.246243994114, 12368.134230603771, 12426.130170887951, 12438.440270187863, 12454.190477618926, 8815.471071735716, 9229.723108306762, 9251.074892510695, 9251.07489251083, 9256.213221876082, 6836.042953986545, 6845.863082738417, 6928.861422771617, 7000.894986575104, 7026.086608740831, 10754.784904302027, 11163.218574699693, 11182.66452006441, 11270.211085223955, 11303.43482825839, 11035.117190624891, 11353.659390218307, 11544.134189935621, 11544.422778861192, 11634.534618615498, 7568.772936811904, 8394.202550757669, 8659.48043117415, 8706.085860984758, 8985.685501007434, 9705.175060119687, 9768.511574421393, 9792.706218813448, 9798.706038818847, 9868.901310987085, 8550.230479256898, 8585.65657373698, 8650.524221167896, 8682.739517814476, 8764.78088047804, 8585.742427727178, 8612.267957223707, 8636.697715579925, 8690.608922598625, 8717.346199035224, 7782.49413788102, 7902.762917112495, 7908.090569584341, 7926.48477848961, 7928.722494712657, 5730.197772311796, 5804.390538993345, 5892.381299963614, 5943.673097979653, 6021.87956240864, 5820.097884827858, 5873.5594830388745, 5882.323532793613, 5918.319393269829, 5963.73163207648], "value": 5021.767328921949, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.1606724198134, 359.7517712778185, 360.72224387221837, 361.5390377268982, 368.865364142088, 5834.387389324123, 5841.941580584193, 5871.412858714127, 5889.528837692985, 5924.526037916957, 5562.7774889004495, 5806.071028635419, 5810.738516766745, 5815.0810232623235, 5841.2114364560775, 4587.885302867422, 4588.1053194626975, 4595.632349412056, 4602.2636378179495, 4611.19304121779, 4612.700174488664, 4612.7924243409125, 4615.492295847454, 4620.838270660528, 4625.375574297477, 4480.8879778005485, 4576.725396476206, 4589.862304130865, 4590.265557510799, 4602.424696912886, 4499.797509112082, 4524.529527903428, 4540.318952157187, 4542.636589072867, 4588.655850811169, 4091.3862920562156, 4098.610631989956, 4104.322786740214, 4120.62914337708, 4121.836036081051, 5651.858703532444, 5669.0, 5701.743421546041, 5735.677050794393, 5743.540516758691, 4922.360093187898, 5148.459411761749, 5155.922661160085, 5168.777425706944, 5192.3249977503065, 6056.5457590680435, 6069.635821850703, 6092.329843717188, 6099.932511810415, 6153.138560601519, 4140.503139623264, 4392.736435813861, 4396.340548917656, 4418.624416924566, 4421.137878113769, 6125.632462052291, 6231.937680623181, 6244.87510249797, 6266.467350275232, 6314.305426403138, 4425.712328698689, 4447.3773671685985, 4449.443819522559, 4454.465464144323, 4459.710118842329, 4477.597016268486, 4507.8196872124745, 4509.255972764523, 4517.051419202005, 4551.8179272829375, 4968.8757781055765, 5120.820771272987, 5164.579740571373, 5201.141811601119, 5224.52979231871, 6067.332593414721, 6071.089336599545, 6100.176476175659, 6164.3835616438, 6167.259928808572, 1569.7017566662525, 1582.1772678207499, 1583.762435634664, 1588.9761653575206, 1592.3073463043613, 961.5817119553017, 1004.161525126513, 1014.6403818882733, 1018.7469412622368, 1020.2348238820884, 5175.353080864892, 5220.92168617471, 5249.658772179796, 5261.921071183935, 5307.7080760557765, 5559.9444005560235, 5580.693061881636, 5587.692676902728, 5607.0, 5616.5787565932715, 4892.358126611661, 5217.087009773274, 5263.736813159327, 5272.657277276965, 5289.68261904287, 2952.6161598991994, 2961.9703802962126, 2976.627921509811, 2993.521036634128, 2995.5656429817554, 5590.5248053915875, 5598.18059130776, 5696.629719068247, 5699.316082070178, 5749.913751293734, 5981.37195594465, 6386.265579458422, 6442.0, 6453.870922581522, 6476.255230648441, 6565.752507023651, 6583.539152259296, 6587.901181482282, 6592.670366481657, 6609.900851487231, 6105.725242364193, 6279.215098112736, 6291.559590828598, 6302.716377763103, 6312.495000399865, 6221.1336599019205, 6242.3133455320785, 6254.937450625617, 6268.561200715906, 6317.557770955989, 6319.589226700434, 6542.280349161493, 6565.704543295658, 6577.717345117656, 6616.933830661825, 4465.464144302705, 4530.207213737517, 4546.545345465427, 4550.34020067095, 4553.908921821611, 6178.231278919945, 6281.560290779602, 6400.487960963205, 6403.751268502598, 6452.580582262138, 6131.816045518642, 6161.229846269216, 6187.597806142587, 6212.161358216764, 6213.37866213375, 5969.552283578836, 6185.41238582334, 6186.81439556814, 6188.504919606331, 6214.471769899609, 6044.455998960115, 6080.69596520181, 6089.604175728564, 6090.299615544269, 6097.359777223328, 6193.194884664965, 6210.689465526796, 6220.693654332641, 6233.937660623335, 6285.748570057147, 5869.178315035983, 5996.580239383201, 6081.483073938764, 6086.391360863879, 6103.572749907464], "value": 4601.836852053493, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [831.3183189784377, 839.4711331860926, 856.310669910722, 893.2362829780537, 906.2161230535588, 15317.617059573502, 15940.681186376265, 15945.920270398661, 15946.441874534394, 16313.184340782973, 16250.512484625451, 16927.80583221891, 17104.74342884858, 17216.655666886654, 17219.483415497554, 880.5905254056862, 904.9366544341899, 905.8641203819413, 905.8777065096226, 908.4322298563397, 855.7860534866284, 894.8881389826272, 899.9100089991014, 903.7966457547033, 905.2938707807921, 942.3309450290302, 946.342292106986, 947.4978261521404, 950.8145911547251, 951.4101257220533, 937.6343226141844, 943.1652987106426, 943.9716808495722, 950.2255661635745, 952.2905435450565, 699.9615021173834, 700.4361489001352, 701.2076353720314, 702.6732569355274, 702.7048639571392, 16382.508524744277, 16529.090900000494, 16531.504054878373, 16566.83433165677, 16673.0, 14413.423463061465, 14594.197319147443, 14950.626234344229, 15342.156181410019, 16238.75641865373, 12505.0, 13040.869591304061, 13078.673033174151, 13418.26199559024, 13500.054996150273, 4138.668906487474, 4153.91692166155, 4156.43888075112, 4323.891902702426, 4340.8697739067875, 68389.65805170992, 70305.19002209824, 71367.64316178438, 82009.58995204986, 88249.0, 11117.221794474472, 11387.544498220144, 11595.536178552764, 11830.053595712323, 12354.567590134482, 22383.888080559493, 22557.887210563844, 22787.544249114926, 22835.771642283697, 22854.0, 9102.271818254523, 9152.588133534007, 9202.63189472427, 9313.161815436642, 9460.101290377403, 5078.984203159383, 5083.517065878736, 5097.286379906816, 5138.409082955433, 5173.844784656466, 3782.8865134046023, 3848.4419759134767, 3874.2445223181207, 3879.0884142226555, 3904.4338570907057, 716.1334784910317, 716.3481232078783, 724.6920058974914, 733.7541923455595, 734.1153909538992, 790.1190172957112, 819.5779173725537, 835.9122292159236, 857.438377862501, 874.0, 10284.640037598649, 10506.392329204984, 10971.890281097087, 11056.11551075912, 11371.204015718986, 730.649288341599, 786.1548835002395, 795.777182388932, 800.1198681450358, 833.5665453963904, 4920.532549407801, 5304.814331498379, 5357.678539287577, 5381.811636592779, 5424.0, 82255.0, 99419.0, 135044.0, 135656.0, 136204.31897840448, 114033.4298328503, 115421.0, 115861.42069289599, 116686.0, 117308.0, 59794.0, 97146.0, 97411.51294243483, 98474.0, 101375.49312253391, 9760.804783904425, 9850.60597576089, 9928.0, 10039.247056470647, 10237.078662920372, 49068.263976041104, 58398.9999999983, 58525.70737146287, 59392.406075938685, 60293.69853150882, 51131.744341278056, 69408.95886561605, 77258.0, 79336.60331698305, 79790.60104699439, 13044.0, 13521.391537381038, 13594.320283985564, 13719.588412347646, 13787.448502059806, 16487.752683709514, 16689.33242670328, 16793.664126717642, 17019.40432084871, 17947.102644867442, 15637.687246255238, 15789.526314210592, 16246.106464144586, 16355.100469474293, 17062.914685426495, 15538.611534711723, 15605.687886242438, 16103.597410064842, 16274.349026038826, 16607.667846643242, 14091.295435228403, 14565.781513277521, 14631.707365852837, 14721.705565888837, 15740.527784166494, 12246.448909798903, 12355.75288494207, 12737.235765854079, 12858.0999330046, 13064.150830196008, 12327.50689972391, 12978.156419832681, 13074.80387794203, 13260.867391325963, 13295.66760830987], "value": 8296.160614678147, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1500.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 111.0, 105.0, 110.0, 111.0, 113.0, 110.0, 111.0, 111.0, 110.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 114.0, 141.0, 167.0, 116.0, 145.0, 148.0, 118.0, 184.0, 116.0], "value": 139.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 163.0, 163.0, 166.0, 162.0, 161.0, 162.0, 162.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 171.0, 75.0, 74.0, 76.0, 76.0, 165.0, 76.0], "value": 93.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 144.0, 84.0, 83.0, 84.0, 136.0, 84.0, 84.0, 146.0], "value": 101.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 119.0, 117.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 150.0, 148.0, 147.0, 148.0, 147.0, 148.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 52.0, 51.0, 52.0, 51.0, 52.0, 56.0, 52.0, 52.0], "value": 52.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 59.0, 59.0, 59.0, 58.0, 58.0, 59.0, 58.0, 64.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 72.0, 72.0, 72.0, 71.0, 77.0, 78.0, 72.0, 72.0, 81.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 119.0, 123.0, 120.0, 125.0, 126.0, 126.0, 117.0, 167.0, 129.0], "value": 127.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 165.0, 154.0, 158.0, 150.0, 154.0, 165.0, 153.0, 156.0, 152.0], "value": 156.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 66.0, 63.0, 67.0, 63.0, 64.0, 64.0, 62.0, 61.0], "value": 64.5, "unit": "score"}]}]} 19:29:43 INFO - Return code: 0 19:29:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:29:43 ERROR - # TBPL SUCCESS # 19:29:43 INFO - Running post-action listener: _resource_record_post_action 19:29:43 INFO - [mozharness: 2016-08-20 02:29:43.208738Z] Finished run-tests step (success) 19:29:43 INFO - Running post-run listener: _resource_record_post_run 19:29:43 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 266240; Write bytes: 328286208; Read time: 32; Write time: 194040 19:29:43 INFO - TinderboxPrint: CPU usage
13.2% 19:29:43 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 32 19:29:43 INFO - TinderboxPrint: I/O write bytes / time
328,286,208 / 194,040 19:29:43 INFO - TinderboxPrint: CPU idle
8,230.1 (86.7%) 19:29:43 INFO - TinderboxPrint: CPU user
1,199.4 (12.6%) 19:29:43 INFO - TinderboxPrint: Swap in / out
0 / 0 19:29:43 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 77049856; Read time: 0; Write time: 37672 19:29:43 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 266240; Write bytes: 250957824; Read time: 32; Write time: 156332 19:29:43 INFO - Running post-run listener: _upload_blobber_files 19:29:43 INFO - Blob upload gear active. 19:29:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:29:43 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 19:29:43 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'] 19:29:43 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 19:29:44 INFO - (blobuploader) - INFO - Open directory for files ... 19:29:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:29:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:29:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:29:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:29:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:29:49 INFO - (blobuploader) - INFO - Done attempting. 19:29:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:29:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:29:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:29:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:29:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:29:50 INFO - (blobuploader) - INFO - Done attempting. 19:29:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:29:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:29:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:29:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:29:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:29:50 INFO - (blobuploader) - INFO - Done attempting. 19:29:50 INFO - (blobuploader) - INFO - Iteration through files over. 19:29:50 INFO - Return code: 0 19:29:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:29:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:29:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/52d9901ca48a89c34b2b3bef4f58dd64d13dfef3c36067bac5b4abf49434c291484374e3b32694df3ce1ece371d07e7620a6105ba7f8687bb390a0a56b6287fe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be0562552151a8da4b116eecca383c45e7a4730536c6a6578eb336d7f18c2b0936e96f1e2f2ced132ca1c8b606e32f48e06d478e870a137440ebf600932c5667", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45ab2e4ac5dac42b6eb8ea66c0e1131c052a8314ea8b29c0b3a158613ec49de094dcde71a008b444c31b7c53f1c9b59add5985cbf4e533024002ffbb849e3151"} 19:29:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:29:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:29:50 INFO - Contents: 19:29:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/52d9901ca48a89c34b2b3bef4f58dd64d13dfef3c36067bac5b4abf49434c291484374e3b32694df3ce1ece371d07e7620a6105ba7f8687bb390a0a56b6287fe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be0562552151a8da4b116eecca383c45e7a4730536c6a6578eb336d7f18c2b0936e96f1e2f2ced132ca1c8b606e32f48e06d478e870a137440ebf600932c5667", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45ab2e4ac5dac42b6eb8ea66c0e1131c052a8314ea8b29c0b3a158613ec49de094dcde71a008b444c31b7c53f1c9b59add5985cbf4e533024002ffbb849e3151"} 19:29:50 INFO - Running post-run listener: copy_logs_to_upload_dir 19:29:50 INFO - Copying logs to upload dir... 19:29:50 INFO - mkdir: /builds/slave/test/build/upload/logs 19:29:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1678.534865 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 58 secs) (at 2016-08-19 19:29:50.399218) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 19:29:50.402577) ========= 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=232498196343f89f466a4a9a000001c8-1471658434.74224-2027292900 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/52d9901ca48a89c34b2b3bef4f58dd64d13dfef3c36067bac5b4abf49434c291484374e3b32694df3ce1ece371d07e7620a6105ba7f8687bb390a0a56b6287fe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be0562552151a8da4b116eecca383c45e7a4730536c6a6578eb336d7f18c2b0936e96f1e2f2ced132ca1c8b606e32f48e06d478e870a137440ebf600932c5667", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45ab2e4ac5dac42b6eb8ea66c0e1131c052a8314ea8b29c0b3a158613ec49de094dcde71a008b444c31b7c53f1c9b59add5985cbf4e533024002ffbb849e3151"} build_url:https://queue.taskcluster.net/v1/task/T0IkbK3NTECacQ_W7ljJAQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011198 build_url: 'https://queue.taskcluster.net/v1/task/T0IkbK3NTECacQ_W7ljJAQ/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/52d9901ca48a89c34b2b3bef4f58dd64d13dfef3c36067bac5b4abf49434c291484374e3b32694df3ce1ece371d07e7620a6105ba7f8687bb390a0a56b6287fe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be0562552151a8da4b116eecca383c45e7a4730536c6a6578eb336d7f18c2b0936e96f1e2f2ced132ca1c8b606e32f48e06d478e870a137440ebf600932c5667", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45ab2e4ac5dac42b6eb8ea66c0e1131c052a8314ea8b29c0b3a158613ec49de094dcde71a008b444c31b7c53f1c9b59add5985cbf4e533024002ffbb849e3151"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 19:29:50.428380) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 19:29:50.428735) ========= 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=232498196343f89f466a4a9a000001c8-1471658434.74224-2027292900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004413 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 19:29:50.513862) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 19:29:50.514208) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 19:29:50.514515) ========= ========= Total master_lag: 0.16 =========