builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-006 starttime: 1472502323.68 results: success (0) buildid: 20160829102231 builduid: 22fe23d2699145c5873ec15d49d44bb4 revision: 350ef810694c3704431f65c91bd83b9f2e933622 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 13:25:23.675716) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 13:25:23.676700) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 13:25:23.677415) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 13:25:23.693832) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 13:25:23.694498) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1472502322.623800-82203651 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-29 13:25:23-- 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% 30.2M=0s 2016-08-29 13:25:23 (30.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123429 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 13:25:23.836702) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 13:25:23.837582) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1472502322.623800-82203651 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016499 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 13:25:23.890778) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-29 13:25:23.891615) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 350ef810694c3704431f65c91bd83b9f2e933622 --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 350ef810694c3704431f65c91bd83b9f2e933622 --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=e31afd3c0f0de4e86ebe4d94000001b5-1472502322.623800-82203651 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-29 13:25:23,977 truncating revision to first 12 chars 2016-08-29 13:25:23,978 Setting DEBUG logging. 2016-08-29 13:25:23,978 attempt 1/10 2016-08-29 13:25:23,978 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/350ef810694c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-29 13:25:25,107 unpacking tar archive at: mozilla-aurora-350ef810694c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.440427 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-29 13:25:25.347681) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 13:25:25.348091) ========= script_repo_revision: 350ef810694c3704431f65c91bd83b9f2e933622 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 13:25:25.348560) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 13:25:25.348889) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 13:25:25.359186) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 56 secs) (at 2016-08-29 13:25:25.359488) ========= /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=e31afd3c0f0de4e86ebe4d94000001b5-1472502322.623800-82203651 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:25:25 INFO - MultiFileLogger online at 20160829 13:25:25 in /builds/slave/test 13:25:25 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 13:25:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:25:25 INFO - {'append_to_log': False, 13:25:25 INFO - 'base_work_dir': '/builds/slave/test', 13:25:25 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:25:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:25:25 INFO - 'branch': 'Mozilla-Aurora', 13:25:25 INFO - 'buildbot_json_path': 'buildprops.json', 13:25:25 INFO - 'config_files': ('talos/linux_config.py',), 13:25:25 INFO - 'default_actions': ('clobber', 13:25:25 INFO - 'read-buildbot-config', 13:25:25 INFO - 'download-and-extract', 13:25:25 INFO - 'populate-webroot', 13:25:25 INFO - 'create-virtualenv', 13:25:25 INFO - 'install', 13:25:25 INFO - 'run-tests'), 13:25:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:25:25 INFO - 'download_minidump_stackwalk': True, 13:25:25 INFO - 'download_symbols': 'ondemand', 13:25:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:25:25 INFO - 'tooltool.py': '/tools/tooltool.py', 13:25:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:25:25 INFO - '/tools/misc-python/virtualenv.py')}, 13:25:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:25:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:25:25 INFO - 'installer_path': 'installer.exe', 13:25:25 INFO - 'log_level': 'info', 13:25:25 INFO - 'log_name': 'talos', 13:25:25 INFO - 'log_to_console': True, 13:25:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:25:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:25:25 INFO - 'opt_config_files': (), 13:25:25 INFO - 'pip_index': False, 13:25:25 INFO - 'sps_profile': False, 13:25:25 INFO - 'sps_profile_interval': 0, 13:25:25 INFO - 'suite': 'dromaeojs-e10s', 13:25:25 INFO - 'system_bits': '32', 13:25:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:25:25 INFO - 'title': 'talos-linux64-ix-006', 13:25:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:25:25 INFO - 'use_talos_json': True, 13:25:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:25:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:25:25 INFO - 'work_dir': 'build'} 13:25:25 INFO - [mozharness: 2016-08-29 20:25:25.538748Z] Running clobber step. 13:25:25 INFO - Running pre-action listener: _resource_record_pre_action 13:25:25 INFO - Running main action method: clobber 13:25:25 INFO - rmtree: /builds/slave/test/build 13:25:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:25:25 INFO - Running post-action listener: _resource_record_post_action 13:25:25 INFO - [mozharness: 2016-08-29 20:25:25.984315Z] Finished clobber step (success) 13:25:25 INFO - [mozharness: 2016-08-29 20:25:25.984416Z] Running read-buildbot-config step. 13:25:25 INFO - Running pre-action listener: _resource_record_pre_action 13:25:25 INFO - Running main action method: read_buildbot_config 13:25:25 INFO - Using buildbot properties: 13:25:25 INFO - { 13:25:25 INFO - "project": "", 13:25:25 INFO - "product": "firefox", 13:25:25 INFO - "script_repo_revision": "production", 13:25:25 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 13:25:25 INFO - "repository": "", 13:25:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 13:25:25 INFO - "buildid": "20160829102231", 13:25:25 INFO - "pgo_build": "True", 13:25:25 INFO - "basedir": "/builds/slave/test", 13:25:25 INFO - "buildnumber": 518, 13:25:25 INFO - "slavename": "talos-linux64-ix-006", 13:25:25 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:25:25 INFO - "platform": "ubuntu64_hw", 13:25:25 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 13:25:25 INFO - "branch": "mozilla-aurora", 13:25:25 INFO - "repo_path": "releases/mozilla-aurora", 13:25:25 INFO - "revision": "350ef810694c3704431f65c91bd83b9f2e933622", 13:25:25 INFO - "stage_platform": "linux64-pgo", 13:25:25 INFO - "builduid": "22fe23d2699145c5873ec15d49d44bb4", 13:25:25 INFO - "slavebuilddir": "test" 13:25:25 INFO - } 13:25:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 13:25:25 INFO - Running post-action listener: _resource_record_post_action 13:25:25 INFO - [mozharness: 2016-08-29 20:25:25.986845Z] Finished read-buildbot-config step (success) 13:25:25 INFO - [mozharness: 2016-08-29 20:25:25.986935Z] Running download-and-extract step. 13:25:25 INFO - Running pre-action listener: _resource_record_pre_action 13:25:25 INFO - Running main action method: download_and_extract 13:25:25 INFO - mkdir: /builds/slave/test/build/tests 13:25:25 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')]} 13:25:25 INFO - https://queue.taskcluster.net/v1/task/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:25:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 13:25:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 13:25:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/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 13:25:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/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 13:25:25 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 13:25:25 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 13:25:25 INFO - retry: Failed, sleeping 30 seconds before retrying 13:25:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/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 13:25:56 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 13:25:56 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 13:25:56 INFO - retry: Failed, sleeping 60 seconds before retrying 13:26:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/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 13:26:56 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 13:26:56 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 13:26:56 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/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! 13:26:56 INFO - Caught exception: HTTP Error 404: Not Found 13:26:56 INFO - Caught exception: HTTP Error 404: Not Found 13:26:56 INFO - Caught exception: HTTP Error 404: Not Found 13:26:56 INFO - trying https://queue.taskcluster.net/v1/task/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 13:26:56 INFO - Downloading https://queue.taskcluster.net/v1/task/cQZgZ3OATKiRrUDD4u0HFw/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 13:26:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cQZgZ3OATKiRrUDD4u0HFw/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 13:26:56 INFO - Downloaded 1361 bytes. 13:26:56 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 13:26:56 INFO - Using the following test package requirements: 13:26:56 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 13:26:56 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 13:26:56 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 13:26:56 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 13:26:56 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 13:26:56 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 13:26:56 INFO - u'jsshell-linux-x86_64.zip'], 13:26:56 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 13:26:56 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 13:26:56 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 13:26:56 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 13:26:56 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 13:26:56 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 13:26:56 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 13:26:56 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 13:26:56 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 13:26:56 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 13:26:56 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 13:26:56 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:56 INFO - https://queue.taskcluster.net/v1/task/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:26:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:26:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:26:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/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 13:26:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/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 13:26:56 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:26:56 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 13:26:56 INFO - retry: Failed, sleeping 30 seconds before retrying 13:27:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/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 13:27:26 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:27:26 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 13:27:26 INFO - retry: Failed, sleeping 60 seconds before retrying 13:28:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/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 13:28:26 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:28:26 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 13:28:26 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/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! 13:28:26 INFO - Caught exception: HTTP Error 404: Not Found 13:28:26 INFO - Caught exception: HTTP Error 404: Not Found 13:28:26 INFO - Caught exception: HTTP Error 404: Not Found 13:28:26 INFO - trying https://queue.taskcluster.net/v1/task/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:28:26 INFO - Downloading https://queue.taskcluster.net/v1/task/cQZgZ3OATKiRrUDD4u0HFw/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 13:28:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cQZgZ3OATKiRrUDD4u0HFw/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 13:28:27 INFO - Downloaded 21769130 bytes. 13:28:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:28:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:28:28 INFO - Return code: 0 13:28:28 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 13:28: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')]} 13:28:28 INFO - https://queue.taskcluster.net/v1/task/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:28:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:28:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:28:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/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 13:28:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/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 13:28:28 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:28:28 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 13:28:28 INFO - retry: Failed, sleeping 30 seconds before retrying 13:28:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/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 13:28:58 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:28:58 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 13:28:58 INFO - retry: Failed, sleeping 60 seconds before retrying 13:29:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/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 13:29:59 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:29:59 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 13:29:59 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/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! 13:29:59 INFO - Caught exception: HTTP Error 404: Not Found 13:29:59 INFO - Caught exception: HTTP Error 404: Not Found 13:29:59 INFO - Caught exception: HTTP Error 404: Not Found 13:29:59 INFO - trying https://queue.taskcluster.net/v1/task/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:29:59 INFO - Downloading https://queue.taskcluster.net/v1/task/cQZgZ3OATKiRrUDD4u0HFw/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 13:29:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cQZgZ3OATKiRrUDD4u0HFw/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 13:29:59 INFO - Downloaded 21769130 bytes. 13:29:59 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'] 13:29:59 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 13:30:01 INFO - Return code: 0 13:30:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:01 INFO - https://queue.taskcluster.net/v1/task/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:30:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 13:30:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 13:30:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/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 13:30:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/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 13:30:01 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 13:30:01 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 13:30:01 INFO - retry: Failed, sleeping 30 seconds before retrying 13:30:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/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 13:30:31 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 13:30:31 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 13:30:31 INFO - retry: Failed, sleeping 60 seconds before retrying 13:31:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/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 13:31:31 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 13:31:31 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 13:31:31 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/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! 13:31:31 INFO - Caught exception: HTTP Error 404: Not Found 13:31:31 INFO - Caught exception: HTTP Error 404: Not Found 13:31:31 INFO - Caught exception: HTTP Error 404: Not Found 13:31:31 INFO - trying https://queue.taskcluster.net/v1/task/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 13:31:31 INFO - Downloading https://queue.taskcluster.net/v1/task/cQZgZ3OATKiRrUDD4u0HFw/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 13:31:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cQZgZ3OATKiRrUDD4u0HFw/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 13:31:32 INFO - Downloaded 14413723 bytes. 13:31:32 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'] 13:31:32 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 13:31:32 INFO - Return code: 0 13:31:32 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')]} 13:31:32 INFO - https://queue.taskcluster.net/v1/task/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:31:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 13:31:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 13:31:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/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 13:31:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/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 13:31:32 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 13:31:32 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 13:31:32 INFO - retry: Failed, sleeping 30 seconds before retrying 13:32:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/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 13:32:02 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 13:32:02 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 13:32:02 INFO - retry: Failed, sleeping 60 seconds before retrying 13:33:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/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 13:33:02 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 13:33:02 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 13:33:02 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQZgZ3OATKiRrUDD4u0HFw/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! 13:33:02 INFO - Caught exception: HTTP Error 404: Not Found 13:33:02 INFO - Caught exception: HTTP Error 404: Not Found 13:33:02 INFO - Caught exception: HTTP Error 404: Not Found 13:33:02 INFO - trying https://queue.taskcluster.net/v1/task/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 13:33:02 INFO - Downloading https://queue.taskcluster.net/v1/task/cQZgZ3OATKiRrUDD4u0HFw/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 13:33:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cQZgZ3OATKiRrUDD4u0HFw/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 13:33:03 INFO - Downloaded 63886640 bytes. 13:33:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 13:33:03 INFO - mkdir: /builds/slave/test/properties 13:33:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:33:03 INFO - Writing to file /builds/slave/test/properties/build_url 13:33:03 INFO - Contents: 13:33:03 INFO - build_url:https://queue.taskcluster.net/v1/task/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 13:33:04 INFO - Running post-action listener: _resource_record_post_action 13:33:04 INFO - Running post-action listener: set_extra_try_arguments 13:33:04 INFO - [mozharness: 2016-08-29 20:33:04.734029Z] Finished download-and-extract step (success) 13:33:04 INFO - [mozharness: 2016-08-29 20:33:04.734259Z] Running populate-webroot step. 13:33:04 INFO - Running pre-action listener: _resource_record_pre_action 13:33:04 INFO - Running main action method: populate_webroot 13:33:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:33:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:33:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:33:04 INFO - '--tppagecycles', 13:33:04 INFO - '7'], 13:33:04 INFO - 'tests': ['tsvgm']}}, 13:33:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:33:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:33:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:33:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:33:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:33:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:33:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:04 INFO - 'talos_options': ['--disable-e10s'], 13:33:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:33:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:33:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:04 INFO - 'talos_options': ['--disable-e10s'], 13:33:04 INFO - 'tests': ['damp', 'tps']}, 13:33:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:04 INFO - 'tests': ['damp', 'tps']}, 13:33:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:33:04 INFO - 'tests': ['dromaeo_dom']}, 13:33:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:33:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:33:04 INFO - 'tests': ['basic_compositor_video']}, 13:33:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:33:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:33:04 INFO - 'tests': ['a11yr', 13:33:04 INFO - 'ts_paint', 13:33:04 INFO - 'tpaint', 13:33:04 INFO - 'sessionrestore', 13:33:04 INFO - 'sessionrestore_no_auto_restore', 13:33:04 INFO - 'tabpaint']}, 13:33:04 INFO - 'other-e10s': {'tests': ['a11yr', 13:33:04 INFO - 'ts_paint', 13:33:04 INFO - 'tpaint', 13:33:04 INFO - 'sessionrestore', 13:33:04 INFO - 'sessionrestore_no_auto_restore', 13:33:04 INFO - 'tabpaint']}, 13:33:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:33:04 INFO - 'ts_paint', 13:33:04 INFO - 'tpaint', 13:33:04 INFO - 'sessionrestore', 13:33:04 INFO - 'sessionrestore_no_auto_restore', 13:33:04 INFO - 'tabpaint']}, 13:33:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:33:04 INFO - 'ts_paint', 13:33:04 INFO - 'tpaint', 13:33:04 INFO - 'sessionrestore', 13:33:04 INFO - 'sessionrestore_no_auto_restore', 13:33:04 INFO - 'tabpaint']}, 13:33:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:33:04 INFO - 'tests': ['a11yr', 13:33:04 INFO - 'ts_paint', 13:33:04 INFO - 'tpaint', 13:33:04 INFO - 'sessionrestore', 13:33:04 INFO - 'sessionrestore_no_auto_restore', 13:33:04 INFO - 'tabpaint']}, 13:33:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:33:04 INFO - 'tests': ['a11yr', 13:33:04 INFO - 'ts_paint', 13:33:04 INFO - 'tpaint', 13:33:04 INFO - 'sessionrestore', 13:33:04 INFO - 'sessionrestore_no_auto_restore', 13:33:04 INFO - 'tabpaint']}, 13:33:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:33:04 INFO - 'tests': ['tsvgx', 13:33:04 INFO - 'tsvgr_opacity', 13:33:04 INFO - 'tart', 13:33:04 INFO - 'tscrollx', 13:33:04 INFO - 'cart']}, 13:33:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:33:04 INFO - 'tsvgr_opacity', 13:33:04 INFO - 'tart', 13:33:04 INFO - 'tscrollx', 13:33:04 INFO - 'cart']}, 13:33:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:04 INFO - 'talos_options': ['--disable-e10s'], 13:33:04 INFO - 'tests': ['tp5o']}, 13:33:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:04 INFO - 'tests': ['tp5o']}, 13:33:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:04 INFO - 'talos_options': ['--disable-e10s', 13:33:04 INFO - '--xperf_path', 13:33:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:33:04 INFO - 'tests': ['tp5n']}, 13:33:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:04 INFO - 'talos_options': ['--xperf_path', 13:33:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:33:04 INFO - 'tests': ['tp5n']}}, 13:33:04 INFO - 'talos.zip': {'path': '', 13:33:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:33:04 INFO - Running post-action listener: _resource_record_post_action 13:33:04 INFO - [mozharness: 2016-08-29 20:33:04.753208Z] Finished populate-webroot step (success) 13:33:04 INFO - [mozharness: 2016-08-29 20:33:04.753297Z] Running create-virtualenv step. 13:33:04 INFO - Running pre-action listener: _resource_record_pre_action 13:33:04 INFO - Running main action method: create_virtualenv 13:33:04 INFO - Creating virtualenv /builds/slave/test/build/venv 13:33:04 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 13:33:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:33:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:33:04 INFO - Using real prefix '/usr' 13:33:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:33:05 INFO - Installing distribute.............................................................................................................................................................................................done. 13:33:07 INFO - Installing pip.................done. 13:33:07 INFO - Return code: 0 13:33:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:33:07 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')]} 13:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:07 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')]} 13:33:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:07 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 0x114c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140a570>, '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 0x140b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140b900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1472502322.623800-82203651', '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 13:33:07 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 13:33:07 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 13:33:07 INFO - Using env: {'DISPLAY': ':0', 13:33:07 INFO - 'HOME': '/home/cltbld', 13:33:07 INFO - 'LANG': 'en_US.UTF-8', 13:33:07 INFO - 'LANGUAGE': 'en_US:en', 13:33:07 INFO - 'LOGNAME': 'cltbld', 13:33:07 INFO - 'MAIL': '/var/mail/cltbld', 13:33:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:07 INFO - 'MOZ_NO_REMOTE': '1', 13:33:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:07 INFO - 'NO_EM_RESTART': '1', 13:33:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:07 INFO - 'PWD': '/builds/slave/test', 13:33:07 INFO - 'SHELL': '/bin/bash', 13:33:07 INFO - 'SHLVL': '1', 13:33:07 INFO - 'TERM': 'linux', 13:33:07 INFO - 'TMOUT': '86400', 13:33:07 INFO - 'USER': 'cltbld', 13:33:07 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472502322.623800-82203651', 13:33:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:07 INFO - '_': '/tools/buildbot/bin/python'} 13:33:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:07 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 13:33:07 INFO - Cleaning up... 13:33:07 INFO - Return code: 0 13:33:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:33:07 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')]} 13:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:07 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')]} 13:33:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:07 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 0x114c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140a570>, '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 0x140b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140b900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1472502322.623800-82203651', '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 13:33:07 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 13:33:07 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 13:33:07 INFO - Using env: {'DISPLAY': ':0', 13:33:07 INFO - 'HOME': '/home/cltbld', 13:33:07 INFO - 'LANG': 'en_US.UTF-8', 13:33:07 INFO - 'LANGUAGE': 'en_US:en', 13:33:07 INFO - 'LOGNAME': 'cltbld', 13:33:07 INFO - 'MAIL': '/var/mail/cltbld', 13:33:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:07 INFO - 'MOZ_NO_REMOTE': '1', 13:33:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:07 INFO - 'NO_EM_RESTART': '1', 13:33:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:07 INFO - 'PWD': '/builds/slave/test', 13:33:07 INFO - 'SHELL': '/bin/bash', 13:33:07 INFO - 'SHLVL': '1', 13:33:07 INFO - 'TERM': 'linux', 13:33:07 INFO - 'TMOUT': '86400', 13:33:07 INFO - 'USER': 'cltbld', 13:33:07 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472502322.623800-82203651', 13:33:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:07 INFO - '_': '/tools/buildbot/bin/python'} 13:33:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:07 INFO - Downloading/unpacking psutil>=3.1.1 13:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:33:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:33:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:33:09 INFO - Installing collected packages: psutil 13:33:09 INFO - Running setup.py install for psutil 13:33:09 INFO - building 'psutil._psutil_linux' extension 13:33:09 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 13:33:09 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 13:33:09 INFO - building 'psutil._psutil_posix' extension 13:33:09 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 13:33:10 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 13:33:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:33:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:33:10 INFO - Successfully installed psutil 13:33:10 INFO - Cleaning up... 13:33:10 INFO - Return code: 0 13:33:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:33: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')]} 13:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33: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')]} 13:33:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:10 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 0x114c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140a570>, '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 0x140b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140b900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1472502322.623800-82203651', '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 13:33:10 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 13:33:10 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 13:33:10 INFO - Using env: {'DISPLAY': ':0', 13:33:10 INFO - 'HOME': '/home/cltbld', 13:33:10 INFO - 'LANG': 'en_US.UTF-8', 13:33:10 INFO - 'LANGUAGE': 'en_US:en', 13:33:10 INFO - 'LOGNAME': 'cltbld', 13:33:10 INFO - 'MAIL': '/var/mail/cltbld', 13:33:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:10 INFO - 'MOZ_NO_REMOTE': '1', 13:33:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:10 INFO - 'NO_EM_RESTART': '1', 13:33:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:10 INFO - 'PWD': '/builds/slave/test', 13:33:10 INFO - 'SHELL': '/bin/bash', 13:33:10 INFO - 'SHLVL': '1', 13:33:10 INFO - 'TERM': 'linux', 13:33:10 INFO - 'TMOUT': '86400', 13:33:10 INFO - 'USER': 'cltbld', 13:33:10 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472502322.623800-82203651', 13:33:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:10 INFO - '_': '/tools/buildbot/bin/python'} 13:33:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:33:10 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 13:33:10 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 13:33:10 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 13:33:10 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 13:33:10 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 13:33:10 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 13:33:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:33:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:33:12 INFO - Installing collected packages: mozsystemmonitor 13:33:12 INFO - Running setup.py install for mozsystemmonitor 13:33:12 INFO - Successfully installed mozsystemmonitor 13:33:12 INFO - Cleaning up... 13:33:12 INFO - Return code: 0 13:33:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:33:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:33:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:12 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 0x114c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140a570>, '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 0x140b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140b900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1472502322.623800-82203651', '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 13:33:12 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 13:33:12 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 13:33:12 INFO - Using env: {'DISPLAY': ':0', 13:33:12 INFO - 'HOME': '/home/cltbld', 13:33:12 INFO - 'LANG': 'en_US.UTF-8', 13:33:12 INFO - 'LANGUAGE': 'en_US:en', 13:33:12 INFO - 'LOGNAME': 'cltbld', 13:33:12 INFO - 'MAIL': '/var/mail/cltbld', 13:33:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:12 INFO - 'MOZ_NO_REMOTE': '1', 13:33:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:12 INFO - 'NO_EM_RESTART': '1', 13:33:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:12 INFO - 'PWD': '/builds/slave/test', 13:33:12 INFO - 'SHELL': '/bin/bash', 13:33:12 INFO - 'SHLVL': '1', 13:33:12 INFO - 'TERM': 'linux', 13:33:12 INFO - 'TMOUT': '86400', 13:33:12 INFO - 'USER': 'cltbld', 13:33:12 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472502322.623800-82203651', 13:33:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:12 INFO - '_': '/tools/buildbot/bin/python'} 13:33:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:12 INFO - Downloading/unpacking jsonschema==2.5.1 13:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:33:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:14 INFO - Downloading functools32-3.2.3-2.tar.gz 13:33:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:33:14 INFO - warning: no files found matching '*.txt' 13:33:14 INFO - no previously-included directories found matching 'build' 13:33:14 INFO - no previously-included directories found matching 'dist' 13:33:14 INFO - no previously-included directories found matching '.git*' 13:33:14 INFO - Installing collected packages: jsonschema, functools32 13:33:14 INFO - Running setup.py install for functools32 13:33:15 INFO - warning: no files found matching '*.txt' 13:33:15 INFO - no previously-included directories found matching 'build' 13:33:15 INFO - no previously-included directories found matching 'dist' 13:33:15 INFO - no previously-included directories found matching '.git*' 13:33:15 INFO - Successfully installed jsonschema functools32 13:33:15 INFO - Cleaning up... 13:33:15 INFO - Return code: 0 13:33:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:33:15 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')]} 13:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:15 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')]} 13:33:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:15 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 0x114c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140a570>, '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 0x140b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140b900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1472502322.623800-82203651', '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 13:33:15 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 13:33:15 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 13:33:15 INFO - Using env: {'DISPLAY': ':0', 13:33:15 INFO - 'HOME': '/home/cltbld', 13:33:15 INFO - 'LANG': 'en_US.UTF-8', 13:33:15 INFO - 'LANGUAGE': 'en_US:en', 13:33:15 INFO - 'LOGNAME': 'cltbld', 13:33:15 INFO - 'MAIL': '/var/mail/cltbld', 13:33:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:15 INFO - 'MOZ_NO_REMOTE': '1', 13:33:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:15 INFO - 'NO_EM_RESTART': '1', 13:33:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:15 INFO - 'PWD': '/builds/slave/test', 13:33:15 INFO - 'SHELL': '/bin/bash', 13:33:15 INFO - 'SHLVL': '1', 13:33:15 INFO - 'TERM': 'linux', 13:33:15 INFO - 'TMOUT': '86400', 13:33:15 INFO - 'USER': 'cltbld', 13:33:15 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472502322.623800-82203651', 13:33:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:15 INFO - '_': '/tools/buildbot/bin/python'} 13:33:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:33:15 INFO - Cleaning up... 13:33:15 INFO - Return code: 0 13:33:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:33:15 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')]} 13:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:15 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')]} 13:33:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:15 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 0x114c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140a570>, '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 0x140b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140b900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1472502322.623800-82203651', '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 13:33:15 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 13:33:15 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 13:33:15 INFO - Using env: {'DISPLAY': ':0', 13:33:15 INFO - 'HOME': '/home/cltbld', 13:33:15 INFO - 'LANG': 'en_US.UTF-8', 13:33:15 INFO - 'LANGUAGE': 'en_US:en', 13:33:15 INFO - 'LOGNAME': 'cltbld', 13:33:15 INFO - 'MAIL': '/var/mail/cltbld', 13:33:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:15 INFO - 'MOZ_NO_REMOTE': '1', 13:33:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:15 INFO - 'NO_EM_RESTART': '1', 13:33:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:15 INFO - 'PWD': '/builds/slave/test', 13:33:15 INFO - 'SHELL': '/bin/bash', 13:33:15 INFO - 'SHLVL': '1', 13:33:15 INFO - 'TERM': 'linux', 13:33:15 INFO - 'TMOUT': '86400', 13:33:15 INFO - 'USER': 'cltbld', 13:33:15 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472502322.623800-82203651', 13:33:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:15 INFO - '_': '/tools/buildbot/bin/python'} 13:33:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:15 INFO - Downloading/unpacking blobuploader==1.2.4 13:33:15 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 13:33:15 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 13:33:15 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 13:33:15 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 13:33:15 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 13:33:15 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 13:33:17 INFO - Downloading blobuploader-1.2.4.tar.gz 13:33:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:33:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:33:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:18 INFO - Downloading docopt-0.6.1.tar.gz 13:33:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:33:18 INFO - Installing collected packages: blobuploader, requests, docopt 13:33:18 INFO - Running setup.py install for blobuploader 13:33:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:33:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:33:18 INFO - Running setup.py install for requests 13:33:18 INFO - Running setup.py install for docopt 13:33:18 INFO - Successfully installed blobuploader requests docopt 13:33:18 INFO - Cleaning up... 13:33:18 INFO - Return code: 0 13:33:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:33:18 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')]} 13:33:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:18 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')]} 13:33:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:18 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 0x114c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140a570>, '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 0x140b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140b900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1472502322.623800-82203651', '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 13:33:18 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 13:33:18 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 13:33:18 INFO - Using env: {'DISPLAY': ':0', 13:33:18 INFO - 'HOME': '/home/cltbld', 13:33:18 INFO - 'LANG': 'en_US.UTF-8', 13:33:18 INFO - 'LANGUAGE': 'en_US:en', 13:33:18 INFO - 'LOGNAME': 'cltbld', 13:33:18 INFO - 'MAIL': '/var/mail/cltbld', 13:33:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:18 INFO - 'MOZ_NO_REMOTE': '1', 13:33:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:18 INFO - 'NO_EM_RESTART': '1', 13:33:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:18 INFO - 'PWD': '/builds/slave/test', 13:33:18 INFO - 'SHELL': '/bin/bash', 13:33:18 INFO - 'SHLVL': '1', 13:33:18 INFO - 'TERM': 'linux', 13:33:18 INFO - 'TMOUT': '86400', 13:33:18 INFO - 'USER': 'cltbld', 13:33:18 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472502322.623800-82203651', 13:33:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:18 INFO - '_': '/tools/buildbot/bin/python'} 13:33:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:33:19 INFO - Running setup.py (path:/tmp/pip-srDTRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:33:19 INFO - Running setup.py (path:/tmp/pip-9oBMyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:33:19 INFO - Running setup.py (path:/tmp/pip-vzQbRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:33:19 INFO - Running setup.py (path:/tmp/pip-MIxoVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:33:19 INFO - Running setup.py (path:/tmp/pip-vt1C9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:33:19 INFO - Running setup.py (path:/tmp/pip-G9y3pc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:33:19 INFO - Running setup.py (path:/tmp/pip-Jq25MT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:33:19 INFO - Running setup.py (path:/tmp/pip-v0L8G5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:33:19 INFO - Running setup.py (path:/tmp/pip-XqfOo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:33:19 INFO - Running setup.py (path:/tmp/pip-uwJWfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:33:19 INFO - Running setup.py (path:/tmp/pip-stN7aL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:33:19 INFO - Running setup.py (path:/tmp/pip-DNx4v7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:33:19 INFO - Running setup.py (path:/tmp/pip-_Fp39c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:33:19 INFO - Running setup.py (path:/tmp/pip-wgsSyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:33:20 INFO - Running setup.py (path:/tmp/pip-wcXk53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:33:20 INFO - Running setup.py (path:/tmp/pip-HXlKU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:33:20 INFO - Running setup.py (path:/tmp/pip-oeJBAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:33:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:33:20 INFO - Running setup.py install for manifestparser 13:33:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:33:20 INFO - Running setup.py install for mozcrash 13:33:20 INFO - Running setup.py install for mozdebug 13:33:20 INFO - Running setup.py install for mozdevice 13:33:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:33:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:33:20 INFO - Running setup.py install for mozfile 13:33:20 INFO - Running setup.py install for mozhttpd 13:33:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:33:20 INFO - Running setup.py install for mozinfo 13:33:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:33:20 INFO - Running setup.py install for mozInstall 13:33:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:33:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:33:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:33:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:33:21 INFO - Running setup.py install for mozleak 13:33:21 INFO - Running setup.py install for mozlog 13:33:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:33:21 INFO - Running setup.py install for moznetwork 13:33:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:33:21 INFO - Running setup.py install for mozprocess 13:33:21 INFO - Running setup.py install for mozprofile 13:33:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:33:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:33:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:33:21 INFO - Running setup.py install for mozrunner 13:33:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:33:21 INFO - Running setup.py install for mozscreenshot 13:33:21 INFO - Running setup.py install for moztest 13:33:21 INFO - Running setup.py install for mozversion 13:33:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:33:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:33:21 INFO - Cleaning up... 13:33:22 INFO - Return code: 0 13:33:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:33:22 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')]} 13:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:22 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')]} 13:33:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:22 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 0x114c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140a570>, '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 0x140b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140b900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1472502322.623800-82203651', '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 13:33:22 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 13:33:22 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 13:33:22 INFO - Using env: {'DISPLAY': ':0', 13:33:22 INFO - 'HOME': '/home/cltbld', 13:33:22 INFO - 'LANG': 'en_US.UTF-8', 13:33:22 INFO - 'LANGUAGE': 'en_US:en', 13:33:22 INFO - 'LOGNAME': 'cltbld', 13:33:22 INFO - 'MAIL': '/var/mail/cltbld', 13:33:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:22 INFO - 'MOZ_NO_REMOTE': '1', 13:33:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:22 INFO - 'NO_EM_RESTART': '1', 13:33:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:22 INFO - 'PWD': '/builds/slave/test', 13:33:22 INFO - 'SHELL': '/bin/bash', 13:33:22 INFO - 'SHLVL': '1', 13:33:22 INFO - 'TERM': 'linux', 13:33:22 INFO - 'TMOUT': '86400', 13:33:22 INFO - 'USER': 'cltbld', 13:33:22 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472502322.623800-82203651', 13:33:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:22 INFO - '_': '/tools/buildbot/bin/python'} 13:33:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:33:22 INFO - Running setup.py (path:/tmp/pip-CJMPk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:33:22 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)) 13:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:33:22 INFO - Running setup.py (path:/tmp/pip-3aKVZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:33:22 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)) 13:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:33:22 INFO - Running setup.py (path:/tmp/pip-Xw1ugW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:33:22 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)) 13:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:33:22 INFO - Running setup.py (path:/tmp/pip-MuN_UF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:33:22 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)) 13:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:33:22 INFO - Running setup.py (path:/tmp/pip-MXz_qs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:33:22 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)) 13:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:33:22 INFO - Running setup.py (path:/tmp/pip-5y4d4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:33:22 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)) 13:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:33:22 INFO - Running setup.py (path:/tmp/pip-3bgtuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:33:22 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)) 13:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:33:22 INFO - Running setup.py (path:/tmp/pip-4FosVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:33:22 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)) 13:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:33:22 INFO - Running setup.py (path:/tmp/pip-34kz8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:33:22 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)) 13:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:33:22 INFO - Running setup.py (path:/tmp/pip-C4962l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:33:22 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)) 13:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:33:22 INFO - Running setup.py (path:/tmp/pip-0xvXKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:33:23 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)) 13:33:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:33:23 INFO - Running setup.py (path:/tmp/pip-PTlPq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:33:23 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)) 13:33:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:33:23 INFO - Running setup.py (path:/tmp/pip-8grs9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:33:23 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)) 13:33:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:33:23 INFO - Running setup.py (path:/tmp/pip-Md1TTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:33:23 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)) 13:33:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:33:23 INFO - Running setup.py (path:/tmp/pip-ZrIelc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:33:23 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)) 13:33:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:33:23 INFO - Running setup.py (path:/tmp/pip-ixl7Pb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:33:23 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)) 13:33:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:33:23 INFO - Running setup.py (path:/tmp/pip-ig5KnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:33:23 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)) 13:33:23 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)) 13:33:23 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)) 13:33:23 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)) 13:33:23 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)) 13:33:23 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)) 13:33:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:33:23 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 13:33:23 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 13:33:23 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 13:33:23 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 13:33:23 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 13:33:23 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 13:33:25 INFO - Downloading blessings-1.6.tar.gz 13:33:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:33:25 INFO - Installing collected packages: blessings 13:33:25 INFO - Running setup.py install for blessings 13:33:25 INFO - Successfully installed blessings 13:33:25 INFO - Cleaning up... 13:33:25 INFO - Return code: 0 13:33:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:33:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:33:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:33:25 INFO - Reading from file tmpfile_stdout 13:33:25 INFO - Current package versions: 13:33:25 INFO - argparse == 1.2.1 13:33:25 INFO - blessings == 1.6 13:33:25 INFO - blobuploader == 1.2.4 13:33:25 INFO - docopt == 0.6.1 13:33:25 INFO - functools32 == 3.2.3-2 13:33:25 INFO - jsonschema == 2.5.1 13:33:25 INFO - manifestparser == 1.1 13:33:25 INFO - mozInstall == 1.12 13:33:25 INFO - mozcrash == 0.17 13:33:25 INFO - mozdebug == 0.1 13:33:25 INFO - mozdevice == 0.48 13:33:25 INFO - mozfile == 1.2 13:33:25 INFO - mozhttpd == 0.7 13:33:25 INFO - mozinfo == 0.9 13:33:25 INFO - mozleak == 0.1 13:33:25 INFO - mozlog == 3.3 13:33:25 INFO - moznetwork == 0.27 13:33:25 INFO - mozprocess == 0.23 13:33:25 INFO - mozprofile == 0.28 13:33:25 INFO - mozrunner == 6.12 13:33:25 INFO - mozscreenshot == 0.1 13:33:25 INFO - mozsystemmonitor == 0.3 13:33:25 INFO - moztest == 0.7 13:33:25 INFO - mozversion == 1.4 13:33:25 INFO - psutil == 3.1.1 13:33:25 INFO - requests == 1.2.3 13:33:25 INFO - wsgiref == 0.1.2 13:33:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:33:25 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')]} 13:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:25 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')]} 13:33:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:25 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 0x114c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140a570>, '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 0x140b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140b900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1472502322.623800-82203651', '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 13:33:25 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 13:33:25 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 13:33:25 INFO - Using env: {'DISPLAY': ':0', 13:33:25 INFO - 'HOME': '/home/cltbld', 13:33:25 INFO - 'LANG': 'en_US.UTF-8', 13:33:25 INFO - 'LANGUAGE': 'en_US:en', 13:33:25 INFO - 'LOGNAME': 'cltbld', 13:33:25 INFO - 'MAIL': '/var/mail/cltbld', 13:33:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:25 INFO - 'MOZ_NO_REMOTE': '1', 13:33:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:25 INFO - 'NO_EM_RESTART': '1', 13:33:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:25 INFO - 'PWD': '/builds/slave/test', 13:33:25 INFO - 'SHELL': '/bin/bash', 13:33:25 INFO - 'SHLVL': '1', 13:33:25 INFO - 'TERM': 'linux', 13:33:25 INFO - 'TMOUT': '86400', 13:33:25 INFO - 'USER': 'cltbld', 13:33:25 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472502322.623800-82203651', 13:33:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:25 INFO - '_': '/tools/buildbot/bin/python'} 13:33:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:26 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)) 13:33:26 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)) 13:33:26 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)) 13:33:26 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)) 13:33:26 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)) 13:33:26 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)) 13:33:26 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)) 13:33:26 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)) 13:33:26 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)) 13:33:26 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)) 13:33:26 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)) 13:33:26 INFO - Cleaning up... 13:33:26 INFO - Return code: 0 13:33:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:33:26 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')]} 13:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:26 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')]} 13:33:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:26 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 0x114c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140a570>, '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 0x140b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140b900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1472502322.623800-82203651', '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 13:33:26 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 13:33:26 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 13:33:26 INFO - Using env: {'DISPLAY': ':0', 13:33:26 INFO - 'HOME': '/home/cltbld', 13:33:26 INFO - 'LANG': 'en_US.UTF-8', 13:33:26 INFO - 'LANGUAGE': 'en_US:en', 13:33:26 INFO - 'LOGNAME': 'cltbld', 13:33:26 INFO - 'MAIL': '/var/mail/cltbld', 13:33:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:26 INFO - 'MOZ_NO_REMOTE': '1', 13:33:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:26 INFO - 'NO_EM_RESTART': '1', 13:33:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:26 INFO - 'PWD': '/builds/slave/test', 13:33:26 INFO - 'SHELL': '/bin/bash', 13:33:26 INFO - 'SHLVL': '1', 13:33:26 INFO - 'TERM': 'linux', 13:33:26 INFO - 'TMOUT': '86400', 13:33:26 INFO - 'USER': 'cltbld', 13:33:26 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472502322.623800-82203651', 13:33:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:26 INFO - '_': '/tools/buildbot/bin/python'} 13:33:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:33:26 INFO - Cleaning up... 13:33:26 INFO - Return code: 0 13:33:26 INFO - Running post-action listener: _resource_record_post_action 13:33:26 INFO - Running post-action listener: _start_resource_monitoring 13:33:26 INFO - Starting resource monitoring. 13:33:26 INFO - [mozharness: 2016-08-29 20:33:26.299014Z] Finished create-virtualenv step (success) 13:33:26 INFO - [mozharness: 2016-08-29 20:33:26.299540Z] Running install step. 13:33:26 INFO - Running pre-action listener: _resource_record_pre_action 13:33:26 INFO - Running main action method: install 13:33:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:33:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:33:26 INFO - Reading from file tmpfile_stdout 13:33:26 INFO - Detecting whether we're running mozinstall >=1.0... 13:33:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:33:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:33:26 INFO - Reading from file tmpfile_stdout 13:33:26 INFO - Output received: 13:33:26 INFO - Usage: mozinstall [options] installer 13:33:26 INFO - Options: 13:33:26 INFO - -h, --help show this help message and exit 13:33:26 INFO - -d DEST, --destination=DEST 13:33:26 INFO - Directory to install application into. [default: 13:33:26 INFO - "/builds/slave/test"] 13:33:26 INFO - --app=APP Application being installed. [default: firefox] 13:33:26 INFO - mkdir: /builds/slave/test/build/application 13:33:26 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'] 13:33:26 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 13:33:43 INFO - Reading from file tmpfile_stdout 13:33:43 INFO - Output received: 13:33:43 INFO - /builds/slave/test/build/application/firefox/firefox 13:33:43 INFO - Running post-action listener: _resource_record_post_action 13:33:43 INFO - [mozharness: 2016-08-29 20:33:43.076745Z] Finished install step (success) 13:33:43 INFO - [mozharness: 2016-08-29 20:33:43.077020Z] Running run-tests step. 13:33:43 INFO - Running pre-action listener: _resource_record_pre_action 13:33:43 INFO - Running main action method: run_tests 13:33:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:33:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:33:43 INFO - Python 2.7.3 13:33:43 INFO - Return code: 0 13:33:43 INFO - grabbing minidump binary from tooltool 13:33:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:33:43 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 0x140a570>, '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 0x140b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140b900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:33:43 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 13:33:43 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 13:33:43 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 13:33:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:33:43 INFO - Return code: 0 13:33:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:33:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:33:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:33:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:33:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:33:43 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/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 13:33:43 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/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 13:33:43 INFO - Using env: {'DISPLAY': ':0', 13:33:43 INFO - 'HOME': '/home/cltbld', 13:33:43 INFO - 'LANG': 'en_US.UTF-8', 13:33:43 INFO - 'LANGUAGE': 'en_US:en', 13:33:43 INFO - 'LOGNAME': 'cltbld', 13:33:43 INFO - 'MAIL': '/var/mail/cltbld', 13:33:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:33:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:33:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:43 INFO - 'MOZ_NO_REMOTE': '1', 13:33:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:33:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:43 INFO - 'NO_EM_RESTART': '1', 13:33:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:43 INFO - 'PWD': '/builds/slave/test', 13:33:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:33:43 INFO - 'SHELL': '/bin/bash', 13:33:43 INFO - 'SHLVL': '1', 13:33:43 INFO - 'TERM': 'linux', 13:33:43 INFO - 'TMOUT': '86400', 13:33:43 INFO - 'USER': 'cltbld', 13:33:43 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472502322.623800-82203651', 13:33:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:43 INFO - '_': '/tools/buildbot/bin/python'} 13:33:43 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/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 13:33:43 INFO - mozversion application_buildid: 20160829102231 13:33:43 INFO - mozversion application_changeset: 350ef810694c3704431f65c91bd83b9f2e933622 13:33:43 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:33:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:33:43 INFO - mozversion application_name: Firefox 13:33:43 INFO - mozversion application_remotingname: firefox-dev 13:33:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:33:43 INFO - mozversion application_vendor: Mozilla 13:33:43 INFO - mozversion application_version: 50.0a2 13:33:43 INFO - mozversion platform_buildid: 20160829102231 13:33:43 INFO - mozversion platform_changeset: 350ef810694c3704431f65c91bd83b9f2e933622 13:33:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:33:43 INFO - mozversion platform_version: 50.0a2 13:33:43 INFO - using testdate: 1472502823 13:33:43 INFO - actual date: 1472502823 13:33:43 INFO - starting webserver on 'localhost:39886' 13:33:43 INFO - SUITE-START | Running 2 tests 13:33:43 INFO - TEST-START | dromaeo_css 13:33:43 INFO - operating with platform_type : linux_ 13:33:43 INFO - Initialising browser for dromaeo_css test... 13:33:43 INFO - TEST-INFO | started process 12845 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmQBXpV/profile http://localhost:39886/getInfo.html) 13:33:47 INFO - PROCESS | 12845 | __metrics Screen width/height:1600/1200 13:33:47 INFO - PROCESS | 12845 | colorDepth:24 13:33:47 INFO - PROCESS | 12845 | Browser inner width/height: 1024/697 13:33:47 INFO - PROCESS | 12845 | __metrics 13:33:48 ERROR - PROCESS | 12845 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 13:33:48 INFO - TEST-INFO | 12845: exit 0 13:33:48 INFO - Browser initialized. 13:33:48 INFO - Running cycle 1/1 for dromaeo_css test... 13:33:48 INFO - TEST-INFO | started process 12969 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmQBXpV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:34:00 INFO - PROCESS | 12969 | RSS: Main: 152854528 13:34:00 INFO - PROCESS | 12969 | 13:34:50 INFO - PROCESS | 12969 | 1472502890280 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] 13:36:58 INFO - PROCESS | 12969 | Cycle 1(1): loaded http://localhost:39886/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39886/tests/dromaeo/cssquery-ext.html) 13:37:00 INFO - PROCESS | 12969 | RSS: Main: 157601792 13:37:00 INFO - PROCESS | 12969 | 13:40:02 INFO - PROCESS | 12969 | Cycle 1(1): loaded http://localhost:39886/tests/dromaeo/cssquery-ext.html (next: http://localhost:39886/tests/dromaeo/cssquery-jquery.html) 13:40:02 INFO - PROCESS | 12969 | RSS: Main: 153989120 13:40:02 INFO - PROCESS | 12969 | 13:43:04 INFO - PROCESS | 12969 | Cycle 1(1): loaded http://localhost:39886/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39886/tests/dromaeo/cssquery-mootools.html) 13:43:05 INFO - PROCESS | 12969 | RSS: Main: 154140672 13:43:05 INFO - PROCESS | 12969 | 13:46:07 INFO - PROCESS | 12969 | Cycle 1(1): loaded http://localhost:39886/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39886/tests/dromaeo/cssquery-prototype.html) 13:46:07 INFO - PROCESS | 12969 | RSS: Main: 152801280 13:46:07 INFO - PROCESS | 12969 | 13:49:10 INFO - PROCESS | 12969 | Cycle 1(1): loaded http://localhost:39886/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39886/tests/dromaeo/cssquery-yui.html) 13:49:10 INFO - PROCESS | 12969 | RSS: Main: 155230208 13:49:10 INFO - PROCESS | 12969 | 13:52:13 INFO - PROCESS | 12969 | Cycle 1(1): loaded http://localhost:39886/tests/dromaeo/cssquery-yui.html (next: http://localhost:39886/tests/dromaeo/cssquery-dojo.html) 13:52:13 INFO - PROCESS | 12969 | RSS: Main: 155721728 13:52:13 INFO - PROCESS | 12969 | 13:52:13 INFO - PROCESS | 12969 | __start_tp_report 13:52:13 INFO - PROCESS | 12969 | _x_x_mozilla_page_load 13:52:13 INFO - PROCESS | 12969 | _x_x_mozilla_page_load_details 13:52:13 INFO - PROCESS | 12969 | |i|pagename|runs| 13:52:13 INFO - PROCESS | 12969 | |0;dojo.html;3329.9500507492385;3353.6814002669753;3361.3613413451444;3383.323335332934;3384.187794929218;5852;5879.500242479395;5892.852678683035;5944.167816505693;5948.672822994734;5782.624129431594;5840.620359676618;5848.064309710437;5896.498797602209;5906.350301466835;5287.576993840484;5338.092524270884;5350.036993341197;5350.224217488462;5383.031054410205;5237.083510385686;5253.60597955153;5282.841514754564;5332.14685650296;5342.358916929955;5282.339707536558;5290.92063619046;5333.626646134772;5355.732213389334;5434.157705555625;5318.414974352818;5323.787048518094;5371.785128594852;5379.488948549882;5391.29913111295;5128.538431541142;5149.2791009258735;5170.612204084671;5236.6857988520815;5341.305630268041;5739.16782066598;5822.155787410844;5830.4461076197695;5835.883282334329;5880.117982302646;6245.094461303085;6270.404311590437;6275.403836635513;6303.779367722108;6304.306526282106;6137.9386206137815;6162.8767424651705;6283.8114856554375;6328.1773369462135;6343.8414039648915;5757.712114394263;5875.471207591295;5890.204822348928;5908.379620139866;5911.320198177222;6374.74501019954;6404.743810247538;6433.710483028275;6438.259600146043;6461.935380646133;5982.192404025488;5994.310654274727;6179.134921111048;6192.845178870564;6196.845078873064;6091.48222401092;6163.322034576193;6179.567430279837;6186.1648677428875;6188.566800324024;6175.042868355412;6180.042093475518;6180.783672571439;6190.81427557174;6202.503799696014;6088.208532890784;6168.599041062316;6178.907316390258;6187.566870319124;6193.102000209944;4757.405324334458;4834.323194752737;4843.491433399442;4873.26900964851;4874.951250487521;4288.635465985364;4290.077633308853;4291.871243862689;4315.762633055149;4333.371661109121;5812.912806307909;5938.970305148447;6017.909731354033;6043.09353596964;6063.878722425527;6270.404311590391;6357.618542887441;6368.586041907354;6377;6397.360263973658;6052.122442245938;6056.454919057306;6057.515398768088;6071.6660583667435;6071.908921366095;5306.124489459196;5403.405625381205;5474.178873168977;5474.644148130438;5503.091989821634;6484.383983521558;6619.5035372347265;6647.833804154935;6657.766978155838;6660.200775907019;6328.430441260309;6353.3011368748475;6376.043593460832;6379.170707808141;6382.585131966407;6313.526485513513;6381.202349706286;6547.083408322744;6571.277159512354;6646.501512386493;6065.666388348507;6140.688304616564;6173.56785025044;6173.660448675366;6183.752649893954;6282.1519094921605;6290;6290.308066112815;6296.338884417253;6313.715882785194;5939.07944268639;6049.485793707584;6134.723937422737;6144.692765361803;6147.293061297829;6104.786332478519;6120.387961203844;6169.537284703575;6169.876602468015;6170.382961703794;6117.877642447037;6119.040615792663;6141.6007959482495;6147.200863887666;6149.323574406902;6046.334903160737;6073.453389194994;6121.330490065119;6145.385461453819;6199.3490683477585;5803.883922321445;5980.491658209101;5988.221531200916;5993.850153746192;5998.400159983967 13:52:13 INFO - PROCESS | 12969 | |1;ext.html;586.5014737473149;636.9012803015532;650.5478692308848;667.6961982298053;678.2064983968756;43267.350989735176;47226.81932951674;47278;47356;47417.76291118544;49239.753801230945;49498.752506237506;49831.25253121197;49861.750691246496;49892;9197.90802091979;9264;9301.95349023254;9308.58111384986;9353.625854965792;9204.171624553788;9250.121238482334;9270.768230794216;9276;9282.814343713122;9304.72085837426;9317.860232096524;9345.67290144845;9373.859392109123;9408.576614052385;9258.907410925905;9269.860952085724;9276.907230927673;9289.535523223813;9337;9124.361294709373;9193.35646504745;9211.631534738603;9235.815283694355;9244;45017.324740128926;45330.32004519935;45333.32000020002;45337.773311133235;45483.772581137215;4075.551689314173;4102.343625019982;4397;4506.301523263866;4735.242361222222;32025.839870800497;32091.197720056953;36257.45613815795;36310.092247693756;37510;4380.102079073782;4490.326451032339;4492.595666390041;4614.907701845944;4711.387519622427;398370;400644;401457;401701.9999999971;403757;38628.613713863066;65051;65476.345236547975;65592;65698.01452978209;39734;41238.79380603078;41652.79173604112;41912.790436047624;42065;16027.519174424786;16260.75608865868;16305.918470407572;16339.42812001598;16343.34626614946;13349.265790381622;13408.530701425403;13454.93272533631;13527.594172174851;13566.321683915765;9250.814983700422;9283.442993420416;9320.813583728288;9386;9486.715398538056;3555.3244883472057;3586.282743451268;3612.87354942581;3668.3396988541786;3699.2601479704167;1064.6072409093583;1092.3282181458346;1099.8075336816025;1148.2478976270556;1161.088545491785;35070.649293507246;35184;35397.292054158774;35555.82222088925;35691.4646280306;1147.2428197389684;1150.5110328110686;1243.1795015290047;1262.217425196384;1262.5202423079354;17871.421717575635;17991.370302039366;18092.366767163086;18291.72562411565;18431.07844607764;346205;355034;356857;357836;359808;66528;66874.66562667156;67312;67454.32545674579;67582.66208669024;1443.9278036098153;1454.919979401143;1474.1744623010934;1494.2454060699495;1495.349522957517;34599.65400345964;34772.304553908274;35514;35641.82179089192;35727.46408803922;58674;59774;59816;59817.700911495165;59846;552791;553842;555851;556778;557991;31634.841825790725;32333;32533.511997320533;32553.34893302168;32742.50886236661;55628;55651.443485564625;55667.721661391435;56551;56653.43346566481;45092.54907450883;46345.30482042839;46577.3013404806;47118.52881471279;47698.76150619364;44948.55051449444;45704.77147614241;46469;47094.29358559556;48111.51888481071;45495.54504454913;45568.772156139006;46275;46794.29808552806;48481.5151848477;39006;40089.79955100323;40123.59876401316;40709.79645101756;40806.79596601998;29814.105576831862;30865;30904.536431953988;31154.688453116087;31351.84324078365 13:52:13 INFO - PROCESS | 12969 | |2;jquery.html;413.7993073359418;421.69848558280825;427.69847257683324;436.1669211805452;438.92538268494354;20400.89799551004;20416.285430009953;21219.469513262175;21331.57336853262;21407.357779266607;19648.719550281075;19944.60110797787;20731.170753169856;20765.169393224252;21035.368938931817;5722.227499287595;5978.282606087276;5989.940100599004;5993.4006599340155;5995.040793473046;5895.9705201473935;5947.672877991708;6905.827354316132;7097.858042839166;7142.428605711557;7176.461765367592;7179.06672132622;7243.6378181090995;7305.488615796897;7312;6924.58452492847;7153.499255052148;7276.745313914014;7671.578063206522;7774.999999999972;7072.611006394646;7083.220845706968;7109.46678999072;7142.178649455327;7441.8511629767645;27361;27813.582796258073;28465.71534284672;28776.280592985135;28855.278618034507;2782.1097248880365;2910.5634154876725;2934.046434908642;3606.873759418434;3664.04734768962;16919.577010574834;17257.137143142794;17446.56383590408;17497.737533937;18063.781548695177;2203.8347123965605;2223.188536184281;2253.6506841439605;2276.3739971507803;2305.6656784766114;98211;101177;102044.48977755064;104210.47894760553;106431;18930.62138757217;19521.511962200773;21094.156233750786;21369.14523419046;21568.676469852966;34561.827190863885;34780.13049673728;34795.130121747155;34889.651103489145;34949.30101397958;9719.854202186973;10201.74495637615;10222.744431389276;10285.74285642865;10344.793104137874;8403.327733781283;8419.031811341652;8448;8632.093630168867;8654.783630409163;9277.443353398818;9489.240860731124;9590.08894155054;9620.807583848284;9639.277054220822;3666.1934374437583;3689.5756987946193;3787.8484860605818;3819.236152769457;3896.376579747227;1030.9742256443649;1076.5586109694987;1092.4810714910514;1098.7527806243531;1118.4184224203368;20700.896495517427;20708.79291207099;20721;20879.582408352053;21054.47363815917;1017.6183931025865;1049.192122066005;1063.7766069125416;1109.4896347680158;1141.8743938166795;10664.466776661136;11629;11630.592929247436;11634.069274458023;11750.412479375997;571809;579174;585587;600199;602295;88071;88889;97258;98915.50542247387;102579;1052.6210564196883;1084.902358787713;1119.944002799873;1143.656902929118;1147.6786499780076;18655.160517777003;18821;18888.811111888706;19122.139503722086;19358.8064119357;30887.382252355277;34198.31603367969;43353;44134.55865441304;44297.77851110724;57465;58293.4170658288;60114;63193.052104219394;63366.68316658387;8664.78338041554;8826.161514656098;8934.821303574023;9030.503322317336;9159.49622770754;10405.791884162123;13218.537351192663;13403.195808251536;13515.729685406433;13806.240656763573;5680.2047713321;8718.956405217934;11025.944870275598;11046.502907369028;11159;11607.419629018346;11672.649820505398;11762.647120586396;11926.522939082339;12174.513019479122;11960.401979901144;12250.448729807002;12342.197757145757;12410.131290809917;12511.93744031274;8534.871976920227;8701.303895688203;8891.110888911056;8944;8994.190522852712;11458.770824583295;11643.068554515788;12045.759084818079;12180.634580962585;12274.4476498556 13:52:13 INFO - PROCESS | 12969 | |3;mootools.html;1548.5276990517887;1549.7597872329789;1763.3123081998024;1847.5565864192597;1855.2857149997246;8810.603522841471;9099.681511147111;9357.25141988641;10062.547185376658;10075.49622518874;9111.362204645677;9279.396839205447;9587.137157655827;9608.95195524023;9645.5177241138;2477.566425875469;2537.581299085649;2538.4796116796106;2538.7715105640486;2544.847309161447;2528.216252961588;2577.458733665923;2579.4196305831224;2581.4449893272945;2582.2640547443984;2543.7201907790127;2555.56555385584;2560.0527804712283;2572.318335641057;2572.7555882191164;2457.594496908017;2492.43920117972;2496.5256601245705;2500.6874140732407;2507.8119141064403;2490.452100537897;2496.9750302497105;2501.9992003198868;2518.659980902573;2528.747125287475;9756.121949024622;9843.458609776459;9881.61657367969;9892.55483503244;9900.108990190918;5841.503472204868;5912.113183022581;5983.311919129269;5983.491403230731;5994.820155395301;3653.7442379033478;3777.8866634001024;3850.210706805098;3872.283627528916;3878.9030274243087;1229.901607871377;1276.8403949506312;1291.8126871603658;1305.5495853930474;1326.383231797219;13931.303434828218;14002.509912153026;14081.155130692192;14113.576592702133;14124.858751412457;5169.06956747789;5182.481751824863;5324.04167249891;5379.515843574019;5438.075527160392;11873.643790686294;11905.583304584297;11947.581834635746;11968.401579920968;12025;5884.205632239593;5993.041113421831;6014.578979471483;6023.1266466363;6035.517158627299;4821.2045012572535;5329.840104796862;5419.078756611386;5500.22996780451;5558.583106267046;4578.542145785462;4608.516105808909;4640.118377508263;4709.552592503706;4733.431988161443;1411.8164638596916;1440.3446431873472;1464.2971373740452;1467.1783801071433;1485.1979930837442;1071.287593750163;1075.774087441646;1086.1310951238977;1086.4676308608725;1096.742265567591;6407.167068281094;6629.701663425158;6711.127553418122;6819.522633415712;6891.069705589681;513.8252993981989;531.253588707866;531.5083547718423;533.0804362474778;542.2192043457409;4509.526499717548;4579.793909274091;4615.653825963066;4638.397008388888;4669.4396672399525;11990.280583164864;12139.939300303442;12148.817767733492;12168.513259469699;12369.567065152676;11742.412879355998;11919.761604767857;12084;12112.454939527743;12132.45403956824;8887.066857979818;8916.28669706435;8957.776055598662;8993.325500587482;9003.054679258714;6410.1987251593555;6443.935560644333;6511.055896895018;6561.475081993524;6626.6686665667485;10953.397563133785;11198.21612487118;11215.271007384494;11285.774284514428;11330.60342888028;11411;11677.532898683958;11687.649370518899;11737.061035117342;11840.407979600814;7787.727429539939;8447.197516235949;8460.450070745383;8673.913260867563;8703.651853925772;9643.27675424332;9663.598778177266;9667.564959576695;9697.369670971364;9707.514624268617;7740.303372696484;7839.137694853675;7913.327367173854;7921.722739704082;8034.517928924283;8459.915400845914;8488.10874858131;8512.276456501018;8552.273056790242;8707.825843483222;7845.686172553263;7870.763877083697;7875.684972601031;7879.0151231096115;7922.841543169219;5832.62087964281;6015.368386319548;6037.547183961308;6072.544559158169;6080.969595151996;5839.941600584109;5901.616394934315;5937.732802023833;5967.46292833647;6003.90994135097 13:52:13 INFO - PROCESS | 12969 | |4;prototype.html;346.2123668653813;347.86595698024433;351.08542247445405;352.19523389056013;354.9236914063476;5834;5902.9704851475735;5928.170056192132;5959.271811174765;5973.611715238507;5713.571482138836;5738.684372359518;5756.366799652035;5774.855628609287;5804.912926306099;4065.634092931628;4458.554144585548;4460.76594469009;4470.173017991666;4473.709208901411;4455;4461.620762235198;4464.017916058462;4474.753888536129;4485.215087359699;4459.308807134899;4470.508244093147;4486.573775491323;4492.505824359318;4519.932201016987;4372.453443319585;4462.665300102505;4488.316881169561;4493.415855938707;4500.559820857327;3958.960410395888;3961.108750531136;3964.781936993464;3966.2860685076676;3981.3231750602467;5675.148727690838;5688.146777983336;5690.374058853523;5712.914306285409;5723.370429252779;4970.17992031318;5102.260172275;5136.075506408845;5139.434662187194;5156.149235376159;5954.702264886781;5996.97001514994;6011.218541589609;6018.766152938637;6047.606905551125;4317.417148684919;4352.608265256111;4356.978215108936;4381.4961279452955;4423.7566933818625;6256.343083976162;6264.467520260783;6265.8120256392385;6270.372962703739;6274.905876411857;4405.273129933589;4448.644108471314;4451.443569553806;4453.665975051819;4464;4237.703360764717;4524.828082520408;4552.658550608651;4554.7039442436135;4560.771961401917;4977.427595826454;4988.102141614471;4996.350474438373;5003;5034.647574669812;5933.199018132583;5974.476508490307;5988.610740301953;6022.819315420545;6026.583752818085;1479.9556013319618;1513.5005448202066;1514.7576387777904;1533.7699345098324;1550.7518796992426;961.6441916490943;975.8731364922514;1000.5297510170209;1004.5835372125414;1018.6180182431589;5768.557860534866;5789.45000224978;5844.766209351578;5855.121731740188;5857.619254748428;6105.778844231171;6136.355682653347;6163.19878415803;6180.752769889244;6209.316975132731;5669.716514174274;5673.6028478006965;5720.340041880462;5784.82645520635;5800.361960184377;3271.413364518207;3310.7351411886993;3323.850426730803;3326.417876871538;3335.533025376449;6234.781782637677;6323.683815809283;6378.968105159444;6477.060826180177;6483.351664833479;6177.2587289525545;6201.441870231701;6266.616027345182;6294.552252981748;6298.464630506458;6252.531060170596;6391.648459334781;6446.709898054505;6504.804855854332;6513.348665133449;6243.843903902439;6252.937470625236;6262.714109350146;6264.937350626436;6278.905816412849;6181.505479561534;6234.75060997555;6251.874962500816;6252.749890004531;6258.718357674006;6358.713857876314;6492.6104433732235;6496.935030649822;6497.317781632861;6508.219013718195;4360.411344468456;4391.34323734149;4435.401220835146;4437.755923424243;4462;6111.602745821508;6259.530535209787;6279.466245369194;6289.874202515833;6320.4311611955145;6068.6965651716355;6101.877962440638;6109.236345456818;6114.877702445837;6119.44924956756;6071.332153463204;6082.513398928164;6087.086936959491;6164.568480206342;6179.382061793965;5836.591438599257;5917.319508256433;6064.211652485149;6076.453119219292;6100.206973093469;6191.783287584913;6192.535559833121;6192.566520343713;6196.721147548281;6229.657368844757;5869.559783016205;5955.40445955401;6008.819735407945;6015.699215039143;6040.154378386941 13:52:13 INFO - PROCESS | 12969 | |5;yui.html;816.6325153680841;825.4551995682847;826.8011383493936;908.8863892013499;941.1482608239544;15549.844501554995;17145.57136071599;17206.827931720694;17277.827221727777;17462.388816391427;15754.606134846634;16580.75128873068;16621.83378166218;16676;16726.7490987635;863.8229163021565;881.7795551112222;881.995590022049;883.3551507399602;884.2881480408269;869.543489667923;896.995515022424;900.9054049324825;901.4366021236727;902.4946030223064;940.7271891151557;949.6723630347519;950.1875896108832;952.2382094324547;953.699584630839;934.2385955446324;935.6304259817368;937.3625934364629;942.2744486745237;944.9102335278207;690.9170899492043;694.3022262626029;695.9721611135549;698.5284932670478;700.982475438113;15294.617634559114;15332.310046047955;15349;15365.001274917206;15383.923080384639;16224.188790560425;16305.103219322933;16452.424165154163;16473.176341182894;16560.337586496527;12593.929515991153;12714;12908.54820081302;13067.934660326733;13246.933765331209;4081.3469844824685;4107.486564179478;4114.485689288839;4122.711410201287;4153.771542565158;88044;88572;91409.54295228481;91745.54127229388;91842.5407872963;11999.160058795975;12003.399830008464;12012.75974480523;12016.459259333351;12143.392830358624;24052.27843164708;24107.15624953118;24168.274951751475;24239.394015149763;24279.63580546293;8953.59708813105;9433.52832358393;9450.952745236229;9605.231581473465;9663.613455461844;5193.065917756456;5241.685498870003;5267.894642107136;5313.468653134656;5419.593530485229;4039.071013666873;4156.729812562174;4195.119025004783;4222.9577704223175;4225.9577404225565;650.1061041068531;662.8475450646379;663.6316844151446;682.2052309059989;682.5802131688976;693.4209934704578;781.5662307419436;782.1743456715525;807.1444269074799;820.9343252539783;9958.80082398348;10341;10422.895771042193;10587.417692026858;10587.735306617396;635.3678090300181;696.4150113904243;788.8658927982257;805.2672068417829;827.5117680568494;4782.3543821584335;4942.777575009133;5073.1122053640465;5107.540321371094;5143.794248230104;114687.42656286832;128948.3552582231;130879;131303;133951.33024334817;68813;97254;116816.41591791986;118164.6825892837;121065.39467302606;80952.59523702462;94303.52848235714;98627;101183.99999999853;101880;9154.450732956044;9157.954210228907;9693.563789629625;9750.366226195274;9805.509724513604;39081.6091839078;42133.57866421419;50056;51565.48434515607;52338.21492677537;78781.21218787739;78816;80476.19523804921;80966.59516702378;84519;11516.596919107791;12204.81692774627;12979.675508112372;13313.201207927556;14166.291685415481;14640.41438342497;14731.926340368229;15790.684186316439;16035.35858565691;16184.67630647357;15519.542611259538;15825.841741582897;15916.602084947968;16152.919235403748;16746.246418910934;15745.370185192922;15819.367225311318;15984.840151598335;16370.754438683667;17066;13344.866551334362;13839.30803459843;14013.719725605635;14269.643258918195;14326.925480588789;12458.937705311415;12970.870291296966;13046.217226966412;13210.801837972245;13532.255725935169;10383.688489345332;11929.403529823649;11968.222065565711;12020.278783273032;12068.33624150645 13:52:13 INFO - PROCESS | 12969 | __end_tp_report 13:52:13 INFO - PROCESS | 12969 | __start_cc_report 13:52:13 INFO - PROCESS | 12969 | _x_x_mozilla_cycle_collect,322 13:52:13 INFO - PROCESS | 12969 | __end_cc_report 13:52:13 INFO - PROCESS | 12969 | __startTimestamp1472503933461__endTimestamp 13:52:13 INFO - PROCESS | 12969 | 13:52:13 INFO - PROCESS | 12969 | ------- Summary: start ------- 13:52:13 INFO - PROCESS | 12969 | Number of tests: 6 13:52:13 INFO - PROCESS | 12969 | 13:52:13 INFO - PROCESS | 12969 | [#0] dojo.html Cycles:165 Average:5825.12 Median:6063.88 stddev:666.46 (11.0%) stddev-sans-first:639.12 13:52:13 INFO - PROCESS | 12969 | Values: 3330.0 3353.7 3361.4 3383.3 3384.2 5852.0 5879.5 5892.9 5944.2 5948.7 5782.6 5840.6 5848.1 5896.5 5906.4 5287.6 5338.1 5350.0 5350.2 5383.0 5237.1 5253.6 5282.8 5332.1 5342.4 5282.3 5290.9 5333.6 5355.7 5434.2 5318.4 5323.8 5371.8 5379.5 5391.3 5128.5 5149.3 5170.6 5236.7 5341.3 5739.2 5822.2 5830.4 5835.9 5880.1 6245.1 6270.4 6275.4 6303.8 6304.3 6137.9 6162.9 6283.8 6328.2 6343.8 5757.7 5875.5 5890.2 5908.4 5911.3 6374.7 6404.7 6433.7 6438.3 6461.9 5982.2 5994.3 6179.1 6192.8 6196.8 6091.5 6163.3 6179.6 6186.2 6188.6 6175.0 6180.0 6180.8 6190.8 6202.5 6088.2 6168.6 6178.9 6187.6 6193.1 4757.4 4834.3 4843.5 4873.3 4875.0 4288.6 4290.1 4291.9 4315.8 4333.4 5812.9 5939.0 6017.9 6043.1 6063.9 6270.4 6357.6 6368.6 6377.0 6397.4 6052.1 6056.5 6057.5 6071.7 6071.9 5306.1 5403.4 5474.2 5474.6 5503.1 6484.4 6619.5 6647.8 6657.8 6660.2 6328.4 6353.3 6376.0 6379.2 6382.6 6313.5 6381.2 6547.1 6571.3 6646.5 6065.7 6140.7 6173.6 6173.7 6183.8 6282.2 6290.0 6290.3 6296.3 6313.7 5939.1 6049.5 6134.7 6144.7 6147.3 6104.8 6120.4 6169.5 6169.9 6170.4 6117.9 6119.0 6141.6 6147.2 6149.3 6046.3 6073.5 6121.3 6145.4 6199.3 5803.9 5980.5 5988.2 5993.9 5998.4 13:52:13 INFO - PROCESS | 12969 | 13:52:13 INFO - PROCESS | 12969 | [#1] ext.html Cycles:180 Average:61286.98 Median:24799.43 stddev:118050.02 (476.0%) stddev-sans-first:118293.20 13:52:13 INFO - PROCESS | 12969 | Values: 586.5 636.9 650.5 667.7 678.2 43267.4 47226.8 47278.0 47356.0 47417.8 49239.8 49498.8 49831.3 49861.8 49892.0 9197.9 9264.0 9302.0 9308.6 9353.6 9204.2 9250.1 9270.8 9276.0 9282.8 9304.7 9317.9 9345.7 9373.9 9408.6 9258.9 9269.9 9276.9 9289.5 9337.0 9124.4 9193.4 9211.6 9235.8 9244.0 45017.3 45330.3 45333.3 45337.8 45483.8 4075.6 4102.3 4397.0 4506.3 4735.2 32025.8 32091.2 36257.5 36310.1 37510.0 4380.1 4490.3 4492.6 4614.9 4711.4 398370.0 400644.0 401457.0 401702.0 403757.0 38628.6 65051.0 65476.3 65592.0 65698.0 39734.0 41238.8 41652.8 41912.8 42065.0 16027.5 16260.8 16305.9 16339.4 16343.3 13349.3 13408.5 13454.9 13527.6 13566.3 9250.8 9283.4 9320.8 9386.0 9486.7 3555.3 3586.3 3612.9 3668.3 3699.3 1064.6 1092.3 1099.8 1148.2 1161.1 35070.6 35184.0 35397.3 35555.8 35691.5 1147.2 1150.5 1243.2 1262.2 1262.5 17871.4 17991.4 18092.4 18291.7 18431.1 346205.0 355034.0 356857.0 357836.0 359808.0 66528.0 66874.7 67312.0 67454.3 67582.7 1443.9 1454.9 1474.2 1494.2 1495.3 34599.7 34772.3 35514.0 35641.8 35727.5 58674.0 59774.0 59816.0 59817.7 59846.0 552791.0 553842.0 555851.0 556778.0 557991.0 31634.8 32333.0 32533.5 32553.3 32742.5 55628.0 55651.4 55667.7 56551.0 56653.4 45092.5 46345.3 46577.3 47118.5 47698.8 44948.6 45704.8 46469.0 47094.3 48111.5 45495.5 45568.8 46275.0 46794.3 48481.5 39006.0 40089.8 40123.6 40709.8 40806.8 29814.1 30865.0 30904.5 31154.7 31351.8 13:52:13 INFO - PROCESS | 12969 | 13:52:13 INFO - PROCESS | 12969 | [#2] jquery.html Cycles:180 Average:34178.13 Median:28621.00 stddev:96639.80 (337.7%) stddev-sans-first:96877.65 13:52:13 INFO - PROCESS | 12969 | Values: 413.8 421.7 427.7 436.2 438.9 20400.9 20416.3 21219.5 21331.6 21407.4 19648.7 19944.6 20731.2 20765.2 21035.4 5722.2 5978.3 5989.9 5993.4 5995.0 5896.0 5947.7 6905.8 7097.9 7142.4 7176.5 7179.1 7243.6 7305.5 7312.0 6924.6 7153.5 7276.7 7671.6 7775.0 7072.6 7083.2 7109.5 7142.2 7441.9 27361.0 27813.6 28465.7 28776.3 28855.3 2782.1 2910.6 2934.0 3606.9 3664.0 16919.6 17257.1 17446.6 17497.7 18063.8 2203.8 2223.2 2253.7 2276.4 2305.7 98211.0 101177.0 102044.5 104210.5 106431.0 18930.6 19521.5 21094.2 21369.1 21568.7 34561.8 34780.1 34795.1 34889.7 34949.3 9719.9 10201.7 10222.7 10285.7 10344.8 8403.3 8419.0 8448.0 8632.1 8654.8 9277.4 9489.2 9590.1 9620.8 9639.3 3666.2 3689.6 3787.8 3819.2 3896.4 1031.0 1076.6 1092.5 1098.8 1118.4 20700.9 20708.8 20721.0 20879.6 21054.5 1017.6 1049.2 1063.8 1109.5 1141.9 10664.5 11629.0 11630.6 11634.1 11750.4 571809.0 579174.0 585587.0 600199.0 602295.0 88071.0 88889.0 97258.0 98915.5 102579.0 1052.6 1084.9 1119.9 1143.7 1147.7 18655.2 18821.0 18888.8 19122.1 19358.8 30887.4 34198.3 43353.0 44134.6 44297.8 57465.0 58293.4 60114.0 63193.1 63366.7 8664.8 8826.2 8934.8 9030.5 9159.5 10405.8 13218.5 13403.2 13515.7 13806.2 5680.2 8719.0 11025.9 11046.5 11159.0 11607.4 11672.6 11762.6 11926.5 12174.5 11960.4 12250.4 12342.2 12410.1 12511.9 8534.9 8701.3 8891.1 8944.0 8994.2 11458.8 11643.1 12045.8 12180.6 12274.4 13:52:13 INFO - PROCESS | 12969 | 13:52:13 INFO - PROCESS | 12969 | [#3] mootools.html Cycles:180 Average:6462.35 Median:4721.49 stddev:3709.20 (78.6%) stddev-sans-first:3701.23 13:52:13 INFO - PROCESS | 12969 | Values: 1548.5 1549.8 1763.3 1847.6 1855.3 8810.6 9099.7 9357.3 10062.5 10075.5 9111.4 9279.4 9587.1 9609.0 9645.5 2477.6 2537.6 2538.5 2538.8 2544.8 2528.2 2577.5 2579.4 2581.4 2582.3 2543.7 2555.6 2560.1 2572.3 2572.8 2457.6 2492.4 2496.5 2500.7 2507.8 2490.5 2497.0 2502.0 2518.7 2528.7 9756.1 9843.5 9881.6 9892.6 9900.1 5841.5 5912.1 5983.3 5983.5 5994.8 3653.7 3777.9 3850.2 3872.3 3878.9 1229.9 1276.8 1291.8 1305.5 1326.4 13931.3 14002.5 14081.2 14113.6 14124.9 5169.1 5182.5 5324.0 5379.5 5438.1 11873.6 11905.6 11947.6 11968.4 12025.0 5884.2 5993.0 6014.6 6023.1 6035.5 4821.2 5329.8 5419.1 5500.2 5558.6 4578.5 4608.5 4640.1 4709.6 4733.4 1411.8 1440.3 1464.3 1467.2 1485.2 1071.3 1075.8 1086.1 1086.5 1096.7 6407.2 6629.7 6711.1 6819.5 6891.1 513.8 531.3 531.5 533.1 542.2 4509.5 4579.8 4615.7 4638.4 4669.4 11990.3 12139.9 12148.8 12168.5 12369.6 11742.4 11919.8 12084.0 12112.5 12132.5 8887.1 8916.3 8957.8 8993.3 9003.1 6410.2 6443.9 6511.1 6561.5 6626.7 10953.4 11198.2 11215.3 11285.8 11330.6 11411.0 11677.5 11687.6 11737.1 11840.4 7787.7 8447.2 8460.5 8673.9 8703.7 9643.3 9663.6 9667.6 9697.4 9707.5 7740.3 7839.1 7913.3 7921.7 8034.5 8459.9 8488.1 8512.3 8552.3 8707.8 7845.7 7870.8 7875.7 7879.0 7922.8 5832.6 6015.4 6037.5 6072.5 6081.0 5839.9 5901.6 5937.7 5967.5 6003.9 13:52:13 INFO - PROCESS | 12969 | 13:52:13 INFO - PROCESS | 12969 | [#4] prototype.html Cycles:180 Average:5104.84 Median:5835.30 stddev:1515.36 (26.0%) stddev-sans-first:1476.92 13:52:13 INFO - PROCESS | 12969 | Values: 346.2 347.9 351.1 352.2 354.9 5834.0 5903.0 5928.2 5959.3 5973.6 5713.6 5738.7 5756.4 5774.9 5804.9 4065.6 4458.6 4460.8 4470.2 4473.7 4455.0 4461.6 4464.0 4474.8 4485.2 4459.3 4470.5 4486.6 4492.5 4519.9 4372.5 4462.7 4488.3 4493.4 4500.6 3959.0 3961.1 3964.8 3966.3 3981.3 5675.1 5688.1 5690.4 5712.9 5723.4 4970.2 5102.3 5136.1 5139.4 5156.1 5954.7 5997.0 6011.2 6018.8 6047.6 4317.4 4352.6 4357.0 4381.5 4423.8 6256.3 6264.5 6265.8 6270.4 6274.9 4405.3 4448.6 4451.4 4453.7 4464.0 4237.7 4524.8 4552.7 4554.7 4560.8 4977.4 4988.1 4996.4 5003.0 5034.6 5933.2 5974.5 5988.6 6022.8 6026.6 1480.0 1513.5 1514.8 1533.8 1550.8 961.6 975.9 1000.5 1004.6 1018.6 5768.6 5789.5 5844.8 5855.1 5857.6 6105.8 6136.4 6163.2 6180.8 6209.3 5669.7 5673.6 5720.3 5784.8 5800.4 3271.4 3310.7 3323.9 3326.4 3335.5 6234.8 6323.7 6379.0 6477.1 6483.4 6177.3 6201.4 6266.6 6294.6 6298.5 6252.5 6391.6 6446.7 6504.8 6513.3 6243.8 6252.9 6262.7 6264.9 6278.9 6181.5 6234.8 6251.9 6252.7 6258.7 6358.7 6492.6 6496.9 6497.3 6508.2 4360.4 4391.3 4435.4 4437.8 4462.0 6111.6 6259.5 6279.5 6289.9 6320.4 6068.7 6101.9 6109.2 6114.9 6119.4 6071.3 6082.5 6087.1 6164.6 6179.4 5836.6 5917.3 6064.2 6076.5 6100.2 6191.8 6192.5 6192.6 6196.7 6229.7 5869.6 5955.4 6008.8 6015.7 6040.2 13:52:13 INFO - PROCESS | 12969 | 13:52:13 INFO - PROCESS | 12969 | [#5] yui.html Cycles:180 Average:22628.48 Median:4155.25 stddev:33057.83 (795.6%) stddev-sans-first:33110.00 13:52:13 INFO - PROCESS | 12969 | Values: 816.6 825.5 826.8 908.9 941.1 15549.8 17145.6 17206.8 17277.8 17462.4 15754.6 16580.8 16621.8 16676.0 16726.7 863.8 881.8 882.0 883.4 884.3 869.5 897.0 900.9 901.4 902.5 940.7 949.7 950.2 952.2 953.7 934.2 935.6 937.4 942.3 944.9 690.9 694.3 696.0 698.5 701.0 15294.6 15332.3 15349.0 15365.0 15383.9 16224.2 16305.1 16452.4 16473.2 16560.3 12593.9 12714.0 12908.5 13067.9 13246.9 4081.3 4107.5 4114.5 4122.7 4153.8 88044.0 88572.0 91409.5 91745.5 91842.5 11999.2 12003.4 12012.8 12016.5 12143.4 24052.3 24107.2 24168.3 24239.4 24279.6 8953.6 9433.5 9451.0 9605.2 9663.6 5193.1 5241.7 5267.9 5313.5 5419.6 4039.1 4156.7 4195.1 4223.0 4226.0 650.1 662.8 663.6 682.2 682.6 693.4 781.6 782.2 807.1 820.9 9958.8 10341.0 10422.9 10587.4 10587.7 635.4 696.4 788.9 805.3 827.5 4782.4 4942.8 5073.1 5107.5 5143.8 114687.4 128948.4 130879.0 131303.0 133951.3 68813.0 97254.0 116816.4 118164.7 121065.4 80952.6 94303.5 98627.0 101184.0 101880.0 9154.5 9158.0 9693.6 9750.4 9805.5 39081.6 42133.6 50056.0 51565.5 52338.2 78781.2 78816.0 80476.2 80966.6 84519.0 11516.6 12204.8 12979.7 13313.2 14166.3 14640.4 14731.9 15790.7 16035.4 16184.7 15519.5 15825.8 15916.6 16152.9 16746.2 15745.4 15819.4 15984.8 16370.8 17066.0 13344.9 13839.3 14013.7 14269.6 14326.9 12458.9 12970.9 13046.2 13210.8 13532.3 10383.7 11929.4 11968.2 12020.3 12068.3 13:52:13 INFO - PROCESS | 12969 | -------- Summary: end -------- 13:52:13 INFO - PROCESS | 12969 | 13:52:14 INFO - TEST-INFO | 12969: exit 0 13:52:14 INFO - TEST-OK | dromaeo_css | took 1110814ms 13:52:14 INFO - TEST-START | kraken 13:52:14 INFO - operating with platform_type : linux_ 13:52:14 INFO - Initialising browser for kraken test... 13:52:14 INFO - TEST-INFO | started process 13225 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT6RwEc/profile http://localhost:39886/getInfo.html) 13:52:18 INFO - PROCESS | 13225 | __metrics Screen width/height:1600/1200 13:52:18 INFO - PROCESS | 13225 | colorDepth:24 13:52:18 INFO - PROCESS | 13225 | Browser inner width/height: 1024/697 13:52:18 INFO - PROCESS | 13225 | __metrics 13:52:19 ERROR - PROCESS | 13225 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 13:52:19 INFO - TEST-INFO | 13225: exit 0 13:52:19 INFO - Browser initialized. 13:52:19 INFO - Running cycle 1/1 for kraken test... 13:52:19 INFO - TEST-INFO | started process 13353 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT6RwEc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:52:31 INFO - PROCESS | 13353 | RSS: Main: 152190976 13:52:31 INFO - PROCESS | 13353 | 13:52:34 INFO - PROCESS | 13353 | Cycle 1(1): loaded http://localhost:39886/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39886/tests/kraken/driver.html?testName=audio-beat-detection) 13:52:34 INFO - PROCESS | 13353 | RSS: Main: 158138368 13:52:34 INFO - PROCESS | 13353 | 13:52:37 INFO - PROCESS | 13353 | Cycle 1(1): loaded http://localhost:39886/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39886/tests/kraken/driver.html?testName=audio-dft) 13:52:38 INFO - PROCESS | 13353 | RSS: Main: 156635136 13:52:38 INFO - PROCESS | 13353 | 13:52:40 INFO - PROCESS | 13353 | Cycle 1(1): loaded http://localhost:39886/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39886/tests/kraken/driver.html?testName=audio-fft) 13:52:41 INFO - PROCESS | 13353 | RSS: Main: 156966912 13:52:41 INFO - PROCESS | 13353 | 13:52:43 INFO - PROCESS | 13353 | Cycle 1(1): loaded http://localhost:39886/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39886/tests/kraken/driver.html?testName=audio-oscillator) 13:52:44 INFO - PROCESS | 13353 | RSS: Main: 157429760 13:52:44 INFO - PROCESS | 13353 | 13:52:46 INFO - PROCESS | 13353 | Cycle 1(1): loaded http://localhost:39886/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39886/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:52:47 INFO - PROCESS | 13353 | RSS: Main: 157048832 13:52:47 INFO - PROCESS | 13353 | 13:52:50 INFO - PROCESS | 13353 | Cycle 1(1): loaded http://localhost:39886/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39886/tests/kraken/driver.html?testName=imaging-darkroom) 13:52:50 INFO - PROCESS | 13353 | RSS: Main: 157278208 13:52:50 INFO - PROCESS | 13353 | 13:52:54 INFO - PROCESS | 13353 | Cycle 1(1): loaded http://localhost:39886/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39886/tests/kraken/driver.html?testName=imaging-desaturate) 13:52:54 INFO - PROCESS | 13353 | RSS: Main: 156590080 13:52:54 INFO - PROCESS | 13353 | 13:52:57 INFO - PROCESS | 13353 | Cycle 1(1): loaded http://localhost:39886/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39886/tests/kraken/driver.html?testName=json-parse-financial) 13:52:58 INFO - PROCESS | 13353 | RSS: Main: 157945856 13:52:58 INFO - PROCESS | 13353 | 13:52:59 INFO - PROCESS | 13353 | Cycle 1(1): loaded http://localhost:39886/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39886/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:53:00 INFO - PROCESS | 13353 | RSS: Main: 157175808 13:53:00 INFO - PROCESS | 13353 | 13:53:02 INFO - PROCESS | 13353 | Cycle 1(1): loaded http://localhost:39886/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39886/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:53:02 INFO - PROCESS | 13353 | RSS: Main: 156524544 13:53:02 INFO - PROCESS | 13353 | 13:53:04 INFO - PROCESS | 13353 | Cycle 1(1): loaded http://localhost:39886/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39886/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:53:05 INFO - PROCESS | 13353 | RSS: Main: 157155328 13:53:05 INFO - PROCESS | 13353 | 13:53:08 INFO - PROCESS | 13353 | Cycle 1(1): loaded http://localhost:39886/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39886/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:53:08 INFO - PROCESS | 13353 | RSS: Main: 157724672 13:53:08 INFO - PROCESS | 13353 | 13:53:11 INFO - PROCESS | 13353 | Cycle 1(1): loaded http://localhost:39886/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39886/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:53:11 INFO - PROCESS | 13353 | RSS: Main: 158199808 13:53:11 INFO - PROCESS | 13353 | 13:53:13 INFO - PROCESS | 13353 | Cycle 1(1): loaded http://localhost:39886/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39886/tests/kraken/driver.html?testName=ai-astar) 13:53:13 INFO - PROCESS | 13353 | RSS: Main: 159072256 13:53:13 INFO - PROCESS | 13353 | 13:53:13 INFO - PROCESS | 13353 | __start_tp_report 13:53:13 INFO - PROCESS | 13353 | _x_x_mozilla_page_load 13:53:13 INFO - PROCESS | 13353 | _x_x_mozilla_page_load_details 13:53:13 INFO - PROCESS | 13353 | |i|pagename|runs| 13:53:13 INFO - PROCESS | 13353 | |0;ai-astar;101;111;105;110;110;111;109;111;109;110 13:53:13 INFO - PROCESS | 13353 | |1;audio-beat-detection;139;118;147;173;116;142;148;126;174;117 13:53:13 INFO - PROCESS | 13353 | |2;audio-dft;162;164;160;162;162;163;161;161;161;159 13:53:13 INFO - PROCESS | 13353 | |3;audio-fft;75;75;76;165;76;75;76;75;179;75 13:53:13 INFO - PROCESS | 13353 | |4;audio-oscillator;83;84;144;84;84;86;129;84;86;143 13:53:13 INFO - PROCESS | 13353 | |5;imaging-gaussian-blur;117;118;117;117;117;117;118;118;117;117 13:53:13 INFO - PROCESS | 13353 | |6;imaging-darkroom;147;146;147;148;147;147;147;148;147;148 13:53:13 INFO - PROCESS | 13353 | |7;imaging-desaturate;95;96;95;96;95;95;95;96;96;95 13:53:13 INFO - PROCESS | 13353 | |8;json-parse-financial;52;51;52;54;52;54;53;52;53;61 13:53:13 INFO - PROCESS | 13353 | |9;json-stringify-tinderbox;60;61;61;61;62;60;60;60;61;61 13:53:13 INFO - PROCESS | 13353 | |10;stanford-crypto-aes;72;83;78;75;81;74;72;74;78;72 13:53:13 INFO - PROCESS | 13353 | |11;stanford-crypto-ccm;122;117;120;126;125;124;125;124;155;137 13:53:13 INFO - PROCESS | 13353 | |12;stanford-crypto-pbkdf2;156;157;154;154;157;153;154;148;150;155 13:53:13 INFO - PROCESS | 13353 | |13;stanford-crypto-sha256-iterative;62;62;62;62;61;62;60;61;60;59 13:53:13 INFO - PROCESS | 13353 | __end_tp_report 13:53:13 INFO - PROCESS | 13353 | __start_cc_report 13:53:13 INFO - PROCESS | 13353 | _x_x_mozilla_cycle_collect,859 13:53:13 INFO - PROCESS | 13353 | __end_cc_report 13:53:13 INFO - PROCESS | 13353 | __startTimestamp1472503993835__endTimestamp 13:53:13 INFO - PROCESS | 13353 | 13:53:13 INFO - PROCESS | 13353 | ------- Summary: start ------- 13:53:13 INFO - PROCESS | 13353 | Number of tests: 14 13:53:13 INFO - PROCESS | 13353 | 13:53:13 INFO - PROCESS | 13353 | [#0] ai-astar Cycles:10 Average:108.70 Median:110.00 stddev:3.23 (2.9%) stddev-sans-first:1.88 13:53:13 INFO - PROCESS | 13353 | Values: 101.0 111.0 105.0 110.0 110.0 111.0 109.0 111.0 109.0 110.0 13:53:13 INFO - PROCESS | 13353 | 13:53:13 INFO - PROCESS | 13353 | [#1] audio-beat-detection Cycles:10 Average:140.00 Median:144.50 stddev:21.47 (14.9%) stddev-sans-first:22.77 13:53:13 INFO - PROCESS | 13353 | Values: 139.0 118.0 147.0 173.0 116.0 142.0 148.0 126.0 174.0 117.0 13:53:13 INFO - PROCESS | 13353 | 13:53:13 INFO - PROCESS | 13353 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.43 (0.9%) stddev-sans-first:1.51 13:53:13 INFO - PROCESS | 13353 | Values: 162.0 164.0 160.0 162.0 162.0 163.0 161.0 161.0 161.0 159.0 13:53:13 INFO - PROCESS | 13353 | 13:53:13 INFO - PROCESS | 13353 | [#3] audio-fft Cycles:10 Average:94.70 Median:75.00 stddev:40.88 (54.5%) stddev-sans-first:42.73 13:53:13 INFO - PROCESS | 13353 | Values: 75.0 75.0 76.0 165.0 76.0 75.0 76.0 75.0 179.0 75.0 13:53:13 INFO - PROCESS | 13353 | 13:53:13 INFO - PROCESS | 13353 | [#4] audio-oscillator Cycles:10 Average:100.70 Median:84.00 stddev:26.51 (31.6%) stddev-sans-first:27.34 13:53:13 INFO - PROCESS | 13353 | Values: 83.0 84.0 144.0 84.0 84.0 86.0 129.0 84.0 86.0 143.0 13:53:13 INFO - PROCESS | 13353 | 13:53:13 INFO - PROCESS | 13353 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 13:53:13 INFO - PROCESS | 13353 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 117.0 13:53:13 INFO - PROCESS | 13353 | 13:53:13 INFO - PROCESS | 13353 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 13:53:13 INFO - PROCESS | 13353 | Values: 147.0 146.0 147.0 148.0 147.0 147.0 147.0 148.0 147.0 148.0 13:53:13 INFO - PROCESS | 13353 | 13:53:13 INFO - PROCESS | 13353 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 13:53:13 INFO - PROCESS | 13353 | Values: 95.0 96.0 95.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 13:53:13 INFO - PROCESS | 13353 | 13:53:13 INFO - PROCESS | 13353 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.00 stddev:2.84 (5.4%) stddev-sans-first:2.96 13:53:13 INFO - PROCESS | 13353 | Values: 52.0 51.0 52.0 54.0 52.0 54.0 53.0 52.0 53.0 61.0 13:53:13 INFO - PROCESS | 13353 | 13:53:13 INFO - PROCESS | 13353 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 13:53:13 INFO - PROCESS | 13353 | Values: 60.0 61.0 61.0 61.0 62.0 60.0 60.0 60.0 61.0 61.0 13:53:13 INFO - PROCESS | 13353 | 13:53:13 INFO - PROCESS | 13353 | [#10] stanford-crypto-aes Cycles:10 Average:75.90 Median:76.50 stddev:3.93 (5.1%) stddev-sans-first:3.91 13:53:13 INFO - PROCESS | 13353 | Values: 72.0 83.0 78.0 75.0 81.0 74.0 72.0 74.0 78.0 72.0 13:53:13 INFO - PROCESS | 13353 | 13:53:13 INFO - PROCESS | 13353 | [#11] stanford-crypto-ccm Cycles:10 Average:127.50 Median:125.00 stddev:10.97 (8.8%) stddev-sans-first:11.45 13:53:13 INFO - PROCESS | 13353 | Values: 122.0 117.0 120.0 126.0 125.0 124.0 125.0 124.0 155.0 137.0 13:53:13 INFO - PROCESS | 13353 | 13:53:13 INFO - PROCESS | 13353 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.80 Median:154.50 stddev:2.90 (1.9%) stddev-sans-first:2.96 13:53:13 INFO - PROCESS | 13353 | Values: 156.0 157.0 154.0 154.0 157.0 153.0 154.0 148.0 150.0 155.0 13:53:13 INFO - PROCESS | 13353 | 13:53:13 INFO - PROCESS | 13353 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.10 Median:62.00 stddev:1.10 (1.8%) stddev-sans-first:1.12 13:53:13 INFO - PROCESS | 13353 | Values: 62.0 62.0 62.0 62.0 61.0 62.0 60.0 61.0 60.0 59.0 13:53:13 INFO - PROCESS | 13353 | -------- Summary: end -------- 13:53:13 INFO - PROCESS | 13353 | 13:53:14 INFO - TEST-INFO | 13353: exit 0 13:53:14 INFO - TEST-OK | kraken | took 60644ms 13:53:14 INFO - SUITE-END | took 1171s 13:53:15 INFO - Completed test suite (00:19:31) 13:53:15 INFO - javascript benchmark 13:53:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7947.256685190448, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3329.9500507492385, 3353.6814002669753, 3361.3613413451444, 3383.323335332934, 3384.187794929218, 5852.0, 5879.500242479395, 5892.852678683035, 5944.167816505693, 5948.672822994734, 5782.624129431594, 5840.620359676618, 5848.064309710437, 5896.498797602209, 5906.350301466835, 5287.576993840484, 5338.092524270884, 5350.036993341197, 5350.224217488462, 5383.031054410205, 5237.083510385686, 5253.60597955153, 5282.841514754564, 5332.14685650296, 5342.358916929955, 5282.339707536558, 5290.92063619046, 5333.626646134772, 5355.732213389334, 5434.157705555625, 5318.414974352818, 5323.787048518094, 5371.785128594852, 5379.488948549882, 5391.29913111295, 5128.538431541142, 5149.2791009258735, 5170.612204084671, 5236.6857988520815, 5341.305630268041, 5739.16782066598, 5822.155787410844, 5830.4461076197695, 5835.883282334329, 5880.117982302646, 6245.094461303085, 6270.404311590437, 6275.403836635513, 6303.779367722108, 6304.306526282106, 6137.9386206137815, 6162.8767424651705, 6283.8114856554375, 6328.1773369462135, 6343.8414039648915, 5757.712114394263, 5875.471207591295, 5890.204822348928, 5908.379620139866, 5911.320198177222, 6374.74501019954, 6404.743810247538, 6433.710483028275, 6438.259600146043, 6461.935380646133, 5982.192404025488, 5994.310654274727, 6179.134921111048, 6192.845178870564, 6196.845078873064, 6091.48222401092, 6163.322034576193, 6179.567430279837, 6186.1648677428875, 6188.566800324024, 6175.042868355412, 6180.042093475518, 6180.783672571439, 6190.81427557174, 6202.503799696014, 6088.208532890784, 6168.599041062316, 6178.907316390258, 6187.566870319124, 6193.102000209944, 4757.405324334458, 4834.323194752737, 4843.491433399442, 4873.26900964851, 4874.951250487521, 4288.635465985364, 4290.077633308853, 4291.871243862689, 4315.762633055149, 4333.371661109121, 5812.912806307909, 5938.970305148447, 6017.909731354033, 6043.09353596964, 6063.878722425527, 6270.404311590391, 6357.618542887441, 6368.586041907354, 6377.0, 6397.360263973658, 6052.122442245938, 6056.454919057306, 6057.515398768088, 6071.6660583667435, 6071.908921366095, 5306.124489459196, 5403.405625381205, 5474.178873168977, 5474.644148130438, 5503.091989821634, 6484.383983521558, 6619.5035372347265, 6647.833804154935, 6657.766978155838, 6660.200775907019, 6328.430441260309, 6353.3011368748475, 6376.043593460832, 6379.170707808141, 6382.585131966407, 6313.526485513513, 6381.202349706286, 6547.083408322744, 6571.277159512354, 6646.501512386493, 6065.666388348507, 6140.688304616564, 6173.56785025044, 6173.660448675366, 6183.752649893954, 6282.1519094921605, 6290.0, 6290.308066112815, 6296.338884417253, 6313.715882785194, 5939.07944268639, 6049.485793707584, 6134.723937422737, 6144.692765361803, 6147.293061297829, 6104.786332478519, 6120.387961203844, 6169.537284703575, 6169.876602468015, 6170.382961703794, 6117.877642447037, 6119.040615792663, 6141.6007959482495, 6147.200863887666, 6149.323574406902, 6046.334903160737, 6073.453389194994, 6121.330490065119, 6145.385461453819, 6199.3490683477585, 5803.883922321445, 5980.491658209101, 5988.221531200916, 5993.850153746192, 5998.400159983967], "value": 5779.7109659716725, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.5014737473149, 636.9012803015532, 650.5478692308848, 667.6961982298053, 678.2064983968756, 43267.350989735176, 47226.81932951674, 47278.0, 47356.0, 47417.76291118544, 49239.753801230945, 49498.752506237506, 49831.25253121197, 49861.750691246496, 49892.0, 9197.90802091979, 9264.0, 9301.95349023254, 9308.58111384986, 9353.625854965792, 9204.171624553788, 9250.121238482334, 9270.768230794216, 9276.0, 9282.814343713122, 9304.72085837426, 9317.860232096524, 9345.67290144845, 9373.859392109123, 9408.576614052385, 9258.907410925905, 9269.860952085724, 9276.907230927673, 9289.535523223813, 9337.0, 9124.361294709373, 9193.35646504745, 9211.631534738603, 9235.815283694355, 9244.0, 45017.324740128926, 45330.32004519935, 45333.32000020002, 45337.773311133235, 45483.772581137215, 4075.551689314173, 4102.343625019982, 4397.0, 4506.301523263866, 4735.242361222222, 32025.839870800497, 32091.197720056953, 36257.45613815795, 36310.092247693756, 37510.0, 4380.102079073782, 4490.326451032339, 4492.595666390041, 4614.907701845944, 4711.387519622427, 398370.0, 400644.0, 401457.0, 401701.9999999971, 403757.0, 38628.613713863066, 65051.0, 65476.345236547975, 65592.0, 65698.01452978209, 39734.0, 41238.79380603078, 41652.79173604112, 41912.790436047624, 42065.0, 16027.519174424786, 16260.75608865868, 16305.918470407572, 16339.42812001598, 16343.34626614946, 13349.265790381622, 13408.530701425403, 13454.93272533631, 13527.594172174851, 13566.321683915765, 9250.814983700422, 9283.442993420416, 9320.813583728288, 9386.0, 9486.715398538056, 3555.3244883472057, 3586.282743451268, 3612.87354942581, 3668.3396988541786, 3699.2601479704167, 1064.6072409093583, 1092.3282181458346, 1099.8075336816025, 1148.2478976270556, 1161.088545491785, 35070.649293507246, 35184.0, 35397.292054158774, 35555.82222088925, 35691.4646280306, 1147.2428197389684, 1150.5110328110686, 1243.1795015290047, 1262.217425196384, 1262.5202423079354, 17871.421717575635, 17991.370302039366, 18092.366767163086, 18291.72562411565, 18431.07844607764, 346205.0, 355034.0, 356857.0, 357836.0, 359808.0, 66528.0, 66874.66562667156, 67312.0, 67454.32545674579, 67582.66208669024, 1443.9278036098153, 1454.919979401143, 1474.1744623010934, 1494.2454060699495, 1495.349522957517, 34599.65400345964, 34772.304553908274, 35514.0, 35641.82179089192, 35727.46408803922, 58674.0, 59774.0, 59816.0, 59817.700911495165, 59846.0, 552791.0, 553842.0, 555851.0, 556778.0, 557991.0, 31634.841825790725, 32333.0, 32533.511997320533, 32553.34893302168, 32742.50886236661, 55628.0, 55651.443485564625, 55667.721661391435, 56551.0, 56653.43346566481, 45092.54907450883, 46345.30482042839, 46577.3013404806, 47118.52881471279, 47698.76150619364, 44948.55051449444, 45704.77147614241, 46469.0, 47094.29358559556, 48111.51888481071, 45495.54504454913, 45568.772156139006, 46275.0, 46794.29808552806, 48481.5151848477, 39006.0, 40089.79955100323, 40123.59876401316, 40709.79645101756, 40806.79596601998, 29814.105576831862, 30865.0, 30904.536431953988, 31154.688453116087, 31351.84324078365], "value": 20572.240436039912, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.7993073359418, 421.69848558280825, 427.69847257683324, 436.1669211805452, 438.92538268494354, 20400.89799551004, 20416.285430009953, 21219.469513262175, 21331.57336853262, 21407.357779266607, 19648.719550281075, 19944.60110797787, 20731.170753169856, 20765.169393224252, 21035.368938931817, 5722.227499287595, 5978.282606087276, 5989.940100599004, 5993.4006599340155, 5995.040793473046, 5895.9705201473935, 5947.672877991708, 6905.827354316132, 7097.858042839166, 7142.428605711557, 7176.461765367592, 7179.06672132622, 7243.6378181090995, 7305.488615796897, 7312.0, 6924.58452492847, 7153.499255052148, 7276.745313914014, 7671.578063206522, 7774.999999999972, 7072.611006394646, 7083.220845706968, 7109.46678999072, 7142.178649455327, 7441.8511629767645, 27361.0, 27813.582796258073, 28465.71534284672, 28776.280592985135, 28855.278618034507, 2782.1097248880365, 2910.5634154876725, 2934.046434908642, 3606.873759418434, 3664.04734768962, 16919.577010574834, 17257.137143142794, 17446.56383590408, 17497.737533937, 18063.781548695177, 2203.8347123965605, 2223.188536184281, 2253.6506841439605, 2276.3739971507803, 2305.6656784766114, 98211.0, 101177.0, 102044.48977755064, 104210.47894760553, 106431.0, 18930.62138757217, 19521.511962200773, 21094.156233750786, 21369.14523419046, 21568.676469852966, 34561.827190863885, 34780.13049673728, 34795.130121747155, 34889.651103489145, 34949.30101397958, 9719.854202186973, 10201.74495637615, 10222.744431389276, 10285.74285642865, 10344.793104137874, 8403.327733781283, 8419.031811341652, 8448.0, 8632.093630168867, 8654.783630409163, 9277.443353398818, 9489.240860731124, 9590.08894155054, 9620.807583848284, 9639.277054220822, 3666.1934374437583, 3689.5756987946193, 3787.8484860605818, 3819.236152769457, 3896.376579747227, 1030.9742256443649, 1076.5586109694987, 1092.4810714910514, 1098.7527806243531, 1118.4184224203368, 20700.896495517427, 20708.79291207099, 20721.0, 20879.582408352053, 21054.47363815917, 1017.6183931025865, 1049.192122066005, 1063.7766069125416, 1109.4896347680158, 1141.8743938166795, 10664.466776661136, 11629.0, 11630.592929247436, 11634.069274458023, 11750.412479375997, 571809.0, 579174.0, 585587.0, 600199.0, 602295.0, 88071.0, 88889.0, 97258.0, 98915.50542247387, 102579.0, 1052.6210564196883, 1084.902358787713, 1119.944002799873, 1143.656902929118, 1147.6786499780076, 18655.160517777003, 18821.0, 18888.811111888706, 19122.139503722086, 19358.8064119357, 30887.382252355277, 34198.31603367969, 43353.0, 44134.55865441304, 44297.77851110724, 57465.0, 58293.4170658288, 60114.0, 63193.052104219394, 63366.68316658387, 8664.78338041554, 8826.161514656098, 8934.821303574023, 9030.503322317336, 9159.49622770754, 10405.791884162123, 13218.537351192663, 13403.195808251536, 13515.729685406433, 13806.240656763573, 5680.2047713321, 8718.956405217934, 11025.944870275598, 11046.502907369028, 11159.0, 11607.419629018346, 11672.649820505398, 11762.647120586396, 11926.522939082339, 12174.513019479122, 11960.401979901144, 12250.448729807002, 12342.197757145757, 12410.131290809917, 12511.93744031274, 8534.871976920227, 8701.303895688203, 8891.110888911056, 8944.0, 8994.190522852712, 11458.770824583295, 11643.068554515788, 12045.759084818079, 12180.634580962585, 12274.4476498556], "value": 10977.683556732136, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1548.5276990517887, 1549.7597872329789, 1763.3123081998024, 1847.5565864192597, 1855.2857149997246, 8810.603522841471, 9099.681511147111, 9357.25141988641, 10062.547185376658, 10075.49622518874, 9111.362204645677, 9279.396839205447, 9587.137157655827, 9608.95195524023, 9645.5177241138, 2477.566425875469, 2537.581299085649, 2538.4796116796106, 2538.7715105640486, 2544.847309161447, 2528.216252961588, 2577.458733665923, 2579.4196305831224, 2581.4449893272945, 2582.2640547443984, 2543.7201907790127, 2555.56555385584, 2560.0527804712283, 2572.318335641057, 2572.7555882191164, 2457.594496908017, 2492.43920117972, 2496.5256601245705, 2500.6874140732407, 2507.8119141064403, 2490.452100537897, 2496.9750302497105, 2501.9992003198868, 2518.659980902573, 2528.747125287475, 9756.121949024622, 9843.458609776459, 9881.61657367969, 9892.55483503244, 9900.108990190918, 5841.503472204868, 5912.113183022581, 5983.311919129269, 5983.491403230731, 5994.820155395301, 3653.7442379033478, 3777.8866634001024, 3850.210706805098, 3872.283627528916, 3878.9030274243087, 1229.901607871377, 1276.8403949506312, 1291.8126871603658, 1305.5495853930474, 1326.383231797219, 13931.303434828218, 14002.509912153026, 14081.155130692192, 14113.576592702133, 14124.858751412457, 5169.06956747789, 5182.481751824863, 5324.04167249891, 5379.515843574019, 5438.075527160392, 11873.643790686294, 11905.583304584297, 11947.581834635746, 11968.401579920968, 12025.0, 5884.205632239593, 5993.041113421831, 6014.578979471483, 6023.1266466363, 6035.517158627299, 4821.2045012572535, 5329.840104796862, 5419.078756611386, 5500.22996780451, 5558.583106267046, 4578.542145785462, 4608.516105808909, 4640.118377508263, 4709.552592503706, 4733.431988161443, 1411.8164638596916, 1440.3446431873472, 1464.2971373740452, 1467.1783801071433, 1485.1979930837442, 1071.287593750163, 1075.774087441646, 1086.1310951238977, 1086.4676308608725, 1096.742265567591, 6407.167068281094, 6629.701663425158, 6711.127553418122, 6819.522633415712, 6891.069705589681, 513.8252993981989, 531.253588707866, 531.5083547718423, 533.0804362474778, 542.2192043457409, 4509.526499717548, 4579.793909274091, 4615.653825963066, 4638.397008388888, 4669.4396672399525, 11990.280583164864, 12139.939300303442, 12148.817767733492, 12168.513259469699, 12369.567065152676, 11742.412879355998, 11919.761604767857, 12084.0, 12112.454939527743, 12132.45403956824, 8887.066857979818, 8916.28669706435, 8957.776055598662, 8993.325500587482, 9003.054679258714, 6410.1987251593555, 6443.935560644333, 6511.055896895018, 6561.475081993524, 6626.6686665667485, 10953.397563133785, 11198.21612487118, 11215.271007384494, 11285.774284514428, 11330.60342888028, 11411.0, 11677.532898683958, 11687.649370518899, 11737.061035117342, 11840.407979600814, 7787.727429539939, 8447.197516235949, 8460.450070745383, 8673.913260867563, 8703.651853925772, 9643.27675424332, 9663.598778177266, 9667.564959576695, 9697.369670971364, 9707.514624268617, 7740.303372696484, 7839.137694853675, 7913.327367173854, 7921.722739704082, 8034.517928924283, 8459.915400845914, 8488.10874858131, 8512.276456501018, 8552.273056790242, 8707.825843483222, 7845.686172553263, 7870.763877083697, 7875.684972601031, 7879.0151231096115, 7922.841543169219, 5832.62087964281, 6015.368386319548, 6037.547183961308, 6072.544559158169, 6080.969595151996, 5839.941600584109, 5901.616394934315, 5937.732802023833, 5967.46292833647, 6003.90994135097], "value": 5084.817523570014, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.2123668653813, 347.86595698024433, 351.08542247445405, 352.19523389056013, 354.9236914063476, 5834.0, 5902.9704851475735, 5928.170056192132, 5959.271811174765, 5973.611715238507, 5713.571482138836, 5738.684372359518, 5756.366799652035, 5774.855628609287, 5804.912926306099, 4065.634092931628, 4458.554144585548, 4460.76594469009, 4470.173017991666, 4473.709208901411, 4455.0, 4461.620762235198, 4464.017916058462, 4474.753888536129, 4485.215087359699, 4459.308807134899, 4470.508244093147, 4486.573775491323, 4492.505824359318, 4519.932201016987, 4372.453443319585, 4462.665300102505, 4488.316881169561, 4493.415855938707, 4500.559820857327, 3958.960410395888, 3961.108750531136, 3964.781936993464, 3966.2860685076676, 3981.3231750602467, 5675.148727690838, 5688.146777983336, 5690.374058853523, 5712.914306285409, 5723.370429252779, 4970.17992031318, 5102.260172275, 5136.075506408845, 5139.434662187194, 5156.149235376159, 5954.702264886781, 5996.97001514994, 6011.218541589609, 6018.766152938637, 6047.606905551125, 4317.417148684919, 4352.608265256111, 4356.978215108936, 4381.4961279452955, 4423.7566933818625, 6256.343083976162, 6264.467520260783, 6265.8120256392385, 6270.372962703739, 6274.905876411857, 4405.273129933589, 4448.644108471314, 4451.443569553806, 4453.665975051819, 4464.0, 4237.703360764717, 4524.828082520408, 4552.658550608651, 4554.7039442436135, 4560.771961401917, 4977.427595826454, 4988.102141614471, 4996.350474438373, 5003.0, 5034.647574669812, 5933.199018132583, 5974.476508490307, 5988.610740301953, 6022.819315420545, 6026.583752818085, 1479.9556013319618, 1513.5005448202066, 1514.7576387777904, 1533.7699345098324, 1550.7518796992426, 961.6441916490943, 975.8731364922514, 1000.5297510170209, 1004.5835372125414, 1018.6180182431589, 5768.557860534866, 5789.45000224978, 5844.766209351578, 5855.121731740188, 5857.619254748428, 6105.778844231171, 6136.355682653347, 6163.19878415803, 6180.752769889244, 6209.316975132731, 5669.716514174274, 5673.6028478006965, 5720.340041880462, 5784.82645520635, 5800.361960184377, 3271.413364518207, 3310.7351411886993, 3323.850426730803, 3326.417876871538, 3335.533025376449, 6234.781782637677, 6323.683815809283, 6378.968105159444, 6477.060826180177, 6483.351664833479, 6177.2587289525545, 6201.441870231701, 6266.616027345182, 6294.552252981748, 6298.464630506458, 6252.531060170596, 6391.648459334781, 6446.709898054505, 6504.804855854332, 6513.348665133449, 6243.843903902439, 6252.937470625236, 6262.714109350146, 6264.937350626436, 6278.905816412849, 6181.505479561534, 6234.75060997555, 6251.874962500816, 6252.749890004531, 6258.718357674006, 6358.713857876314, 6492.6104433732235, 6496.935030649822, 6497.317781632861, 6508.219013718195, 4360.411344468456, 4391.34323734149, 4435.401220835146, 4437.755923424243, 4462.0, 6111.602745821508, 6259.530535209787, 6279.466245369194, 6289.874202515833, 6320.4311611955145, 6068.6965651716355, 6101.877962440638, 6109.236345456818, 6114.877702445837, 6119.44924956756, 6071.332153463204, 6082.513398928164, 6087.086936959491, 6164.568480206342, 6179.382061793965, 5836.591438599257, 5917.319508256433, 6064.211652485149, 6076.453119219292, 6100.206973093469, 6191.783287584913, 6192.535559833121, 6192.566520343713, 6196.721147548281, 6229.657368844757, 5869.559783016205, 5955.40445955401, 6008.819735407945, 6015.699215039143, 6040.154378386941], "value": 4614.287600801673, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [816.6325153680841, 825.4551995682847, 826.8011383493936, 908.8863892013499, 941.1482608239544, 15549.844501554995, 17145.57136071599, 17206.827931720694, 17277.827221727777, 17462.388816391427, 15754.606134846634, 16580.75128873068, 16621.83378166218, 16676.0, 16726.7490987635, 863.8229163021565, 881.7795551112222, 881.995590022049, 883.3551507399602, 884.2881480408269, 869.543489667923, 896.995515022424, 900.9054049324825, 901.4366021236727, 902.4946030223064, 940.7271891151557, 949.6723630347519, 950.1875896108832, 952.2382094324547, 953.699584630839, 934.2385955446324, 935.6304259817368, 937.3625934364629, 942.2744486745237, 944.9102335278207, 690.9170899492043, 694.3022262626029, 695.9721611135549, 698.5284932670478, 700.982475438113, 15294.617634559114, 15332.310046047955, 15349.0, 15365.001274917206, 15383.923080384639, 16224.188790560425, 16305.103219322933, 16452.424165154163, 16473.176341182894, 16560.337586496527, 12593.929515991153, 12714.0, 12908.54820081302, 13067.934660326733, 13246.933765331209, 4081.3469844824685, 4107.486564179478, 4114.485689288839, 4122.711410201287, 4153.771542565158, 88044.0, 88572.0, 91409.54295228481, 91745.54127229388, 91842.5407872963, 11999.160058795975, 12003.399830008464, 12012.75974480523, 12016.459259333351, 12143.392830358624, 24052.27843164708, 24107.15624953118, 24168.274951751475, 24239.394015149763, 24279.63580546293, 8953.59708813105, 9433.52832358393, 9450.952745236229, 9605.231581473465, 9663.613455461844, 5193.065917756456, 5241.685498870003, 5267.894642107136, 5313.468653134656, 5419.593530485229, 4039.071013666873, 4156.729812562174, 4195.119025004783, 4222.9577704223175, 4225.9577404225565, 650.1061041068531, 662.8475450646379, 663.6316844151446, 682.2052309059989, 682.5802131688976, 693.4209934704578, 781.5662307419436, 782.1743456715525, 807.1444269074799, 820.9343252539783, 9958.80082398348, 10341.0, 10422.895771042193, 10587.417692026858, 10587.735306617396, 635.3678090300181, 696.4150113904243, 788.8658927982257, 805.2672068417829, 827.5117680568494, 4782.3543821584335, 4942.777575009133, 5073.1122053640465, 5107.540321371094, 5143.794248230104, 114687.42656286832, 128948.3552582231, 130879.0, 131303.0, 133951.33024334817, 68813.0, 97254.0, 116816.41591791986, 118164.6825892837, 121065.39467302606, 80952.59523702462, 94303.52848235714, 98627.0, 101183.99999999853, 101880.0, 9154.450732956044, 9157.954210228907, 9693.563789629625, 9750.366226195274, 9805.509724513604, 39081.6091839078, 42133.57866421419, 50056.0, 51565.48434515607, 52338.21492677537, 78781.21218787739, 78816.0, 80476.19523804921, 80966.59516702378, 84519.0, 11516.596919107791, 12204.81692774627, 12979.675508112372, 13313.201207927556, 14166.291685415481, 14640.41438342497, 14731.926340368229, 15790.684186316439, 16035.35858565691, 16184.67630647357, 15519.542611259538, 15825.841741582897, 15916.602084947968, 16152.919235403748, 16746.246418910934, 15745.370185192922, 15819.367225311318, 15984.840151598335, 16370.754438683667, 17066.0, 13344.866551334362, 13839.30803459843, 14013.719725605635, 14269.643258918195, 14326.925480588789, 12458.937705311415, 12970.870291296966, 13046.217226966412, 13210.801837972245, 13532.255725935169, 10383.688489345332, 11929.403529823649, 11968.222065565711, 12020.278783273032, 12068.33624150645], "value": 8225.9249709547, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1497.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 105.0, 110.0, 110.0, 111.0, 109.0, 111.0, 109.0, 110.0], "value": 108.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 118.0, 147.0, 173.0, 116.0, 142.0, 148.0, 126.0, 174.0, 117.0], "value": 140.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 160.0, 162.0, 162.0, 163.0, 161.0, 161.0, 161.0, 159.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 165.0, 76.0, 75.0, 76.0, 75.0, 179.0, 75.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 144.0, 84.0, 84.0, 86.0, 129.0, 84.0, 86.0, 143.0], "value": 100.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 148.0, 147.0, 147.0, 147.0, 148.0, 147.0, 148.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 52.0, 54.0, 52.0, 54.0, 53.0, 52.0, 53.0, 61.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 61.0, 62.0, 60.0, 60.0, 60.0, 61.0, 61.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 83.0, 78.0, 75.0, 81.0, 74.0, 72.0, 74.0, 78.0, 72.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 117.0, 120.0, 126.0, 125.0, 124.0, 125.0, 124.0, 155.0, 137.0], "value": 127.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 157.0, 154.0, 154.0, 157.0, 153.0, 154.0, 148.0, 150.0, 155.0], "value": 153.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 61.0, 62.0, 60.0, 61.0, 60.0, 59.0], "value": 61.1, "unit": "score"}]}]} 13:53:15 INFO - Return code: 0 13:53:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:53:15 ERROR - # TBPL SUCCESS # 13:53:15 INFO - Running post-action listener: _resource_record_post_action 13:53:15 INFO - [mozharness: 2016-08-29 20:53:15.163387Z] Finished run-tests step (success) 13:53:15 INFO - Running post-run listener: _resource_record_post_run 13:53:15 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 610304; Write bytes: 329273344; Read time: 388; Write time: 272000 13:53:15 INFO - TinderboxPrint: CPU usage
13.2% 13:53:15 INFO - TinderboxPrint: I/O read bytes / time
610,304 / 388 13:53:15 INFO - TinderboxPrint: I/O write bytes / time
329,273,344 / 272,000 13:53:15 INFO - TinderboxPrint: CPU idle
8,225.9 (86.8%) 13:53:15 INFO - TinderboxPrint: CPU user
1,198.0 (12.6%) 13:53:15 INFO - TinderboxPrint: Swap in / out
0 / 0 13:53:15 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 78438400; Read time: 208; Write time: 90104 13:53:15 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 606208; Write bytes: 249937920; Read time: 180; Write time: 181880 13:53:15 INFO - Running post-run listener: _upload_blobber_files 13:53:15 INFO - Blob upload gear active. 13:53:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:53:15 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:53:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:53:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:53:16 INFO - (blobuploader) - INFO - Open directory for files ... 13:53:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:53:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:53:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:53:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:53:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:53:16 INFO - (blobuploader) - INFO - Done attempting. 13:53:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:53:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:53:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:53:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:53:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:53:21 INFO - (blobuploader) - INFO - Done attempting. 13:53:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:53:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:53:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:53:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:53:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:53:21 INFO - (blobuploader) - INFO - Done attempting. 13:53:21 INFO - (blobuploader) - INFO - Iteration through files over. 13:53:21 INFO - Return code: 0 13:53:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:53:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:53:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1fae3df471a7e817136d659f9d42a25719e926aede9875a0c1c10b9d522e5af6e1a5f0273b30680f25c54091c014c5e7b42fccc00c8422c5da98ffa1b3f93d71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/938eb7d9d12ea11199a7a989c86433f35f041807d11857d36c68cb851172aa1284b541edb336c8af6b55ac574571aa1dd541cd8d30bb7c301d5967c309f29c28", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cb154064bdd4bcc0749d53383c41ee5cfe5aaabc07c603f62f020a1bd27902822bedde524056aa5715278a13559349f20c134966e67a82d108b39b996a354eeb"} 13:53:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:53:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:53:21 INFO - Contents: 13:53:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1fae3df471a7e817136d659f9d42a25719e926aede9875a0c1c10b9d522e5af6e1a5f0273b30680f25c54091c014c5e7b42fccc00c8422c5da98ffa1b3f93d71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/938eb7d9d12ea11199a7a989c86433f35f041807d11857d36c68cb851172aa1284b541edb336c8af6b55ac574571aa1dd541cd8d30bb7c301d5967c309f29c28", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cb154064bdd4bcc0749d53383c41ee5cfe5aaabc07c603f62f020a1bd27902822bedde524056aa5715278a13559349f20c134966e67a82d108b39b996a354eeb"} 13:53:21 INFO - Running post-run listener: copy_logs_to_upload_dir 13:53:21 INFO - Copying logs to upload dir... 13:53:21 INFO - mkdir: /builds/slave/test/build/upload/logs 13:53:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1676.346533 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 56 secs) (at 2016-08-29 13:53:21.716900) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-29 13:53:21.720277) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1472502322.623800-82203651 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/1fae3df471a7e817136d659f9d42a25719e926aede9875a0c1c10b9d522e5af6e1a5f0273b30680f25c54091c014c5e7b42fccc00c8422c5da98ffa1b3f93d71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/938eb7d9d12ea11199a7a989c86433f35f041807d11857d36c68cb851172aa1284b541edb336c8af6b55ac574571aa1dd541cd8d30bb7c301d5967c309f29c28", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cb154064bdd4bcc0749d53383c41ee5cfe5aaabc07c603f62f020a1bd27902822bedde524056aa5715278a13559349f20c134966e67a82d108b39b996a354eeb"} build_url:https://queue.taskcluster.net/v1/task/cQZgZ3OATKiRrUDD4u0HFw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011272 build_url: 'https://queue.taskcluster.net/v1/task/cQZgZ3OATKiRrUDD4u0HFw/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/1fae3df471a7e817136d659f9d42a25719e926aede9875a0c1c10b9d522e5af6e1a5f0273b30680f25c54091c014c5e7b42fccc00c8422c5da98ffa1b3f93d71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/938eb7d9d12ea11199a7a989c86433f35f041807d11857d36c68cb851172aa1284b541edb336c8af6b55ac574571aa1dd541cd8d30bb7c301d5967c309f29c28", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cb154064bdd4bcc0749d53383c41ee5cfe5aaabc07c603f62f020a1bd27902822bedde524056aa5715278a13559349f20c134966e67a82d108b39b996a354eeb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-29 13:53:21.748808) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 13:53:21.749548) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1472502322.623800-82203651 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004442 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 13:53:21.834503) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-29 13:53:21.835178) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-29 13:53:21.835813) ========= ========= Total master_lag: 0.18 =========