builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-061 starttime: 1475598548.69 results: success (0) buildid: 20161004062601 builduid: 859544fdaa414e909dbaa42ee7ed5b4f revision: bebbf04b7fe13ed3e43d729558505d2917691621 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 09:29:08.687429) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 09:29:08.687883) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 09:29:08.688160) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 09:29:08.702302) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 09:29:08.702562) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1475598549.110116-1000168975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-04 09:29:09-- 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% 114M=0s 2016-10-04 09:29:09 (114 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085130 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 09:29:08.800905) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 09:29:08.801216) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1475598549.110116-1000168975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016706 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 09:29:08.850222) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 09:29:08.850550) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev bebbf04b7fe13ed3e43d729558505d2917691621 --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-beta --rev bebbf04b7fe13ed3e43d729558505d2917691621 --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=516f8d7ca085b4d087ab0a71000001a4-1475598549.110116-1000168975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-04 09:29:09,988 truncating revision to first 12 chars 2016-10-04 09:29:09,988 Setting DEBUG logging. 2016-10-04 09:29:09,988 attempt 1/10 2016-10-04 09:29:09,988 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/bebbf04b7fe1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 09:29:10,327 unpacking tar archive at: mozilla-beta-bebbf04b7fe1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.679657 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 09:29:09.543296) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 09:29:09.543626) ========= script_repo_revision: bebbf04b7fe13ed3e43d729558505d2917691621 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 09:29:09.544064) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 09:29:09.544333) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 09:29:09.554573) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 53 secs) (at 2016-10-04 09:29:09.554862) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=516f8d7ca085b4d087ab0a71000001a4-1475598549.110116-1000168975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:29:10 INFO - MultiFileLogger online at 20161004 09:29:10 in /builds/slave/test 09:29:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:29:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:29:10 INFO - {'append_to_log': False, 09:29:10 INFO - 'base_work_dir': '/builds/slave/test', 09:29:10 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:29:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:29:10 INFO - 'branch': 'Mozilla-Beta', 09:29:10 INFO - 'buildbot_json_path': 'buildprops.json', 09:29:10 INFO - 'config_files': ('talos/linux_config.py',), 09:29:10 INFO - 'default_actions': ('clobber', 09:29:10 INFO - 'read-buildbot-config', 09:29:10 INFO - 'download-and-extract', 09:29:10 INFO - 'populate-webroot', 09:29:10 INFO - 'create-virtualenv', 09:29:10 INFO - 'install', 09:29:10 INFO - 'run-tests'), 09:29:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:29:10 INFO - 'download_minidump_stackwalk': True, 09:29:10 INFO - 'download_symbols': 'ondemand', 09:29:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:29:10 INFO - 'tooltool.py': '/tools/tooltool.py', 09:29:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:29:10 INFO - '/tools/misc-python/virtualenv.py')}, 09:29:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:29:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:29:10 INFO - 'installer_path': 'installer.exe', 09:29:10 INFO - 'log_level': 'info', 09:29:10 INFO - 'log_name': 'talos', 09:29:10 INFO - 'log_to_console': True, 09:29:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:29:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:29:10 INFO - 'opt_config_files': (), 09:29:10 INFO - 'pip_index': False, 09:29:10 INFO - 'sps_profile': False, 09:29:10 INFO - 'sps_profile_interval': 0, 09:29:10 INFO - 'suite': 'dromaeojs-e10s', 09:29:10 INFO - 'system_bits': '32', 09:29:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:29:10 INFO - 'title': 'talos-linux64-ix-061', 09:29:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:29:10 INFO - 'use_talos_json': True, 09:29:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:29:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:29:10 INFO - 'work_dir': 'build'} 09:29:10 INFO - [mozharness: 2016-10-04 16:29:10.792817Z] Running clobber step. 09:29:10 INFO - Running pre-action listener: _resource_record_pre_action 09:29:10 INFO - Running main action method: clobber 09:29:10 INFO - rmtree: /builds/slave/test/build 09:29:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:29:11 INFO - Running post-action listener: _resource_record_post_action 09:29:11 INFO - [mozharness: 2016-10-04 16:29:11.779815Z] Finished clobber step (success) 09:29:11 INFO - [mozharness: 2016-10-04 16:29:11.779915Z] Running read-buildbot-config step. 09:29:11 INFO - Running pre-action listener: _resource_record_pre_action 09:29:11 INFO - Running main action method: read_buildbot_config 09:29:11 INFO - Using buildbot properties: 09:29:11 INFO - { 09:29:11 INFO - "project": "", 09:29:11 INFO - "product": "firefox", 09:29:11 INFO - "script_repo_revision": "production", 09:29:11 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 09:29:11 INFO - "repository": "", 09:29:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 09:29:11 INFO - "buildid": "20161004062601", 09:29:11 INFO - "pgo_build": "True", 09:29:11 INFO - "basedir": "/builds/slave/test", 09:29:11 INFO - "buildnumber": 272, 09:29:11 INFO - "slavename": "talos-linux64-ix-061", 09:29:11 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:29:11 INFO - "platform": "ubuntu64_hw", 09:29:11 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 09:29:11 INFO - "branch": "mozilla-beta", 09:29:11 INFO - "repo_path": "releases/mozilla-beta", 09:29:11 INFO - "revision": "bebbf04b7fe13ed3e43d729558505d2917691621", 09:29:11 INFO - "stage_platform": "linux64-pgo", 09:29:11 INFO - "builduid": "859544fdaa414e909dbaa42ee7ed5b4f", 09:29:11 INFO - "slavebuilddir": "test" 09:29:11 INFO - } 09:29:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 09:29:11 INFO - Running post-action listener: _resource_record_post_action 09:29:11 INFO - [mozharness: 2016-10-04 16:29:11.782372Z] Finished read-buildbot-config step (success) 09:29:11 INFO - [mozharness: 2016-10-04 16:29:11.782461Z] Running download-and-extract step. 09:29:11 INFO - Running pre-action listener: _resource_record_pre_action 09:29:11 INFO - Running main action method: download_and_extract 09:29:11 INFO - mkdir: /builds/slave/test/build/tests 09:29:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:11 INFO - https://queue.taskcluster.net/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:29:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 09:29:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 09:29:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 09:29:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:29:11 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 09:29:11 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 09:29:11 INFO - retry: Failed, sleeping 30 seconds before retrying 09:29:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #2 09:29:41 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 09:29:41 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 09:29:41 INFO - retry: Failed, sleeping 60 seconds before retrying 09:30:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #3 09:30:41 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 09:30:41 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 09:30:41 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json! 09:30:41 INFO - Caught exception: HTTP Error 404: Not Found 09:30:41 INFO - Caught exception: HTTP Error 404: Not Found 09:30:41 INFO - Caught exception: HTTP Error 404: Not Found 09:30:41 INFO - trying https://queue.taskcluster.net/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 09:30:41 INFO - Downloading https://queue.taskcluster.net/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 09:30:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:30:42 INFO - Downloaded 1327 bytes. 09:30:42 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 09:30:42 INFO - Using the following test package requirements: 09:30:42 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 09:30:42 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 09:30:42 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 09:30:42 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 09:30:42 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 09:30:42 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 09:30:42 INFO - u'jsshell-linux-x86_64.zip'], 09:30:42 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 09:30:42 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 09:30:42 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 09:30:42 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 09:30:42 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 09:30:42 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 09:30:42 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 09:30:42 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 09:30:42 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 09:30:42 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 09:30:42 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 09:30:42 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:30:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:42 INFO - https://queue.taskcluster.net/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:30:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 09:30:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 09:30:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 09:30:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:30:42 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 09:30:42 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 09:30:42 INFO - retry: Failed, sleeping 30 seconds before retrying 09:31:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 09:31:12 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 09:31:12 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 09:31:12 INFO - retry: Failed, sleeping 60 seconds before retrying 09:32:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 09:32:12 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 09:32:12 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 09:32:12 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip! 09:32:12 INFO - Caught exception: HTTP Error 404: Not Found 09:32:12 INFO - Caught exception: HTTP Error 404: Not Found 09:32:12 INFO - Caught exception: HTTP Error 404: Not Found 09:32:12 INFO - trying https://queue.taskcluster.net/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 09:32:12 INFO - Downloading https://queue.taskcluster.net/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 09:32:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:32:13 INFO - Downloaded 21841758 bytes. 09:32:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:32:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:32:14 INFO - Return code: 0 09:32:14 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:32:14 INFO - https://queue.taskcluster.net/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:32:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 09:32:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 09:32:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 09:32:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:32:14 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 09:32:14 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 09:32:14 INFO - retry: Failed, sleeping 30 seconds before retrying 09:32:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 09:32:44 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 09:32:44 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 09:32:44 INFO - retry: Failed, sleeping 60 seconds before retrying 09:33:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 09:33:44 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 09:33:44 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 09:33:44 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip! 09:33:44 INFO - Caught exception: HTTP Error 404: Not Found 09:33:44 INFO - Caught exception: HTTP Error 404: Not Found 09:33:44 INFO - Caught exception: HTTP Error 404: Not Found 09:33:44 INFO - trying https://queue.taskcluster.net/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 09:33:44 INFO - Downloading https://queue.taskcluster.net/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 09:33:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:33:45 INFO - Downloaded 21841758 bytes. 09:33:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:33:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:33:46 INFO - Return code: 0 09:33:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:46 INFO - https://queue.taskcluster.net/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:33:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 09:33:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 09:33:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 09:33:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:33:46 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 09:33:46 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 09:33:46 INFO - retry: Failed, sleeping 30 seconds before retrying 09:34:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 09:34:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 09:34:17 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 09:34:17 INFO - retry: Failed, sleeping 60 seconds before retrying 09:35:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 09:35:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 09:35:17 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 09:35:17 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip! 09:35:17 INFO - Caught exception: HTTP Error 404: Not Found 09:35:17 INFO - Caught exception: HTTP Error 404: Not Found 09:35:17 INFO - Caught exception: HTTP Error 404: Not Found 09:35:17 INFO - trying https://queue.taskcluster.net/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 09:35:17 INFO - Downloading https://queue.taskcluster.net/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 09:35:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:35:17 INFO - Downloaded 14413740 bytes. 09:35:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:35:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:35:18 INFO - Return code: 0 09:35: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')]} 09:35:18 INFO - https://queue.taskcluster.net/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:35:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 09:35:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 09:35:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 09:35:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:35:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 09:35:18 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 09:35:18 INFO - retry: Failed, sleeping 30 seconds before retrying 09:35:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #2 09:35:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 09:35:48 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 09:35:48 INFO - retry: Failed, sleeping 60 seconds before retrying 09:36:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #3 09:36:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 09:36:48 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 09:36:48 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2! 09:36:48 INFO - Caught exception: HTTP Error 404: Not Found 09:36:48 INFO - Caught exception: HTTP Error 404: Not Found 09:36:48 INFO - Caught exception: HTTP Error 404: Not Found 09:36:48 INFO - trying https://queue.taskcluster.net/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 09:36:48 INFO - Downloading https://queue.taskcluster.net/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 09:36:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:36:49 INFO - Downloaded 56774159 bytes. 09:36:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 09:36:49 INFO - mkdir: /builds/slave/test/properties 09:36:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:36:49 INFO - Writing to file /builds/slave/test/properties/build_url 09:36:49 INFO - Contents: 09:36:49 INFO - build_url:https://queue.taskcluster.net/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 09:36:50 INFO - Running post-action listener: _resource_record_post_action 09:36:50 INFO - Running post-action listener: set_extra_try_arguments 09:36:50 INFO - [mozharness: 2016-10-04 16:36:50.049399Z] Finished download-and-extract step (success) 09:36:50 INFO - [mozharness: 2016-10-04 16:36:50.049630Z] Running populate-webroot step. 09:36:50 INFO - Running pre-action listener: _resource_record_pre_action 09:36:50 INFO - Running main action method: populate_webroot 09:36:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:36:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:36:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:36:50 INFO - '--tppagecycles', 09:36:50 INFO - '7'], 09:36:50 INFO - 'tests': ['tsvgm']}}, 09:36:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:36:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:36:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:36:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:36:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:36:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:36:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:50 INFO - 'talos_options': ['--disable-e10s'], 09:36:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:36:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:36:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:50 INFO - 'talos_options': ['--disable-e10s'], 09:36:50 INFO - 'tests': ['damp', 'tps']}, 09:36:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:50 INFO - 'tests': ['damp', 'tps']}, 09:36:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:36:50 INFO - 'tests': ['dromaeo_dom']}, 09:36:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:36:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:36:50 INFO - 'tests': ['basic_compositor_video']}, 09:36:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:36:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:36:50 INFO - 'tests': ['a11yr', 09:36:50 INFO - 'ts_paint', 09:36:50 INFO - 'tpaint', 09:36:50 INFO - 'sessionrestore', 09:36:50 INFO - 'sessionrestore_no_auto_restore', 09:36:50 INFO - 'tabpaint']}, 09:36:50 INFO - 'other-e10s': {'tests': ['a11yr', 09:36:50 INFO - 'ts_paint', 09:36:50 INFO - 'tpaint', 09:36:50 INFO - 'sessionrestore', 09:36:50 INFO - 'sessionrestore_no_auto_restore', 09:36:50 INFO - 'tabpaint']}, 09:36:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:36:50 INFO - 'ts_paint', 09:36:50 INFO - 'tpaint', 09:36:50 INFO - 'sessionrestore', 09:36:50 INFO - 'sessionrestore_no_auto_restore', 09:36:50 INFO - 'tabpaint']}, 09:36:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:36:50 INFO - 'ts_paint', 09:36:50 INFO - 'tpaint', 09:36:50 INFO - 'sessionrestore', 09:36:50 INFO - 'sessionrestore_no_auto_restore', 09:36:50 INFO - 'tabpaint']}, 09:36:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:36:50 INFO - 'tests': ['a11yr', 09:36:50 INFO - 'ts_paint', 09:36:50 INFO - 'tpaint', 09:36:50 INFO - 'sessionrestore', 09:36:50 INFO - 'sessionrestore_no_auto_restore', 09:36:50 INFO - 'tabpaint']}, 09:36:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:36:50 INFO - 'tests': ['a11yr', 09:36:50 INFO - 'ts_paint', 09:36:50 INFO - 'tpaint', 09:36:50 INFO - 'sessionrestore', 09:36:50 INFO - 'sessionrestore_no_auto_restore', 09:36:50 INFO - 'tabpaint']}, 09:36:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:36:50 INFO - 'tests': ['tsvgx', 09:36:50 INFO - 'tsvgr_opacity', 09:36:50 INFO - 'tart', 09:36:50 INFO - 'tscrollx', 09:36:50 INFO - 'cart']}, 09:36:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:36:50 INFO - 'tsvgr_opacity', 09:36:50 INFO - 'tart', 09:36:50 INFO - 'tscrollx', 09:36:50 INFO - 'cart']}, 09:36:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:50 INFO - 'talos_options': ['--disable-e10s'], 09:36:50 INFO - 'tests': ['tp5o']}, 09:36:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:50 INFO - 'tests': ['tp5o']}, 09:36:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:50 INFO - 'talos_options': ['--disable-e10s', 09:36:50 INFO - '--xperf_path', 09:36:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:36:50 INFO - 'tests': ['tp5n']}, 09:36:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:50 INFO - 'talos_options': ['--xperf_path', 09:36:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:36:50 INFO - 'tests': ['tp5n']}}, 09:36:50 INFO - 'talos.zip': {'path': '', 09:36:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:36:50 INFO - Running post-action listener: _resource_record_post_action 09:36:50 INFO - [mozharness: 2016-10-04 16:36:50.066207Z] Finished populate-webroot step (success) 09:36:50 INFO - [mozharness: 2016-10-04 16:36:50.066296Z] Running create-virtualenv step. 09:36:50 INFO - Running pre-action listener: _resource_record_pre_action 09:36:50 INFO - Running main action method: create_virtualenv 09:36:50 INFO - Creating virtualenv /builds/slave/test/build/venv 09:36:50 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 09:36:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:36:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:36:50 INFO - Using real prefix '/usr' 09:36:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:36:50 INFO - Installing distribute.............................................................................................................................................................................................done. 09:36:52 INFO - Installing pip.................done. 09:36:52 INFO - Return code: 0 09:36:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:36:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:52 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 0x1904030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b33400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc2570>, '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 0x1bc3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1475598549.110116-1000168975', '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 09:36:52 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 09:36:52 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 09:36:52 INFO - Using env: {'DISPLAY': ':0', 09:36:52 INFO - 'HOME': '/home/cltbld', 09:36:52 INFO - 'LANG': 'en_US.UTF-8', 09:36:52 INFO - 'LANGUAGE': 'en_US:en', 09:36:52 INFO - 'LOGNAME': 'cltbld', 09:36:52 INFO - 'MAIL': '/var/mail/cltbld', 09:36:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:52 INFO - 'MOZ_NO_REMOTE': '1', 09:36:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:52 INFO - 'NO_EM_RESTART': '1', 09:36:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:52 INFO - 'PWD': '/builds/slave/test', 09:36:52 INFO - 'SHELL': '/bin/bash', 09:36:52 INFO - 'SHLVL': '1', 09:36:52 INFO - 'TERM': 'linux', 09:36:52 INFO - 'TMOUT': '86400', 09:36:52 INFO - 'USER': 'cltbld', 09:36:52 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1475598549.110116-1000168975', 09:36:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:52 INFO - '_': '/tools/buildbot/bin/python'} 09:36:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:52 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 09:36:52 INFO - Cleaning up... 09:36:52 INFO - Return code: 0 09:36:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:36:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:52 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 0x1904030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b33400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc2570>, '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 0x1bc3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1475598549.110116-1000168975', '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 09:36:52 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 09:36:52 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 09:36:52 INFO - Using env: {'DISPLAY': ':0', 09:36:52 INFO - 'HOME': '/home/cltbld', 09:36:52 INFO - 'LANG': 'en_US.UTF-8', 09:36:52 INFO - 'LANGUAGE': 'en_US:en', 09:36:52 INFO - 'LOGNAME': 'cltbld', 09:36:52 INFO - 'MAIL': '/var/mail/cltbld', 09:36:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:52 INFO - 'MOZ_NO_REMOTE': '1', 09:36:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:52 INFO - 'NO_EM_RESTART': '1', 09:36:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:52 INFO - 'PWD': '/builds/slave/test', 09:36:52 INFO - 'SHELL': '/bin/bash', 09:36:52 INFO - 'SHLVL': '1', 09:36:52 INFO - 'TERM': 'linux', 09:36:52 INFO - 'TMOUT': '86400', 09:36:52 INFO - 'USER': 'cltbld', 09:36:52 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1475598549.110116-1000168975', 09:36:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:52 INFO - '_': '/tools/buildbot/bin/python'} 09:36:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:53 INFO - Downloading/unpacking psutil>=3.1.1 09:36:53 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 09:36:53 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 09:36:53 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 09:36:53 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 09:36:53 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 09:36:53 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 09:36:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:36:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:36:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:36:55 INFO - Installing collected packages: psutil 09:36:55 INFO - Running setup.py install for psutil 09:36:55 INFO - building 'psutil._psutil_linux' extension 09:36:55 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 09:36:55 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 09:36:55 INFO - building 'psutil._psutil_posix' extension 09:36:55 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 09:36:55 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 09:36:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:36:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:36:55 INFO - Successfully installed psutil 09:36:55 INFO - Cleaning up... 09:36:55 INFO - Return code: 0 09:36:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:36:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:55 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 0x1904030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b33400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc2570>, '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 0x1bc3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1475598549.110116-1000168975', '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 09:36:55 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 09:36:55 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 09:36:55 INFO - Using env: {'DISPLAY': ':0', 09:36:55 INFO - 'HOME': '/home/cltbld', 09:36:55 INFO - 'LANG': 'en_US.UTF-8', 09:36:55 INFO - 'LANGUAGE': 'en_US:en', 09:36:55 INFO - 'LOGNAME': 'cltbld', 09:36:55 INFO - 'MAIL': '/var/mail/cltbld', 09:36:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:55 INFO - 'MOZ_NO_REMOTE': '1', 09:36:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:55 INFO - 'NO_EM_RESTART': '1', 09:36:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:55 INFO - 'PWD': '/builds/slave/test', 09:36:55 INFO - 'SHELL': '/bin/bash', 09:36:55 INFO - 'SHLVL': '1', 09:36:55 INFO - 'TERM': 'linux', 09:36:55 INFO - 'TMOUT': '86400', 09:36:55 INFO - 'USER': 'cltbld', 09:36:55 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1475598549.110116-1000168975', 09:36:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:55 INFO - '_': '/tools/buildbot/bin/python'} 09:36:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:36:55 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 09:36:55 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 09:36:55 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 09:36:55 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 09:36:55 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 09:36:55 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 09:36:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:36:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:36:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:36:57 INFO - Installing collected packages: mozsystemmonitor 09:36:57 INFO - Running setup.py install for mozsystemmonitor 09:36:57 INFO - Successfully installed mozsystemmonitor 09:36:57 INFO - Cleaning up... 09:36:57 INFO - Return code: 0 09:36:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:36:57 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')]} 09:36:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:57 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')]} 09:36:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:57 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 0x1904030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b33400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc2570>, '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 0x1bc3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1475598549.110116-1000168975', '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 09:36:57 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 09:36:57 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 09:36:57 INFO - Using env: {'DISPLAY': ':0', 09:36:57 INFO - 'HOME': '/home/cltbld', 09:36:57 INFO - 'LANG': 'en_US.UTF-8', 09:36:57 INFO - 'LANGUAGE': 'en_US:en', 09:36:57 INFO - 'LOGNAME': 'cltbld', 09:36:57 INFO - 'MAIL': '/var/mail/cltbld', 09:36:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:57 INFO - 'MOZ_NO_REMOTE': '1', 09:36:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:57 INFO - 'NO_EM_RESTART': '1', 09:36:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:57 INFO - 'PWD': '/builds/slave/test', 09:36:57 INFO - 'SHELL': '/bin/bash', 09:36:57 INFO - 'SHLVL': '1', 09:36:57 INFO - 'TERM': 'linux', 09:36:57 INFO - 'TMOUT': '86400', 09:36:57 INFO - 'USER': 'cltbld', 09:36:57 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1475598549.110116-1000168975', 09:36:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:57 INFO - '_': '/tools/buildbot/bin/python'} 09:36:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:58 INFO - Downloading/unpacking jsonschema==2.5.1 09:36:58 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 09:36:58 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 09:36:58 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 09:36:58 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 09:36:58 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 09:36:58 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 09:37:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:37:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:37:00 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 09:37:00 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 09:37:00 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 09:37:00 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 09:37:00 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 09:37:00 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 09:37:00 INFO - Downloading functools32-3.2.3-2.tar.gz 09:37:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:37:00 INFO - warning: no files found matching '*.txt' 09:37:00 INFO - no previously-included directories found matching 'build' 09:37:00 INFO - no previously-included directories found matching 'dist' 09:37:00 INFO - no previously-included directories found matching '.git*' 09:37:00 INFO - Installing collected packages: jsonschema, functools32 09:37:00 INFO - Running setup.py install for functools32 09:37:00 INFO - warning: no files found matching '*.txt' 09:37:00 INFO - no previously-included directories found matching 'build' 09:37:00 INFO - no previously-included directories found matching 'dist' 09:37:00 INFO - no previously-included directories found matching '.git*' 09:37:00 INFO - Successfully installed jsonschema functools32 09:37:00 INFO - Cleaning up... 09:37:00 INFO - Return code: 0 09:37:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:37:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:00 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 0x1904030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b33400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc2570>, '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 0x1bc3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1475598549.110116-1000168975', '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 09:37:00 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 09:37:00 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 09:37:00 INFO - Using env: {'DISPLAY': ':0', 09:37:00 INFO - 'HOME': '/home/cltbld', 09:37:00 INFO - 'LANG': 'en_US.UTF-8', 09:37:00 INFO - 'LANGUAGE': 'en_US:en', 09:37:00 INFO - 'LOGNAME': 'cltbld', 09:37:00 INFO - 'MAIL': '/var/mail/cltbld', 09:37:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:00 INFO - 'MOZ_NO_REMOTE': '1', 09:37:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:00 INFO - 'NO_EM_RESTART': '1', 09:37:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:00 INFO - 'PWD': '/builds/slave/test', 09:37:00 INFO - 'SHELL': '/bin/bash', 09:37:00 INFO - 'SHLVL': '1', 09:37:00 INFO - 'TERM': 'linux', 09:37:00 INFO - 'TMOUT': '86400', 09:37:00 INFO - 'USER': 'cltbld', 09:37:00 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1475598549.110116-1000168975', 09:37:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:00 INFO - '_': '/tools/buildbot/bin/python'} 09:37:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:37:00 INFO - Cleaning up... 09:37:00 INFO - Return code: 0 09:37:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:37:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:00 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 0x1904030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b33400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc2570>, '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 0x1bc3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1475598549.110116-1000168975', '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 09:37:00 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 09:37:00 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 09:37:00 INFO - Using env: {'DISPLAY': ':0', 09:37:00 INFO - 'HOME': '/home/cltbld', 09:37:00 INFO - 'LANG': 'en_US.UTF-8', 09:37:00 INFO - 'LANGUAGE': 'en_US:en', 09:37:00 INFO - 'LOGNAME': 'cltbld', 09:37:00 INFO - 'MAIL': '/var/mail/cltbld', 09:37:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:00 INFO - 'MOZ_NO_REMOTE': '1', 09:37:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:00 INFO - 'NO_EM_RESTART': '1', 09:37:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:00 INFO - 'PWD': '/builds/slave/test', 09:37:00 INFO - 'SHELL': '/bin/bash', 09:37:00 INFO - 'SHLVL': '1', 09:37:00 INFO - 'TERM': 'linux', 09:37:00 INFO - 'TMOUT': '86400', 09:37:00 INFO - 'USER': 'cltbld', 09:37:00 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1475598549.110116-1000168975', 09:37:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:00 INFO - '_': '/tools/buildbot/bin/python'} 09:37:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:00 INFO - Downloading/unpacking blobuploader==1.2.4 09:37:00 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 09:37:00 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 09:37:00 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 09:37:00 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 09:37:00 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 09:37:00 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 09:37:02 INFO - Downloading blobuploader-1.2.4.tar.gz 09:37:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:37:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:37:02 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 09:37:02 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 09:37:02 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 09:37:02 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 09:37:02 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 09:37:02 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 09:37:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:37:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:37:03 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 09:37:03 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 09:37:03 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 09:37:03 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 09:37:03 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 09:37:03 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 09:37:03 INFO - Downloading docopt-0.6.1.tar.gz 09:37:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:37:03 INFO - Installing collected packages: blobuploader, requests, docopt 09:37:03 INFO - Running setup.py install for blobuploader 09:37:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:37:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:37:03 INFO - Running setup.py install for requests 09:37:04 INFO - Running setup.py install for docopt 09:37:04 INFO - Successfully installed blobuploader requests docopt 09:37:04 INFO - Cleaning up... 09:37:04 INFO - Return code: 0 09:37:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:37:04 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')]} 09:37:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:04 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')]} 09:37:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:04 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 0x1904030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b33400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc2570>, '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 0x1bc3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1475598549.110116-1000168975', '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 09:37:04 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 09:37:04 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 09:37:04 INFO - Using env: {'DISPLAY': ':0', 09:37:04 INFO - 'HOME': '/home/cltbld', 09:37:04 INFO - 'LANG': 'en_US.UTF-8', 09:37:04 INFO - 'LANGUAGE': 'en_US:en', 09:37:04 INFO - 'LOGNAME': 'cltbld', 09:37:04 INFO - 'MAIL': '/var/mail/cltbld', 09:37:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:04 INFO - 'MOZ_NO_REMOTE': '1', 09:37:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:04 INFO - 'NO_EM_RESTART': '1', 09:37:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:04 INFO - 'PWD': '/builds/slave/test', 09:37:04 INFO - 'SHELL': '/bin/bash', 09:37:04 INFO - 'SHLVL': '1', 09:37:04 INFO - 'TERM': 'linux', 09:37:04 INFO - 'TMOUT': '86400', 09:37:04 INFO - 'USER': 'cltbld', 09:37:04 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1475598549.110116-1000168975', 09:37:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:04 INFO - '_': '/tools/buildbot/bin/python'} 09:37:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:37:04 INFO - Running setup.py (path:/tmp/pip-1YK2CU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:37:04 INFO - Running setup.py (path:/tmp/pip-EC8Bz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:37:04 INFO - Running setup.py (path:/tmp/pip-k6q02_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:37:04 INFO - Running setup.py (path:/tmp/pip-ABBVqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:37:04 INFO - Running setup.py (path:/tmp/pip-AurOIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:37:04 INFO - Running setup.py (path:/tmp/pip-QkbOAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:37:04 INFO - Running setup.py (path:/tmp/pip-qh4IqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:37:04 INFO - Running setup.py (path:/tmp/pip-Zv4jX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:37:05 INFO - Running setup.py (path:/tmp/pip-9QMaYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:37:05 INFO - Running setup.py (path:/tmp/pip-E1StXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:37:05 INFO - Running setup.py (path:/tmp/pip-gHcJL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:37:05 INFO - Running setup.py (path:/tmp/pip-UA_hvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:37:05 INFO - Running setup.py (path:/tmp/pip-KvS5jB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:37:05 INFO - Running setup.py (path:/tmp/pip-70G4Nl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:37:05 INFO - Running setup.py (path:/tmp/pip-agqUN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:37:05 INFO - Running setup.py (path:/tmp/pip-CADFDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:37:05 INFO - Running setup.py (path:/tmp/pip-tuwbob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:37:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:37:05 INFO - Running setup.py install for manifestparser 09:37:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:37:05 INFO - Running setup.py install for mozcrash 09:37:05 INFO - Running setup.py install for mozdebug 09:37:05 INFO - Running setup.py install for mozdevice 09:37:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:37:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:37:06 INFO - Running setup.py install for mozfile 09:37:06 INFO - Running setup.py install for mozhttpd 09:37:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:37:06 INFO - Running setup.py install for mozinfo 09:37:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:37:06 INFO - Running setup.py install for mozInstall 09:37:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:37:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:37:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:37:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:37:06 INFO - Running setup.py install for mozleak 09:37:06 INFO - Running setup.py install for mozlog 09:37:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:37:06 INFO - Running setup.py install for moznetwork 09:37:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:37:06 INFO - Running setup.py install for mozprocess 09:37:06 INFO - Running setup.py install for mozprofile 09:37:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:37:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:37:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:37:06 INFO - Running setup.py install for mozrunner 09:37:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:37:07 INFO - Running setup.py install for mozscreenshot 09:37:07 INFO - Running setup.py install for moztest 09:37:07 INFO - Running setup.py install for mozversion 09:37:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:37:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:37:07 INFO - Cleaning up... 09:37:07 INFO - Return code: 0 09:37:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:37: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')]} 09:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37: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')]} 09:37:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:07 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 0x1904030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b33400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc2570>, '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 0x1bc3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1475598549.110116-1000168975', '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 09:37:07 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 09:37:07 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 09:37:07 INFO - Using env: {'DISPLAY': ':0', 09:37:07 INFO - 'HOME': '/home/cltbld', 09:37:07 INFO - 'LANG': 'en_US.UTF-8', 09:37:07 INFO - 'LANGUAGE': 'en_US:en', 09:37:07 INFO - 'LOGNAME': 'cltbld', 09:37:07 INFO - 'MAIL': '/var/mail/cltbld', 09:37:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:07 INFO - 'MOZ_NO_REMOTE': '1', 09:37:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:07 INFO - 'NO_EM_RESTART': '1', 09:37:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:07 INFO - 'PWD': '/builds/slave/test', 09:37:07 INFO - 'SHELL': '/bin/bash', 09:37:07 INFO - 'SHLVL': '1', 09:37:07 INFO - 'TERM': 'linux', 09:37:07 INFO - 'TMOUT': '86400', 09:37:07 INFO - 'USER': 'cltbld', 09:37:07 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1475598549.110116-1000168975', 09:37:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:07 INFO - '_': '/tools/buildbot/bin/python'} 09:37:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:37:07 INFO - Running setup.py (path:/tmp/pip-0oafya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:37:07 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)) 09:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:37:07 INFO - Running setup.py (path:/tmp/pip-BCEPki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:37:07 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)) 09:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:37:07 INFO - Running setup.py (path:/tmp/pip-66w6k2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:37:07 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)) 09:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:37:07 INFO - Running setup.py (path:/tmp/pip-hnk0Nk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:37:07 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)) 09:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:37:07 INFO - Running setup.py (path:/tmp/pip-wqqlVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:37:08 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)) 09:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:37:08 INFO - Running setup.py (path:/tmp/pip-8goBd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:37:08 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)) 09:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:37:08 INFO - Running setup.py (path:/tmp/pip-BJh1Xy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:37:08 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)) 09:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:37:08 INFO - Running setup.py (path:/tmp/pip-FST0DD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:37:08 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)) 09:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:37:08 INFO - Running setup.py (path:/tmp/pip-bQa16X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:37:08 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)) 09:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:37:08 INFO - Running setup.py (path:/tmp/pip-2FTZKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:37:08 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)) 09:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:37:08 INFO - Running setup.py (path:/tmp/pip-bMmuUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:37:08 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)) 09:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:37:08 INFO - Running setup.py (path:/tmp/pip-rnt4gA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:37:08 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)) 09:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:37:08 INFO - Running setup.py (path:/tmp/pip-3mFu4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:37:08 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)) 09:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:37:08 INFO - Running setup.py (path:/tmp/pip-EOAdIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:37:08 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)) 09:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:37:08 INFO - Running setup.py (path:/tmp/pip-p0LuNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:37:08 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)) 09:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:37:08 INFO - Running setup.py (path:/tmp/pip-6tnPjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:37:08 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)) 09:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:37:08 INFO - Running setup.py (path:/tmp/pip-Jk69Mf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:37:08 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)) 09:37:08 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)) 09:37:08 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)) 09:37:08 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)) 09:37:08 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)) 09:37:08 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)) 09:37:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:37:08 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 09:37:08 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 09:37:08 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 09:37:08 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 09:37:08 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 09:37:08 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 09:37:10 INFO - Downloading blessings-1.6.tar.gz 09:37:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:37:10 INFO - Installing collected packages: blessings 09:37:10 INFO - Running setup.py install for blessings 09:37:10 INFO - Successfully installed blessings 09:37:10 INFO - Cleaning up... 09:37:11 INFO - Return code: 0 09:37:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:37:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:37:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:37:11 INFO - Reading from file tmpfile_stdout 09:37:11 INFO - Current package versions: 09:37:11 INFO - argparse == 1.2.1 09:37:11 INFO - blessings == 1.6 09:37:11 INFO - blobuploader == 1.2.4 09:37:11 INFO - docopt == 0.6.1 09:37:11 INFO - functools32 == 3.2.3-2 09:37:11 INFO - jsonschema == 2.5.1 09:37:11 INFO - manifestparser == 1.1 09:37:11 INFO - mozInstall == 1.12 09:37:11 INFO - mozcrash == 0.17 09:37:11 INFO - mozdebug == 0.1 09:37:11 INFO - mozdevice == 0.48 09:37:11 INFO - mozfile == 1.2 09:37:11 INFO - mozhttpd == 0.7 09:37:11 INFO - mozinfo == 0.9 09:37:11 INFO - mozleak == 0.1 09:37:11 INFO - mozlog == 3.3 09:37:11 INFO - moznetwork == 0.27 09:37:11 INFO - mozprocess == 0.23 09:37:11 INFO - mozprofile == 0.28 09:37:11 INFO - mozrunner == 6.12 09:37:11 INFO - mozscreenshot == 0.1 09:37:11 INFO - mozsystemmonitor == 0.3 09:37:11 INFO - moztest == 0.7 09:37:11 INFO - mozversion == 1.4 09:37:11 INFO - psutil == 3.1.1 09:37:11 INFO - requests == 1.2.3 09:37:11 INFO - wsgiref == 0.1.2 09:37:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:37:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:11 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 0x1904030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b33400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc2570>, '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 0x1bc3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1475598549.110116-1000168975', '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 09:37:11 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 09:37:11 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 09:37:11 INFO - Using env: {'DISPLAY': ':0', 09:37:11 INFO - 'HOME': '/home/cltbld', 09:37:11 INFO - 'LANG': 'en_US.UTF-8', 09:37:11 INFO - 'LANGUAGE': 'en_US:en', 09:37:11 INFO - 'LOGNAME': 'cltbld', 09:37:11 INFO - 'MAIL': '/var/mail/cltbld', 09:37:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:11 INFO - 'MOZ_NO_REMOTE': '1', 09:37:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:11 INFO - 'NO_EM_RESTART': '1', 09:37:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:11 INFO - 'PWD': '/builds/slave/test', 09:37:11 INFO - 'SHELL': '/bin/bash', 09:37:11 INFO - 'SHLVL': '1', 09:37:11 INFO - 'TERM': 'linux', 09:37:11 INFO - 'TMOUT': '86400', 09:37:11 INFO - 'USER': 'cltbld', 09:37:11 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1475598549.110116-1000168975', 09:37:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:11 INFO - '_': '/tools/buildbot/bin/python'} 09:37:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:11 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)) 09:37:11 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)) 09:37:11 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)) 09:37:11 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)) 09:37:11 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)) 09:37:11 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)) 09:37:11 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)) 09:37:11 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)) 09:37:11 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)) 09:37:11 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)) 09:37:11 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)) 09:37:11 INFO - Cleaning up... 09:37:11 INFO - Return code: 0 09:37:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:37:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1904030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b33400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc2570>, '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 0x1bc3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1475598549.110116-1000168975', '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 09:37:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:37:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:37:11 INFO - Using env: {'DISPLAY': ':0', 09:37:11 INFO - 'HOME': '/home/cltbld', 09:37:11 INFO - 'LANG': 'en_US.UTF-8', 09:37:11 INFO - 'LANGUAGE': 'en_US:en', 09:37:11 INFO - 'LOGNAME': 'cltbld', 09:37:11 INFO - 'MAIL': '/var/mail/cltbld', 09:37:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:11 INFO - 'MOZ_NO_REMOTE': '1', 09:37:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:11 INFO - 'NO_EM_RESTART': '1', 09:37:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:11 INFO - 'PWD': '/builds/slave/test', 09:37:11 INFO - 'SHELL': '/bin/bash', 09:37:11 INFO - 'SHLVL': '1', 09:37:11 INFO - 'TERM': 'linux', 09:37:11 INFO - 'TMOUT': '86400', 09:37:11 INFO - 'USER': 'cltbld', 09:37:11 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1475598549.110116-1000168975', 09:37:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:11 INFO - '_': '/tools/buildbot/bin/python'} 09:37:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:37:11 INFO - Cleaning up... 09:37:11 INFO - Return code: 0 09:37:11 INFO - Running post-action listener: _resource_record_post_action 09:37:11 INFO - Running post-action listener: _start_resource_monitoring 09:37:11 INFO - Starting resource monitoring. 09:37:11 INFO - [mozharness: 2016-10-04 16:37:11.742085Z] Finished create-virtualenv step (success) 09:37:11 INFO - [mozharness: 2016-10-04 16:37:11.742643Z] Running install step. 09:37:11 INFO - Running pre-action listener: _resource_record_pre_action 09:37:11 INFO - Running main action method: install 09:37:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:37:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:37:11 INFO - Reading from file tmpfile_stdout 09:37:11 INFO - Detecting whether we're running mozinstall >=1.0... 09:37:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:37:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:37:12 INFO - Reading from file tmpfile_stdout 09:37:12 INFO - Output received: 09:37:12 INFO - Usage: mozinstall [options] installer 09:37:12 INFO - Options: 09:37:12 INFO - -h, --help show this help message and exit 09:37:12 INFO - -d DEST, --destination=DEST 09:37:12 INFO - Directory to install application into. [default: 09:37:12 INFO - "/builds/slave/test"] 09:37:12 INFO - --app=APP Application being installed. [default: firefox] 09:37:12 INFO - mkdir: /builds/slave/test/build/application 09:37:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:37:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:37:25 INFO - Reading from file tmpfile_stdout 09:37:25 INFO - Output received: 09:37:25 INFO - /builds/slave/test/build/application/firefox/firefox 09:37:25 INFO - Running post-action listener: _resource_record_post_action 09:37:25 INFO - [mozharness: 2016-10-04 16:37:25.525843Z] Finished install step (success) 09:37:25 INFO - [mozharness: 2016-10-04 16:37:25.526120Z] Running run-tests step. 09:37:25 INFO - Running pre-action listener: _resource_record_pre_action 09:37:25 INFO - Running main action method: run_tests 09:37:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:37:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:37:25 INFO - Python 2.7.3 09:37:25 INFO - Return code: 0 09:37:25 INFO - grabbing minidump binary from tooltool 09:37: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')]} 09:37:25 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 0x1bc2570>, '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 0x1bc3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:37:25 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 09:37:25 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 09:37:25 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 09:37:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:37:25 INFO - Return code: 0 09:37:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:37:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:37:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:37:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:37:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:37:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 09:37:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 09:37:25 INFO - Using env: {'DISPLAY': ':0', 09:37:25 INFO - 'HOME': '/home/cltbld', 09:37:25 INFO - 'LANG': 'en_US.UTF-8', 09:37:25 INFO - 'LANGUAGE': 'en_US:en', 09:37:25 INFO - 'LOGNAME': 'cltbld', 09:37:25 INFO - 'MAIL': '/var/mail/cltbld', 09:37:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:37:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:37:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:25 INFO - 'MOZ_NO_REMOTE': '1', 09:37:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:37:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:25 INFO - 'NO_EM_RESTART': '1', 09:37:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:25 INFO - 'PWD': '/builds/slave/test', 09:37:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:37:25 INFO - 'SHELL': '/bin/bash', 09:37:25 INFO - 'SHLVL': '1', 09:37:25 INFO - 'TERM': 'linux', 09:37:25 INFO - 'TMOUT': '86400', 09:37:25 INFO - 'USER': 'cltbld', 09:37:25 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1475598549.110116-1000168975', 09:37:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:25 INFO - '_': '/tools/buildbot/bin/python'} 09:37:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 09:37:25 INFO - mozversion application_buildid: 20161004062601 09:37:25 INFO - mozversion application_changeset: bebbf04b7fe13ed3e43d729558505d2917691621 09:37:25 INFO - mozversion application_display_name: Firefox 09:37:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:37:25 INFO - mozversion application_name: Firefox 09:37:25 INFO - mozversion application_remotingname: firefox 09:37:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:37:25 INFO - mozversion application_vendor: Mozilla 09:37:25 INFO - mozversion application_version: 50.0 09:37:25 INFO - mozversion platform_buildid: 20161004062601 09:37:25 INFO - mozversion platform_changeset: bebbf04b7fe13ed3e43d729558505d2917691621 09:37:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:37:25 INFO - mozversion platform_version: 50.0 09:37:25 INFO - using testdate: 1475599045 09:37:25 INFO - actual date: 1475599045 09:37:25 INFO - starting webserver on 'localhost:44557' 09:37:25 INFO - SUITE-START | Running 2 tests 09:37:25 INFO - TEST-START | dromaeo_css 09:37:25 INFO - operating with platform_type : linux_ 09:37:25 INFO - Initialising browser for dromaeo_css test... 09:37:25 INFO - TEST-INFO | started process 23575 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgl24GS/profile http://localhost:44557/getInfo.html) 09:37:30 INFO - PROCESS | 23575 | __metrics Screen width/height:1600/1200 09:37:30 INFO - PROCESS | 23575 | colorDepth:24 09:37:30 INFO - PROCESS | 23575 | Browser inner width/height: 1024/697 09:37:30 INFO - PROCESS | 23575 | __metrics 09:37:31 ERROR - PROCESS | 23575 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 09:37:32 INFO - TEST-INFO | 23575: exit 0 09:37:32 INFO - Browser initialized. 09:37:32 INFO - Running cycle 1/1 for dromaeo_css test... 09:37:32 INFO - TEST-INFO | started process 23703 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgl24GS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:37:43 INFO - PROCESS | 23703 | RSS: Main: 150007808 09:37:43 INFO - PROCESS | 23703 | 09:38:33 INFO - PROCESS | 23703 | 1475599113500 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] 09:40:42 INFO - PROCESS | 23703 | Cycle 1(1): loaded http://localhost:44557/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44557/tests/dromaeo/cssquery-ext.html) 09:40:43 INFO - PROCESS | 23703 | RSS: Main: 157483008 09:40:43 INFO - PROCESS | 23703 | 09:43:45 INFO - PROCESS | 23703 | Cycle 1(1): loaded http://localhost:44557/tests/dromaeo/cssquery-ext.html (next: http://localhost:44557/tests/dromaeo/cssquery-jquery.html) 09:43:45 INFO - PROCESS | 23703 | RSS: Main: 155279360 09:43:45 INFO - PROCESS | 23703 | 09:46:47 INFO - PROCESS | 23703 | Cycle 1(1): loaded http://localhost:44557/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44557/tests/dromaeo/cssquery-mootools.html) 09:46:48 INFO - PROCESS | 23703 | RSS: Main: 154324992 09:46:48 INFO - PROCESS | 23703 | 09:49:49 INFO - PROCESS | 23703 | Cycle 1(1): loaded http://localhost:44557/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44557/tests/dromaeo/cssquery-prototype.html) 09:49:50 INFO - PROCESS | 23703 | RSS: Main: 155996160 09:49:50 INFO - PROCESS | 23703 | 09:52:52 INFO - PROCESS | 23703 | Cycle 1(1): loaded http://localhost:44557/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44557/tests/dromaeo/cssquery-yui.html) 09:52:53 INFO - PROCESS | 23703 | RSS: Main: 156790784 09:52:53 INFO - PROCESS | 23703 | 09:55:55 INFO - PROCESS | 23703 | Cycle 1(1): loaded http://localhost:44557/tests/dromaeo/cssquery-yui.html (next: http://localhost:44557/tests/dromaeo/cssquery-dojo.html) 09:55:56 INFO - PROCESS | 23703 | RSS: Main: 156844032 09:55:56 INFO - PROCESS | 23703 | 09:55:56 INFO - PROCESS | 23703 | __start_tp_report 09:55:56 INFO - PROCESS | 23703 | _x_x_mozilla_page_load 09:55:56 INFO - PROCESS | 23703 | _x_x_mozilla_page_load_details 09:55:56 INFO - PROCESS | 23703 | |i|pagename|runs| 09:55:56 INFO - PROCESS | 23703 | |0;dojo.html;3280.770346075775;3294.752893532984;3307.1897385140646;3323.5014747787814;3332.4168270552645;5777.971110144449;5853.414658534144;5853.941460585404;5864.589478736485;5865.413458654132;5742.741576629051;5821.446962538563;5826.417358264182;5849.678267695275;5858.912116318259;5280.973595132029;5325.147976323789;5356.169793681966;5381.784728610871;5385.761274906754;5389.083855744513;5389.487998640123;5390.21841832934;5392.595555333346;5403.621746477748;5130.871728206806;5145.845624631267;5382.407935127133;5390.19147127932;5400.648957817749;5198.376194856603;5239.345081864767;5270.525652691276;5320.228566857784;5399.325084364455;5234.398044224925;5338.27933229013;5338.572914166896;5339.385970613391;5348.277982472356;5747.3677895431465;5775.624584402;5788.942110578924;5831.2127862738835;5862.472377486004;5962.970185149046;6002.909956350658;6045.486133678643;6086.482648974842;6107.175531303262;6131.325554189036;6134.5399095067605;6141;6144.96927515364;6150.2927163376335;5665.178549110356;5701.600887937888;5709.343425506078;5714.028615135396;5716.971415142939;6105.725242364104;6229.314775374705;6247.437730604177;6261.342559031327;6371.904421433682;6054.424829641177;6086.969565152146;6092.786752463731;6121.246617337161;6129.295131059986;6160.845978850564;6196.194494715658;6219.720112594944;6226.40849119342;6235.345288744707;6007.759689612454;6089.786857459968;6133.57950150939;6143.447089761943;6233.532485063638;6220.782272620437;6282.057691346335;6289.496840252768;6290.370962903673;6292.559520833498;4650.511696271843;4666.719996800203;4672.112298663243;4689.038747056845;4706.694064885772;4112.342025276002;4149.668026557929;4151.107511884959;4209.642180414699;4257.787110644455;5880.206172166788;5994.550408719277;5998.940010599926;6016.368281330485;6017.488513476316;6256.624602523863;6257.68711564429;6263.530235232376;6283.7800676976085;6290.402411770874;5794.1308803679785;5922.644641321534;6015.969920150371;6029.939700602938;6095.359987201368;5398.91901621476;5414.891702166014;5421.457854214547;5439.564834813205;5446.046941785172;6212.782552610637;6462;6488;6521.413072823469;6529.249136349285;6149.938500614937;6171.352008039091;6191.19514463117;6299.496040316672;6300.9684951574945;6448.484121270381;6471.676416179266;6477.963525835844;6497.220333560003;6532.41208291256;5925.762969481345;6165.876682466236;6170.81487555374;6172.567920245539;6177.660228687286;6127.036821038878;6132.601380910227;6155.692215389123;6266.717997690023;6270.7805226816845;6053.334133245427;6098.115773212948;6099.451049405575;6104.938950610437;6126.417990290915;5934.495567876779;6051.818445446644;6082.574219804748;6094.664793436404;6123.14276001369;5963.73163207648;6021.036634138517;6025.849353766191;6083.543734219863;6132.294786099477;6047;6112.938870611415;6119.816405507842;6145.262568491809;6151.477124444473;5756.395578464369;5958.880822383441;5966.403359663999;5968.194293770285;6003.039513677965 09:55:56 INFO - PROCESS | 23703 | |1;ext.html;583.3699604427219;597.5488506177835;634.1850721822459;668.8428219368448;702.2380716922139;41593.79203103984;47002.059958800804;47156.52843471564;47165.52834471663;47193.76403117984;47733.284000740015;47991.28013079806;48294.75852620732;48335.758321208436;48340.75829620847;9139.817203655939;9222;9225.077492250788;9248.722538323827;9248.815023699522;9180.495072771027;9252.167304942554;9270.814583708321;9277.95361023194;9285.675001374953;9293.72118836436;9314.347995640273;9362.531873406337;9366.672166474174;9382;9248.861267080965;9277.211437027861;9297.070292970717;9298.349115561914;9299.163075323186;9220.953895230548;9295.395799273025;9297.209737172348;9300.953495232548;9323.06769323069;44581.33128003083;44856.775716121534;45162.54837451616;45230.77384613089;45456.09087818225;4085.8774236772942;4196.202721482909;4200.243956087903;4261.659067274611;4452.777361131931;35609.28781424357;36023.27953440943;36201;36335.63664363349;37738.81130594357;4452.866414007585;4519.683622146451;4523.117991991563;4560.22476179047;4560.315952607102;402639;404316.99999999703;404850;406757;407989;67362;67732.32267677359;67828.6608566954;67894.32105678979;67948;41135.38296925549;41555.58444415578;41764.791176044535;43822.34266486005;44204.77897610491;20450;20670.689939650918;20670.689939650918;20696.896515517627;20706.171753129707;15608.453704120302;15733.370665173494;15749.13379764101;15801;15829.129397883227;21718.891405542872;21724.131034758433;21838.23566175176;21974.45063873384;22042.559148816934;7533.660985255677;7555.433342499335;7746.535207887545;7764.417668674872;7782.416318776114;1020.5764607687875;1070.4059247117925;1079.6760971708457;1094.1301665176204;1121.1087185687397;34608.65391346105;34716;34971.65028349735;35090.298194035975;35573.644263557035;1184.1947475716595;1193.1945936492832;1208.6253261488966;1208.64949164743;1218.6405010521917;18109.818901811075;18210.18054187565;18279.451616451526;18350.724739128924;18360.632787344177;663881;666621;667947;671869;672422;65668.34331656623;66200.66899665471;66261.33738662647;66390.33609663938;66554;1451.9491817786115;1458.0886945658963;1469.3167677030233;1476.6603681153395;1502.6318551954623;33305.83347083249;33829.83085084559;34097.48853767146;34155.316893662486;34314.31371372509;57295.42704572901;57451.71274143602;57885;58088;58138.4186158133;540810;544982;545227;545518;546248;31846;31884;32061.519077213394;32352.191195219366;32477.18807029843;53395;53537.85848566014;53941.73029134829;54490.72754636202;55404.44595553993;44338.55661443473;45800.54199457963;45881.77059114817;46619.30071048869;47695.76152119217;45625.31562026506;45754.31368529541;46656.30015549702;46854.53145468638;47066.76466617645;44413.77793111143;44439.11121777611;44479;44663;45056.77471612621;38167.61832381641;39898.601013989486;40109.79945100256;40847.38728919128;41152.38271425871;30784.38431231318;30814.845925771126;30896.227594310323;30938.690613093582;31490.685093148775 09:55:56 INFO - PROCESS | 23703 | |2;jquery.html;417.3385184482595;427.06472824514316;433.3110354536287;434.58280051150894;439.94500687414063;19499.902500487497;21430.46423839403;21578.244761433354;21659.241926532573;22243.666345004836;20372.69440958383;20978.265760698378;21154.471138221554;21318.680219796715;21375.67936480954;5880.7059647017695;6063.211782468273;6071.666058366788;6071.908921366183;6085.604435711687;5987.161797348374;5998.40015998401;6080.635161890301;6090.756369745205;6135.447809697126;5907.497862681677;6060.4848587869865;6062.605930614518;6065.666388348639;6075.362086980869;5960.403959604048;5998.910016349758;6004.009338459149;6006.369331220203;6016.578839481238;5187.636865419422;5352.464753524655;5362.410134885159;5417.295751552312;5422.75597598109;17934.641307173915;17961.820381796144;21650.783492165036;25595.232143035737;25742.356441088934;2642.9471410571873;2736.4253506763603;2788.6653601567737;2993.730564249228;3324.7007769300635;9823.36148150368;10176.440295783728;10221.79556408875;15727.213639318103;15899.443519476763;2037.7656569494402;2042.8467864910192;2056.1158701758236;2139.882306473143;2153.536989547239;90828.54585727095;92253.07746922511;92328.61507077467;92790.07209927881;93165.5341723287;11775.293482391084;11863.940680296544;11869.287842729464;11883.643490695293;12057.879421205676;17264.827351726573;17265.56836079083;17278.827211727723;17295.481135565955;17312.653746925243;8970;9056.773580660536;9117.635294588143;9154.176124148726;9545.379550329206;9110.772230694152;9157.084291570789;9187.816243675223;9202.355835091614;9347.719568412958;5178.61160412963;5219.608529360313;5225;5272.868178295574;5362.624616276901;2070.6479898417306;2148.8280937525274;2183;2211.535577528737;2230.8215342772537;488.4236600811006;508.9923651145236;971.562796741455;1050.3277902142636;1088.2098947231918;12329.753404931851;13068.346582670829;13213.405396757169;13225.735485290434;13239.139455935527;518.9232342888521;521.2520033751579;524.3943245551394;524.4414698346249;531.2376739379004;11170.27393219438;12008.519659213534;12060.698482538006;12231.775700934579;12363.93818030904;550443;561399;562253;566868;570277;99479;100271.49864250633;106382;109143;110705;1052.3633201912885;1074.4198133008088;1093.8960798724108;1108.2353176308322;1109.378747901178;18102.5474363142;18320.816791831912;18642.44072677822;18684.159212835726;18993;44845.775771120934;45501;45972.310415344466;46826.53173468222;47442;63905;64512.35487645251;64927.35072649402;65469;68325.65837170782;7731.536107833548;8462.492250464991;8636.568171591522;8783.429077109968;9158.633654653739;10523.473826308807;14073.296335183404;14115.929420352833;14398.136111833324;14646;11964.700882478008;11966;12082.939585302369;12126.211796233216;12309.322987235788;11605.187636865337;12089.69775755578;12127.543650060043;12269.8960564946;12518.248905065726;12015.939920300343;12124.454399552218;12639.810402844148;12853.7642101915;12904;7936.087349954829;8477.506064968671;8566.657333706582;8701.912980870111;8716.477011379338;9145.542722863964;11001.179268853362;12039.518419263131;12205.938970305448;12883.742325153256 09:55:56 INFO - PROCESS | 23703 | |3;mootools.html;1540.645651500155;1542.637480192155;1721.4061148903625;1809.8461630761385;1854.9258029678813;7443.8883416748795;8281.66873325067;8287.17128287171;8913.331500137483;8922.152395522431;8427.115152908947;8670.263027642643;8674.392792504526;8675.045744968049;8675.392722509427;2363.2083252110565;2401.9639705404347;2411.144043864429;2414.879256037191;2417.8186636002283;2364.893579788905;2376.7266764322153;2424.151546958568;2427.0291883246664;2428.2108314797674;2359.539889721505;2370.419247284418;2380.6071998120287;2384.1655420602824;2392.1627430399394;2338.754430784777;2344.577975964334;2346.5658853112145;2354.423166324253;2370.0638247892157;2307.746147923727;2312.1329501436962;2321.141177764221;2328.452813588822;2330.778576035291;8599.527026013568;8662.393632445732;8680.218780309802;8681.34889883255;8708.521031343274;5240.8689782755355;5262.342207224097;5274.10340242156;5292.253556326403;5393.7303134843105;3372.089535825338;3372.1906742381652;3374.105861946586;3407.488876668495;3412.77816941898;1020.8315627921384;1042.3836171210316;2224.5328481019005;2273.476441150322;2285.0859656137513;11604.767904641943;11656.533738650443;11710.590129345517;11727.237729547553;11732.824007639892;4399.340098985178;4431.667624928144;4606.239970404913;4639.443266808004;4677.602403795648;9503.097205765442;9511.286653501014;9518.857217141749;9540.093691099335;9557.569909354095;5294.735263236823;5346.037713211582;5348.545373643284;5349.358077030781;5361.490658387525;4902.338184345139;5032.32063671407;5061.013102444987;5082.466341034138;5107.923381149286;3924;3984.86052988144;4013.5986401359633;4064.6545043671617;4081.2041651878194;1113.5991043224433;1131.5247596009697;1140.6977151054978;1160.1241062997383;1161.5353858456685;896.3367108339781;962.0571839597094;1029.4543891737392;1041.9270651054505;1046.8482070099792;5773.336066352424;5858.033424484997;5917.142014407973;5936.584439089309;5994.910076348859;464.73974574238537;466.1865045495564;470.7011047984486;478.1966296621709;481.407868321959;4369.08249267651;4373;4418.085264777421;4430.955690443055;4523.7285762854335;10032.297739158335;10278.588856445807;10514.106300964351;10515.316504427188;10531.789364212826;10459.633912813015;10463.68608941733;10465.633702820365;10496.26526143178;10508.054275115277;7730.497517661334;8014.278714915686;8049.758507244792;8056.073551541531;8205.79485512867;6066.241719785027;6185.226846644169;6291.370862913672;6302.3067462578165;6397.168368112302;9538.523073846418;9830.311878168459;9855.802883942424;9921.156701680438;9930.702078937355;10043.949780251052;10115.544800483849;10124.645637402655;10169.67794186751;10169.84745228837;7584.54492730438;8081.313088387553;8265;8367.372447066373;8507.489550626982;8591.65633374658;8601.698940537051;8616.612252448529;8637.179467950535;8682.609282582425;7508.2867127622785;7546.924530754842;7603.885941710768;7645.961770191114;7743.7676869694;7330.266973302627;7342;7357.5217610855125;7361.4110871129105;7480.70077196906;7122.679479423542;7216;7220.783376498714;7225.060742103493;7229;5367.597430192829;5425.186222066722;5435.782568697208;5437.728113594384;5633.718314084197;5345.305110335631;5425.565954723534;5466.945330546644;5513.972430137824;5541.224228608079 09:55:56 INFO - PROCESS | 23703 | |4;prototype.html;353.2405328543631;359.9586047604525;361.83898165316435;364.3532729405307;368.4160605440377;5679.233303504026;5784.739686714098;5846.830633873226;5861.560382971278;5864.618799778023;5733.455321744438;5764.827055188351;5803.709814509279;5815.912761308584;5830.883382332361;4492.168948744476;4493.775311234425;4518.5481451854885;4518.683692141552;4526.932096018546;4299.226139294926;4472.44094488189;4489.3939318192115;4509.286471140962;4512.59386655201;4470.441194850644;4472.709273897186;4476.418065651461;4476.709013914102;4478.843240486583;4479.969606990394;4492.326151077365;4492.460904691442;4502.469160485451;4518.1415531049;3795.772253664789;3918.1380096378753;3969.1069509360163;3976.840926362942;3989.920201595981;5652.293463317085;5654.4062873398525;5657.717114144318;5666.291713535808;5666.971665141689;5129.384473863161;5141.897162056738;5143.151380022329;5151.845444636667;5185.948140518584;5856.740800727864;5931.763766959332;5959.880802383971;6017.729202185912;6033.456988870978;4279.288284686119;4289.185054839601;4295.763732994684;4297.892552686177;4305.547917468652;6218.689065546704;6271.435570798604;6272.56092073555;6292.811215663537;6317.210348706411;4357.54245804186;4415.094905544356;4453.240969816904;4461.866144015685;4477.485089214782;4502.459704835441;4506.6169375602785;4510.932336014962;4511.887202819956;4514.774261286922;5099.546629210658;5109.259157422227;5125;5133.948660513422;5183.2743415921805;5880.8235752927485;5963.612365196248;6061.515078793686;6075.574709770273;6077.453029227391;1533.4326299269342;1560.7034663413915;1564.2335255724613;1567.1537369820398;1567.6204939653032;941.924646028316;971.6987733802403;971.9076687714655;992.0179022767409;995.1193194023341;5141.562967147835;5181.559567436735;5186.247994040843;5229.790808367623;5262.315898933114;5422.2919780269085;5465.6447330923365;5481.451854814487;5487.314085739283;5494.450554944474;5025.150729546006;5100.846974590768;5218.817341393033;5223.242629818731;5229.848599129854;2935.66239882412;2947.911562653124;2949.8967536136133;2952.818872451037;2956.216602600313;5567.4432556744005;5615.950178184933;5621.353544342372;5655.802046928337;5683.744231509592;5208.8437346879655;5531.446855314517;5546.91679624806;5551.333839939152;5556.499745068809;5600.823826996295;5608.69152196625;5609.382967873531;5628.185907046477;5647.237622920853;5080.923786143137;5438.510534051954;5459.645123066988;5462.863428414322;5478.602956246291;5360.70516121617;5374.140137578125;5396.1366181410785;5414.3232095988005;5431.849527274093;5584.441555844383;5617.831465056055;5626;5649.519790817662;5654.519365853784;3963.3262345401927;4014.8394064238273;4207.852725154605;4400.955990440183;4445.2887537993765;6146.692665366803;6224.346443623535;6225.315215326401;6241.719122639583;6249.812505624838;6126.6017708848785;6140.754369825157;6143.109249158936;6154.476869466145;6170.691465426621;6026.15633811258;6173.506119510339;6176.610262690859;6178.196834411498;6187.907181392373;6088;6124.418180272867;6130.570860039755;6131.448169664752;6144.095330447575;6173.59871608344;6184.474319682878;6184.81445556634;6187.381261873777;6200.441960223601;5922.822315330547;6009.248843894513;6016.819495415145;6029.397060294111;6052.671030932881 09:55:56 INFO - PROCESS | 23703 | |5;yui.html;807.5518087461456;836.3142223376833;850.124371896946;870.2950610005896;891.8795962545056;16357.345706171769;16510.422135225268;16885.91557042213;16920.576985575368;17670.558236044104;16084.276207570658;16198.919005404956;16217.675646487092;16240.593985150377;16274.51176464705;870.2081106193365;884.5488800711652;900.1763386501343;901.5987885391004;902.4089221559889;891.5319457284912;892.3218354050903;892.6340200517789;894.2890402130322;894.825509025737;957.0764212534903;958.2238386906594;958.3914214473824;959.0170075672456;961.3654987708114;951.6050838901882;954.9904500954971;955.073578628729;956.8516879883629;957.2294303086013;696.8188271049513;699.5872435263168;701.2146396036421;702.4275215699189;702.9578225306498;15966.521004369888;16050.438234661848;16055.759163612554;16074.839251607567;16240.593985150348;14852.331645075998;15032.323545440482;15044;15217.923910380377;15217.923910380488;13400.798988015187;13404.262765547892;13482.05625606208;13508.527201547997;13867.514636987758;4130.173965206941;4134.235166494178;4156.397322388237;4177.937330940038;4246.511651160125;69316.6534167336;93715;93974.53012734962;93984.53007734986;95733;12397.194182378116;12658.430370633343;12703.237805731686;12842.357882105858;13119.737605247841;22007;22025.559488810453;22076.2273320433;22100.88949555242;22143.224987125373;8766.60550275239;8803.603837827313;8881.689140880038;9151.908480915106;9198.540072996324;5345.251664766935;5371.75827087782;5448.37343705471;5499.340079190522;5529.723513824292;3486.511888335635;3635.4365073413665;3645.2527231917393;3652.36083685354;3678.9080272993388;611.1230384398402;616.3374372549528;617.1144407774857;626.2766504687094;638.4987784589168;679.7247114918466;694.989575156373;775.7207405334075;786.5516655506307;793.2583034862422;10042.849357259647;10546.103581195684;10761.623343183108;10801.945990269998;10807.243492955418;700.2962023166787;748.6892939430076;758.9582572958541;768.4198430185286;792.3542313014874;4916.410030796327;5194.558462530727;5271.655727789389;5290.391604965402;5306.442823503554;125415;130436;133155.33422332827;133747;135173.32413337872;114415.42792286152;116021;116153;119994;120699;100754;102106.4894675522;102424;103487;105106.47446762717;9500.097490738368;9541.284403669892;9632.75918102053;9728.75678108053;9741.123298903132;59528;59673.40326596679;60066.39933600608;61276.38723612885;61533;80593.19406805857;83795;88008.5599571998;88088;92141.5392923031;12281.508739650313;14224.502142424966;14251.857481425053;14314.785278221043;15379.923100384427;16255.756163657317;16745.246463909396;16896.493105206864;17051.744223836406;18048.368307109187;15011.474598389004;15191.544253672408;15193.6201594961;15343.923280383528;17033.14834258257;13642.181469111885;13695.246761428218;14348.139111653334;14646.487372941896;15910.351825101921;15098.169600672069;15355.61610959735;15373.692526149638;15384.153871537173;15897.947975435434;11387.886121139014;11611.767764644828;11819.290842549475;11861.76276474483;12375.133740638068;12158.934861782765;12456.12807103494;12746.49014039428;12908.483660653845;13005.349732513147 09:55:56 INFO - PROCESS | 23703 | __end_tp_report 09:55:56 INFO - PROCESS | 23703 | __start_cc_report 09:55:56 INFO - PROCESS | 23703 | _x_x_mozilla_cycle_collect,341 09:55:56 INFO - PROCESS | 23703 | __end_cc_report 09:55:56 INFO - PROCESS | 23703 | __startTimestamp1475600156146__endTimestamp 09:55:56 INFO - PROCESS | 23703 | 09:55:56 INFO - PROCESS | 23703 | ------- Summary: start ------- 09:55:56 INFO - PROCESS | 23703 | Number of tests: 6 09:55:56 INFO - PROCESS | 23703 | 09:55:56 INFO - PROCESS | 23703 | [#0] dojo.html Cycles:165 Average:5771.00 Median:6016.37 stddev:661.72 (11.0%) stddev-sans-first:634.25 09:55:56 INFO - PROCESS | 23703 | Values: 3280.8 3294.8 3307.2 3323.5 3332.4 5778.0 5853.4 5853.9 5864.6 5865.4 5742.7 5821.4 5826.4 5849.7 5858.9 5281.0 5325.1 5356.2 5381.8 5385.8 5389.1 5389.5 5390.2 5392.6 5403.6 5130.9 5145.8 5382.4 5390.2 5400.6 5198.4 5239.3 5270.5 5320.2 5399.3 5234.4 5338.3 5338.6 5339.4 5348.3 5747.4 5775.6 5788.9 5831.2 5862.5 5963.0 6002.9 6045.5 6086.5 6107.2 6131.3 6134.5 6141.0 6145.0 6150.3 5665.2 5701.6 5709.3 5714.0 5717.0 6105.7 6229.3 6247.4 6261.3 6371.9 6054.4 6087.0 6092.8 6121.2 6129.3 6160.8 6196.2 6219.7 6226.4 6235.3 6007.8 6089.8 6133.6 6143.4 6233.5 6220.8 6282.1 6289.5 6290.4 6292.6 4650.5 4666.7 4672.1 4689.0 4706.7 4112.3 4149.7 4151.1 4209.6 4257.8 5880.2 5994.6 5998.9 6016.4 6017.5 6256.6 6257.7 6263.5 6283.8 6290.4 5794.1 5922.6 6016.0 6029.9 6095.4 5398.9 5414.9 5421.5 5439.6 5446.0 6212.8 6462.0 6488.0 6521.4 6529.2 6149.9 6171.4 6191.2 6299.5 6301.0 6448.5 6471.7 6478.0 6497.2 6532.4 5925.8 6165.9 6170.8 6172.6 6177.7 6127.0 6132.6 6155.7 6266.7 6270.8 6053.3 6098.1 6099.5 6104.9 6126.4 5934.5 6051.8 6082.6 6094.7 6123.1 5963.7 6021.0 6025.8 6083.5 6132.3 6047.0 6112.9 6119.8 6145.3 6151.5 5756.4 5958.9 5966.4 5968.2 6003.0 09:55:56 INFO - PROCESS | 23703 | 09:55:56 INFO - PROCESS | 23703 | [#1] ext.html Cycles:180 Average:70424.19 Median:24841.12 stddev:146500.49 (589.8%) stddev-sans-first:146817.61 09:55:56 INFO - PROCESS | 23703 | Values: 583.4 597.5 634.2 668.8 702.2 41593.8 47002.1 47156.5 47165.5 47193.8 47733.3 47991.3 48294.8 48335.8 48340.8 9139.8 9222.0 9225.1 9248.7 9248.8 9180.5 9252.2 9270.8 9278.0 9285.7 9293.7 9314.3 9362.5 9366.7 9382.0 9248.9 9277.2 9297.1 9298.3 9299.2 9221.0 9295.4 9297.2 9301.0 9323.1 44581.3 44856.8 45162.5 45230.8 45456.1 4085.9 4196.2 4200.2 4261.7 4452.8 35609.3 36023.3 36201.0 36335.6 37738.8 4452.9 4519.7 4523.1 4560.2 4560.3 402639.0 404317.0 404850.0 406757.0 407989.0 67362.0 67732.3 67828.7 67894.3 67948.0 41135.4 41555.6 41764.8 43822.3 44204.8 20450.0 20670.7 20670.7 20696.9 20706.2 15608.5 15733.4 15749.1 15801.0 15829.1 21718.9 21724.1 21838.2 21974.5 22042.6 7533.7 7555.4 7746.5 7764.4 7782.4 1020.6 1070.4 1079.7 1094.1 1121.1 34608.7 34716.0 34971.7 35090.3 35573.6 1184.2 1193.2 1208.6 1208.6 1218.6 18109.8 18210.2 18279.5 18350.7 18360.6 663881.0 666621.0 667947.0 671869.0 672422.0 65668.3 66200.7 66261.3 66390.3 66554.0 1451.9 1458.1 1469.3 1476.7 1502.6 33305.8 33829.8 34097.5 34155.3 34314.3 57295.4 57451.7 57885.0 58088.0 58138.4 540810.0 544982.0 545227.0 545518.0 546248.0 31846.0 31884.0 32061.5 32352.2 32477.2 53395.0 53537.9 53941.7 54490.7 55404.4 44338.6 45800.5 45881.8 46619.3 47695.8 45625.3 45754.3 46656.3 46854.5 47066.8 44413.8 44439.1 44479.0 44663.0 45056.8 38167.6 39898.6 40109.8 40847.4 41152.4 30784.4 30814.8 30896.2 30938.7 31490.7 09:55:56 INFO - PROCESS | 23703 | 09:55:56 INFO - PROCESS | 23703 | [#2] jquery.html Cycles:180 Average:32286.31 Median:2762.55 stddev:92844.50 (3360.8%) stddev-sans-first:93074.11 09:55:56 INFO - PROCESS | 23703 | Values: 417.3 427.1 433.3 434.6 439.9 19499.9 21430.5 21578.2 21659.2 22243.7 20372.7 20978.3 21154.5 21318.7 21375.7 5880.7 6063.2 6071.7 6071.9 6085.6 5987.2 5998.4 6080.6 6090.8 6135.4 5907.5 6060.5 6062.6 6065.7 6075.4 5960.4 5998.9 6004.0 6006.4 6016.6 5187.6 5352.5 5362.4 5417.3 5422.8 17934.6 17961.8 21650.8 25595.2 25742.4 2642.9 2736.4 2788.7 2993.7 3324.7 9823.4 10176.4 10221.8 15727.2 15899.4 2037.8 2042.8 2056.1 2139.9 2153.5 90828.5 92253.1 92328.6 92790.1 93165.5 11775.3 11863.9 11869.3 11883.6 12057.9 17264.8 17265.6 17278.8 17295.5 17312.7 8970.0 9056.8 9117.6 9154.2 9545.4 9110.8 9157.1 9187.8 9202.4 9347.7 5178.6 5219.6 5225.0 5272.9 5362.6 2070.6 2148.8 2183.0 2211.5 2230.8 488.4 509.0 971.6 1050.3 1088.2 12329.8 13068.3 13213.4 13225.7 13239.1 518.9 521.3 524.4 524.4 531.2 11170.3 12008.5 12060.7 12231.8 12363.9 550443.0 561399.0 562253.0 566868.0 570277.0 99479.0 100271.5 106382.0 109143.0 110705.0 1052.4 1074.4 1093.9 1108.2 1109.4 18102.5 18320.8 18642.4 18684.2 18993.0 44845.8 45501.0 45972.3 46826.5 47442.0 63905.0 64512.4 64927.4 65469.0 68325.7 7731.5 8462.5 8636.6 8783.4 9158.6 10523.5 14073.3 14115.9 14398.1 14646.0 11964.7 11966.0 12082.9 12126.2 12309.3 11605.2 12089.7 12127.5 12269.9 12518.2 12015.9 12124.5 12639.8 12853.8 12904.0 7936.1 8477.5 8566.7 8701.9 8716.5 9145.5 11001.2 12039.5 12205.9 12883.7 09:55:56 INFO - PROCESS | 23703 | 09:55:56 INFO - PROCESS | 23703 | [#3] mootools.html Cycles:180 Average:5769.06 Median:5071.74 stddev:3149.45 (62.1%) stddev-sans-first:3142.25 09:55:56 INFO - PROCESS | 23703 | Values: 1540.6 1542.6 1721.4 1809.8 1854.9 7443.9 8281.7 8287.2 8913.3 8922.2 8427.1 8670.3 8674.4 8675.0 8675.4 2363.2 2402.0 2411.1 2414.9 2417.8 2364.9 2376.7 2424.2 2427.0 2428.2 2359.5 2370.4 2380.6 2384.2 2392.2 2338.8 2344.6 2346.6 2354.4 2370.1 2307.7 2312.1 2321.1 2328.5 2330.8 8599.5 8662.4 8680.2 8681.3 8708.5 5240.9 5262.3 5274.1 5292.3 5393.7 3372.1 3372.2 3374.1 3407.5 3412.8 1020.8 1042.4 2224.5 2273.5 2285.1 11604.8 11656.5 11710.6 11727.2 11732.8 4399.3 4431.7 4606.2 4639.4 4677.6 9503.1 9511.3 9518.9 9540.1 9557.6 5294.7 5346.0 5348.5 5349.4 5361.5 4902.3 5032.3 5061.0 5082.5 5107.9 3924.0 3984.9 4013.6 4064.7 4081.2 1113.6 1131.5 1140.7 1160.1 1161.5 896.3 962.1 1029.5 1041.9 1046.8 5773.3 5858.0 5917.1 5936.6 5994.9 464.7 466.2 470.7 478.2 481.4 4369.1 4373.0 4418.1 4431.0 4523.7 10032.3 10278.6 10514.1 10515.3 10531.8 10459.6 10463.7 10465.6 10496.3 10508.1 7730.5 8014.3 8049.8 8056.1 8205.8 6066.2 6185.2 6291.4 6302.3 6397.2 9538.5 9830.3 9855.8 9921.2 9930.7 10043.9 10115.5 10124.6 10169.7 10169.8 7584.5 8081.3 8265.0 8367.4 8507.5 8591.7 8601.7 8616.6 8637.2 8682.6 7508.3 7546.9 7603.9 7646.0 7743.8 7330.3 7342.0 7357.5 7361.4 7480.7 7122.7 7216.0 7220.8 7225.1 7229.0 5367.6 5425.2 5435.8 5437.7 5633.7 5345.3 5425.6 5466.9 5514.0 5541.2 09:55:56 INFO - PROCESS | 23703 | 09:55:56 INFO - PROCESS | 23703 | [#4] prototype.html Cycles:180 Average:4909.16 Median:5464.25 stddev:1424.22 (26.1%) stddev-sans-first:1386.56 09:55:56 INFO - PROCESS | 23703 | Values: 353.2 360.0 361.8 364.4 368.4 5679.2 5784.7 5846.8 5861.6 5864.6 5733.5 5764.8 5803.7 5815.9 5830.9 4492.2 4493.8 4518.5 4518.7 4526.9 4299.2 4472.4 4489.4 4509.3 4512.6 4470.4 4472.7 4476.4 4476.7 4478.8 4480.0 4492.3 4492.5 4502.5 4518.1 3795.8 3918.1 3969.1 3976.8 3989.9 5652.3 5654.4 5657.7 5666.3 5667.0 5129.4 5141.9 5143.2 5151.8 5185.9 5856.7 5931.8 5959.9 6017.7 6033.5 4279.3 4289.2 4295.8 4297.9 4305.5 6218.7 6271.4 6272.6 6292.8 6317.2 4357.5 4415.1 4453.2 4461.9 4477.5 4502.5 4506.6 4510.9 4511.9 4514.8 5099.5 5109.3 5125.0 5133.9 5183.3 5880.8 5963.6 6061.5 6075.6 6077.5 1533.4 1560.7 1564.2 1567.2 1567.6 941.9 971.7 971.9 992.0 995.1 5141.6 5181.6 5186.2 5229.8 5262.3 5422.3 5465.6 5481.5 5487.3 5494.5 5025.2 5100.8 5218.8 5223.2 5229.8 2935.7 2947.9 2949.9 2952.8 2956.2 5567.4 5616.0 5621.4 5655.8 5683.7 5208.8 5531.4 5546.9 5551.3 5556.5 5600.8 5608.7 5609.4 5628.2 5647.2 5080.9 5438.5 5459.6 5462.9 5478.6 5360.7 5374.1 5396.1 5414.3 5431.8 5584.4 5617.8 5626.0 5649.5 5654.5 3963.3 4014.8 4207.9 4401.0 4445.3 6146.7 6224.3 6225.3 6241.7 6249.8 6126.6 6140.8 6143.1 6154.5 6170.7 6026.2 6173.5 6176.6 6178.2 6187.9 6088.0 6124.4 6130.6 6131.4 6144.1 6173.6 6184.5 6184.8 6187.4 6200.4 5922.8 6009.2 6016.8 6029.4 6052.7 09:55:56 INFO - PROCESS | 23703 | 09:55:56 INFO - PROCESS | 23703 | [#5] yui.html Cycles:180 Average:23795.32 Median:3560.97 stddev:35164.83 (987.5%) stddev-sans-first:35221.11 09:55:56 INFO - PROCESS | 23703 | Values: 807.6 836.3 850.1 870.3 891.9 16357.3 16510.4 16885.9 16920.6 17670.6 16084.3 16198.9 16217.7 16240.6 16274.5 870.2 884.5 900.2 901.6 902.4 891.5 892.3 892.6 894.3 894.8 957.1 958.2 958.4 959.0 961.4 951.6 955.0 955.1 956.9 957.2 696.8 699.6 701.2 702.4 703.0 15966.5 16050.4 16055.8 16074.8 16240.6 14852.3 15032.3 15044.0 15217.9 15217.9 13400.8 13404.3 13482.1 13508.5 13867.5 4130.2 4134.2 4156.4 4177.9 4246.5 69316.7 93715.0 93974.5 93984.5 95733.0 12397.2 12658.4 12703.2 12842.4 13119.7 22007.0 22025.6 22076.2 22100.9 22143.2 8766.6 8803.6 8881.7 9151.9 9198.5 5345.3 5371.8 5448.4 5499.3 5529.7 3486.5 3635.4 3645.3 3652.4 3678.9 611.1 616.3 617.1 626.3 638.5 679.7 695.0 775.7 786.6 793.3 10042.8 10546.1 10761.6 10801.9 10807.2 700.3 748.7 759.0 768.4 792.4 4916.4 5194.6 5271.7 5290.4 5306.4 125415.0 130436.0 133155.3 133747.0 135173.3 114415.4 116021.0 116153.0 119994.0 120699.0 100754.0 102106.5 102424.0 103487.0 105106.5 9500.1 9541.3 9632.8 9728.8 9741.1 59528.0 59673.4 60066.4 61276.4 61533.0 80593.2 83795.0 88008.6 88088.0 92141.5 12281.5 14224.5 14251.9 14314.8 15379.9 16255.8 16745.2 16896.5 17051.7 18048.4 15011.5 15191.5 15193.6 15343.9 17033.1 13642.2 13695.2 14348.1 14646.5 15910.4 15098.2 15355.6 15373.7 15384.2 15897.9 11387.9 11611.8 11819.3 11861.8 12375.1 12158.9 12456.1 12746.5 12908.5 13005.3 09:55:56 INFO - PROCESS | 23703 | -------- Summary: end -------- 09:55:56 INFO - PROCESS | 23703 | 09:55:56 INFO - TEST-INFO | 23703: exit 0 09:55:56 INFO - TEST-OK | dromaeo_css | took 1111077ms 09:55:56 INFO - TEST-START | kraken 09:55:56 INFO - operating with platform_type : linux_ 09:55:56 INFO - Initialising browser for kraken test... 09:55:56 INFO - TEST-INFO | started process 23945 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5G56qz/profile http://localhost:44557/getInfo.html) 09:56:01 INFO - PROCESS | 23945 | __metrics Screen width/height:1600/1200 09:56:01 INFO - PROCESS | 23945 | colorDepth:24 09:56:01 INFO - PROCESS | 23945 | Browser inner width/height: 1024/697 09:56:01 INFO - PROCESS | 23945 | __metrics 09:56:02 ERROR - PROCESS | 23945 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 09:56:03 INFO - TEST-INFO | 23945: exit 0 09:56:03 INFO - Browser initialized. 09:56:03 INFO - Running cycle 1/1 for kraken test... 09:56:03 INFO - TEST-INFO | started process 24065 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5G56qz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:56:14 INFO - PROCESS | 24065 | RSS: Main: 150007808 09:56:14 INFO - PROCESS | 24065 | 09:56:17 INFO - PROCESS | 24065 | Cycle 1(1): loaded http://localhost:44557/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44557/tests/kraken/driver.html?testName=audio-beat-detection) 09:56:18 INFO - PROCESS | 24065 | RSS: Main: 156479488 09:56:18 INFO - PROCESS | 24065 | 09:56:20 INFO - PROCESS | 24065 | Cycle 1(1): loaded http://localhost:44557/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44557/tests/kraken/driver.html?testName=audio-dft) 09:56:21 INFO - PROCESS | 24065 | RSS: Main: 155545600 09:56:21 INFO - PROCESS | 24065 | 09:56:24 INFO - PROCESS | 24065 | Cycle 1(1): loaded http://localhost:44557/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44557/tests/kraken/driver.html?testName=audio-fft) 09:56:24 INFO - PROCESS | 24065 | RSS: Main: 156184576 09:56:24 INFO - PROCESS | 24065 | 09:56:26 INFO - PROCESS | 24065 | Cycle 1(1): loaded http://localhost:44557/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44557/tests/kraken/driver.html?testName=audio-oscillator) 09:56:27 INFO - PROCESS | 24065 | RSS: Main: 155840512 09:56:27 INFO - PROCESS | 24065 | 09:56:29 INFO - PROCESS | 24065 | Cycle 1(1): loaded http://localhost:44557/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44557/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:56:30 INFO - PROCESS | 24065 | RSS: Main: 155676672 09:56:30 INFO - PROCESS | 24065 | 09:56:33 INFO - PROCESS | 24065 | Cycle 1(1): loaded http://localhost:44557/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44557/tests/kraken/driver.html?testName=imaging-darkroom) 09:56:34 INFO - PROCESS | 24065 | RSS: Main: 155828224 09:56:34 INFO - PROCESS | 24065 | 09:56:37 INFO - PROCESS | 24065 | Cycle 1(1): loaded http://localhost:44557/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44557/tests/kraken/driver.html?testName=imaging-desaturate) 09:56:38 INFO - PROCESS | 24065 | RSS: Main: 153935872 09:56:38 INFO - PROCESS | 24065 | 09:56:40 INFO - PROCESS | 24065 | Cycle 1(1): loaded http://localhost:44557/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44557/tests/kraken/driver.html?testName=json-parse-financial) 09:56:41 INFO - PROCESS | 24065 | RSS: Main: 155705344 09:56:41 INFO - PROCESS | 24065 | 09:56:43 INFO - PROCESS | 24065 | Cycle 1(1): loaded http://localhost:44557/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44557/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:56:43 INFO - PROCESS | 24065 | RSS: Main: 156192768 09:56:43 INFO - PROCESS | 24065 | 09:56:45 INFO - PROCESS | 24065 | Cycle 1(1): loaded http://localhost:44557/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44557/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:56:46 INFO - PROCESS | 24065 | RSS: Main: 155938816 09:56:46 INFO - PROCESS | 24065 | 09:56:48 INFO - PROCESS | 24065 | Cycle 1(1): loaded http://localhost:44557/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44557/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:56:48 INFO - PROCESS | 24065 | RSS: Main: 156327936 09:56:48 INFO - PROCESS | 24065 | 09:56:51 INFO - PROCESS | 24065 | Cycle 1(1): loaded http://localhost:44557/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44557/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:56:51 INFO - PROCESS | 24065 | RSS: Main: 156999680 09:56:51 INFO - PROCESS | 24065 | 09:56:54 INFO - PROCESS | 24065 | Cycle 1(1): loaded http://localhost:44557/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44557/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:56:55 INFO - PROCESS | 24065 | RSS: Main: 156729344 09:56:55 INFO - PROCESS | 24065 | 09:56:56 INFO - PROCESS | 24065 | Cycle 1(1): loaded http://localhost:44557/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44557/tests/kraken/driver.html?testName=ai-astar) 09:56:57 INFO - PROCESS | 24065 | RSS: Main: 158863360 09:56:57 INFO - PROCESS | 24065 | 09:56:57 INFO - PROCESS | 24065 | __start_tp_report 09:56:57 INFO - PROCESS | 24065 | _x_x_mozilla_page_load 09:56:57 INFO - PROCESS | 24065 | _x_x_mozilla_page_load_details 09:56:57 INFO - PROCESS | 24065 | |i|pagename|runs| 09:56:57 INFO - PROCESS | 24065 | |0;ai-astar;102;114;109;111;117;113;113;112;115;112 09:56:57 INFO - PROCESS | 24065 | |1;audio-beat-detection;149;121;142;164;119;145;145;123;172;118 09:56:57 INFO - PROCESS | 24065 | |2;audio-dft;163;163;164;161;162;163;163;162;161;162 09:56:57 INFO - PROCESS | 24065 | |3;audio-fft;74;76;76;172;76;74;75;75;166;76 09:56:57 INFO - PROCESS | 24065 | |4;audio-oscillator;87;84;143;83;83;84;141;84;83;135 09:56:57 INFO - PROCESS | 24065 | |5;imaging-gaussian-blur;117;118;117;117;117;117;118;119;117;117 09:56:57 INFO - PROCESS | 24065 | |6;imaging-darkroom;147;147;151;148;147;146;147;148;147;149 09:56:57 INFO - PROCESS | 24065 | |7;imaging-desaturate;95;96;95;96;96;96;95;95;95;95 09:56:57 INFO - PROCESS | 24065 | |8;json-parse-financial;50;51;51;51;50;51;51;52;51;61 09:56:57 INFO - PROCESS | 24065 | |9;json-stringify-tinderbox;59;60;59;63;60;60;59;60;61;59 09:56:57 INFO - PROCESS | 24065 | |10;stanford-crypto-aes;75;72;73;81;72;73;74;80;79;82 09:56:57 INFO - PROCESS | 24065 | |11;stanford-crypto-ccm;132;134;125;120;134;124;122;138;148;126 09:56:57 INFO - PROCESS | 24065 | |12;stanford-crypto-pbkdf2;154;160;154;151;154;152;152;157;152;150 09:56:57 INFO - PROCESS | 24065 | |13;stanford-crypto-sha256-iterative;62;62;64;61;62;61;60;63;63;61 09:56:57 INFO - PROCESS | 24065 | __end_tp_report 09:56:57 INFO - PROCESS | 24065 | __start_cc_report 09:56:57 INFO - PROCESS | 24065 | _x_x_mozilla_cycle_collect,864 09:56:57 INFO - PROCESS | 24065 | __end_cc_report 09:56:57 INFO - PROCESS | 24065 | __startTimestamp1475600217089__endTimestamp 09:56:57 INFO - PROCESS | 24065 | 09:56:57 INFO - PROCESS | 24065 | ------- Summary: start ------- 09:56:57 INFO - PROCESS | 24065 | Number of tests: 14 09:56:57 INFO - PROCESS | 24065 | 09:56:57 INFO - PROCESS | 24065 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.00 stddev:4.08 (3.6%) stddev-sans-first:2.32 09:56:57 INFO - PROCESS | 24065 | Values: 102.0 114.0 109.0 111.0 117.0 113.0 113.0 112.0 115.0 112.0 09:56:57 INFO - PROCESS | 24065 | 09:56:57 INFO - PROCESS | 24065 | [#1] audio-beat-detection Cycles:10 Average:139.80 Median:145.00 stddev:19.18 (13.2%) stddev-sans-first:20.05 09:56:57 INFO - PROCESS | 24065 | Values: 149.0 121.0 142.0 164.0 119.0 145.0 145.0 123.0 172.0 118.0 09:56:57 INFO - PROCESS | 24065 | 09:56:57 INFO - PROCESS | 24065 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 09:56:57 INFO - PROCESS | 24065 | Values: 163.0 163.0 164.0 161.0 162.0 163.0 163.0 162.0 161.0 162.0 09:56:57 INFO - PROCESS | 24065 | 09:56:57 INFO - PROCESS | 24065 | [#3] audio-fft Cycles:10 Average:94.00 Median:75.50 stddev:39.56 (52.4%) stddev-sans-first:41.29 09:56:57 INFO - PROCESS | 24065 | Values: 74.0 76.0 76.0 172.0 76.0 74.0 75.0 75.0 166.0 76.0 09:56:57 INFO - PROCESS | 24065 | 09:56:57 INFO - PROCESS | 24065 | [#4] audio-oscillator Cycles:10 Average:100.70 Median:83.50 stddev:26.99 (32.3%) stddev-sans-first:28.16 09:56:57 INFO - PROCESS | 24065 | Values: 87.0 84.0 143.0 83.0 83.0 84.0 141.0 84.0 83.0 135.0 09:56:57 INFO - PROCESS | 24065 | 09:56:57 INFO - PROCESS | 24065 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 09:56:57 INFO - PROCESS | 24065 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 118.0 119.0 117.0 117.0 09:56:57 INFO - PROCESS | 24065 | 09:56:57 INFO - PROCESS | 24065 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:147.50 stddev:1.42 (1.0%) stddev-sans-first:1.48 09:56:57 INFO - PROCESS | 24065 | Values: 147.0 147.0 151.0 148.0 147.0 146.0 147.0 148.0 147.0 149.0 09:56:57 INFO - PROCESS | 24065 | 09:56:57 INFO - PROCESS | 24065 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 09:56:57 INFO - PROCESS | 24065 | Values: 95.0 96.0 95.0 96.0 96.0 96.0 95.0 95.0 95.0 95.0 09:56:57 INFO - PROCESS | 24065 | 09:56:57 INFO - PROCESS | 24065 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:51.00 stddev:3.25 (6.4%) stddev-sans-first:3.37 09:56:57 INFO - PROCESS | 24065 | Values: 50.0 51.0 51.0 51.0 50.0 51.0 51.0 52.0 51.0 61.0 09:56:57 INFO - PROCESS | 24065 | 09:56:57 INFO - PROCESS | 24065 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:1.25 (2.1%) stddev-sans-first:1.27 09:56:57 INFO - PROCESS | 24065 | Values: 59.0 60.0 59.0 63.0 60.0 60.0 59.0 60.0 61.0 59.0 09:56:57 INFO - PROCESS | 24065 | 09:56:57 INFO - PROCESS | 24065 | [#10] stanford-crypto-aes Cycles:10 Average:76.10 Median:77.00 stddev:3.96 (5.1%) stddev-sans-first:4.18 09:56:57 INFO - PROCESS | 24065 | Values: 75.0 72.0 73.0 81.0 72.0 73.0 74.0 80.0 79.0 82.0 09:56:57 INFO - PROCESS | 24065 | 09:56:57 INFO - PROCESS | 24065 | [#11] stanford-crypto-ccm Cycles:10 Average:130.30 Median:133.00 stddev:8.59 (6.5%) stddev-sans-first:9.09 09:56:57 INFO - PROCESS | 24065 | Values: 132.0 134.0 125.0 120.0 134.0 124.0 122.0 138.0 148.0 126.0 09:56:57 INFO - PROCESS | 24065 | 09:56:57 INFO - PROCESS | 24065 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.60 Median:154.00 stddev:2.99 (1.9%) stddev-sans-first:3.17 09:56:57 INFO - PROCESS | 24065 | Values: 154.0 160.0 154.0 151.0 154.0 152.0 152.0 157.0 152.0 150.0 09:56:57 INFO - PROCESS | 24065 | 09:56:57 INFO - PROCESS | 24065 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:62.00 stddev:1.20 (1.9%) stddev-sans-first:1.27 09:56:57 INFO - PROCESS | 24065 | Values: 62.0 62.0 64.0 61.0 62.0 61.0 60.0 63.0 63.0 61.0 09:56:57 INFO - PROCESS | 24065 | -------- Summary: end -------- 09:56:57 INFO - PROCESS | 24065 | 09:56:58 INFO - TEST-INFO | 24065: exit 0 09:56:58 INFO - TEST-OK | kraken | took 61185ms 09:56:58 INFO - SUITE-END | took 1172s 09:56:58 INFO - Completed test suite (00:19:32) 09:56:58 INFO - javascript benchmark 09:56:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7694.328947210215, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3280.770346075775, 3294.752893532984, 3307.1897385140646, 3323.5014747787814, 3332.4168270552645, 5777.971110144449, 5853.414658534144, 5853.941460585404, 5864.589478736485, 5865.413458654132, 5742.741576629051, 5821.446962538563, 5826.417358264182, 5849.678267695275, 5858.912116318259, 5280.973595132029, 5325.147976323789, 5356.169793681966, 5381.784728610871, 5385.761274906754, 5389.083855744513, 5389.487998640123, 5390.21841832934, 5392.595555333346, 5403.621746477748, 5130.871728206806, 5145.845624631267, 5382.407935127133, 5390.19147127932, 5400.648957817749, 5198.376194856603, 5239.345081864767, 5270.525652691276, 5320.228566857784, 5399.325084364455, 5234.398044224925, 5338.27933229013, 5338.572914166896, 5339.385970613391, 5348.277982472356, 5747.3677895431465, 5775.624584402, 5788.942110578924, 5831.2127862738835, 5862.472377486004, 5962.970185149046, 6002.909956350658, 6045.486133678643, 6086.482648974842, 6107.175531303262, 6131.325554189036, 6134.5399095067605, 6141.0, 6144.96927515364, 6150.2927163376335, 5665.178549110356, 5701.600887937888, 5709.343425506078, 5714.028615135396, 5716.971415142939, 6105.725242364104, 6229.314775374705, 6247.437730604177, 6261.342559031327, 6371.904421433682, 6054.424829641177, 6086.969565152146, 6092.786752463731, 6121.246617337161, 6129.295131059986, 6160.845978850564, 6196.194494715658, 6219.720112594944, 6226.40849119342, 6235.345288744707, 6007.759689612454, 6089.786857459968, 6133.57950150939, 6143.447089761943, 6233.532485063638, 6220.782272620437, 6282.057691346335, 6289.496840252768, 6290.370962903673, 6292.559520833498, 4650.511696271843, 4666.719996800203, 4672.112298663243, 4689.038747056845, 4706.694064885772, 4112.342025276002, 4149.668026557929, 4151.107511884959, 4209.642180414699, 4257.787110644455, 5880.206172166788, 5994.550408719277, 5998.940010599926, 6016.368281330485, 6017.488513476316, 6256.624602523863, 6257.68711564429, 6263.530235232376, 6283.7800676976085, 6290.402411770874, 5794.1308803679785, 5922.644641321534, 6015.969920150371, 6029.939700602938, 6095.359987201368, 5398.91901621476, 5414.891702166014, 5421.457854214547, 5439.564834813205, 5446.046941785172, 6212.782552610637, 6462.0, 6488.0, 6521.413072823469, 6529.249136349285, 6149.938500614937, 6171.352008039091, 6191.19514463117, 6299.496040316672, 6300.9684951574945, 6448.484121270381, 6471.676416179266, 6477.963525835844, 6497.220333560003, 6532.41208291256, 5925.762969481345, 6165.876682466236, 6170.81487555374, 6172.567920245539, 6177.660228687286, 6127.036821038878, 6132.601380910227, 6155.692215389123, 6266.717997690023, 6270.7805226816845, 6053.334133245427, 6098.115773212948, 6099.451049405575, 6104.938950610437, 6126.417990290915, 5934.495567876779, 6051.818445446644, 6082.574219804748, 6094.664793436404, 6123.14276001369, 5963.73163207648, 6021.036634138517, 6025.849353766191, 6083.543734219863, 6132.294786099477, 6047.0, 6112.938870611415, 6119.816405507842, 6145.262568491809, 6151.477124444473, 5756.395578464369, 5958.880822383441, 5966.403359663999, 5968.194293770285, 6003.039513677965], "value": 5725.302108682601, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.3699604427219, 597.5488506177835, 634.1850721822459, 668.8428219368448, 702.2380716922139, 41593.79203103984, 47002.059958800804, 47156.52843471564, 47165.52834471663, 47193.76403117984, 47733.284000740015, 47991.28013079806, 48294.75852620732, 48335.758321208436, 48340.75829620847, 9139.817203655939, 9222.0, 9225.077492250788, 9248.722538323827, 9248.815023699522, 9180.495072771027, 9252.167304942554, 9270.814583708321, 9277.95361023194, 9285.675001374953, 9293.72118836436, 9314.347995640273, 9362.531873406337, 9366.672166474174, 9382.0, 9248.861267080965, 9277.211437027861, 9297.070292970717, 9298.349115561914, 9299.163075323186, 9220.953895230548, 9295.395799273025, 9297.209737172348, 9300.953495232548, 9323.06769323069, 44581.33128003083, 44856.775716121534, 45162.54837451616, 45230.77384613089, 45456.09087818225, 4085.8774236772942, 4196.202721482909, 4200.243956087903, 4261.659067274611, 4452.777361131931, 35609.28781424357, 36023.27953440943, 36201.0, 36335.63664363349, 37738.81130594357, 4452.866414007585, 4519.683622146451, 4523.117991991563, 4560.22476179047, 4560.315952607102, 402639.0, 404316.99999999703, 404850.0, 406757.0, 407989.0, 67362.0, 67732.32267677359, 67828.6608566954, 67894.32105678979, 67948.0, 41135.38296925549, 41555.58444415578, 41764.791176044535, 43822.34266486005, 44204.77897610491, 20450.0, 20670.689939650918, 20670.689939650918, 20696.896515517627, 20706.171753129707, 15608.453704120302, 15733.370665173494, 15749.13379764101, 15801.0, 15829.129397883227, 21718.891405542872, 21724.131034758433, 21838.23566175176, 21974.45063873384, 22042.559148816934, 7533.660985255677, 7555.433342499335, 7746.535207887545, 7764.417668674872, 7782.416318776114, 1020.5764607687875, 1070.4059247117925, 1079.6760971708457, 1094.1301665176204, 1121.1087185687397, 34608.65391346105, 34716.0, 34971.65028349735, 35090.298194035975, 35573.644263557035, 1184.1947475716595, 1193.1945936492832, 1208.6253261488966, 1208.64949164743, 1218.6405010521917, 18109.818901811075, 18210.18054187565, 18279.451616451526, 18350.724739128924, 18360.632787344177, 663881.0, 666621.0, 667947.0, 671869.0, 672422.0, 65668.34331656623, 66200.66899665471, 66261.33738662647, 66390.33609663938, 66554.0, 1451.9491817786115, 1458.0886945658963, 1469.3167677030233, 1476.6603681153395, 1502.6318551954623, 33305.83347083249, 33829.83085084559, 34097.48853767146, 34155.316893662486, 34314.31371372509, 57295.42704572901, 57451.71274143602, 57885.0, 58088.0, 58138.4186158133, 540810.0, 544982.0, 545227.0, 545518.0, 546248.0, 31846.0, 31884.0, 32061.519077213394, 32352.191195219366, 32477.18807029843, 53395.0, 53537.85848566014, 53941.73029134829, 54490.72754636202, 55404.44595553993, 44338.55661443473, 45800.54199457963, 45881.77059114817, 46619.30071048869, 47695.76152119217, 45625.31562026506, 45754.31368529541, 46656.30015549702, 46854.53145468638, 47066.76466617645, 44413.77793111143, 44439.11121777611, 44479.0, 44663.0, 45056.77471612621, 38167.61832381641, 39898.601013989486, 40109.79945100256, 40847.38728919128, 41152.38271425871, 30784.38431231318, 30814.845925771126, 30896.227594310323, 30938.690613093582, 31490.685093148775], "value": 22050.912584639515, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.3385184482595, 427.06472824514316, 433.3110354536287, 434.58280051150894, 439.94500687414063, 19499.902500487497, 21430.46423839403, 21578.244761433354, 21659.241926532573, 22243.666345004836, 20372.69440958383, 20978.265760698378, 21154.471138221554, 21318.680219796715, 21375.67936480954, 5880.7059647017695, 6063.211782468273, 6071.666058366788, 6071.908921366183, 6085.604435711687, 5987.161797348374, 5998.40015998401, 6080.635161890301, 6090.756369745205, 6135.447809697126, 5907.497862681677, 6060.4848587869865, 6062.605930614518, 6065.666388348639, 6075.362086980869, 5960.403959604048, 5998.910016349758, 6004.009338459149, 6006.369331220203, 6016.578839481238, 5187.636865419422, 5352.464753524655, 5362.410134885159, 5417.295751552312, 5422.75597598109, 17934.641307173915, 17961.820381796144, 21650.783492165036, 25595.232143035737, 25742.356441088934, 2642.9471410571873, 2736.4253506763603, 2788.6653601567737, 2993.730564249228, 3324.7007769300635, 9823.36148150368, 10176.440295783728, 10221.79556408875, 15727.213639318103, 15899.443519476763, 2037.7656569494402, 2042.8467864910192, 2056.1158701758236, 2139.882306473143, 2153.536989547239, 90828.54585727095, 92253.07746922511, 92328.61507077467, 92790.07209927881, 93165.5341723287, 11775.293482391084, 11863.940680296544, 11869.287842729464, 11883.643490695293, 12057.879421205676, 17264.827351726573, 17265.56836079083, 17278.827211727723, 17295.481135565955, 17312.653746925243, 8970.0, 9056.773580660536, 9117.635294588143, 9154.176124148726, 9545.379550329206, 9110.772230694152, 9157.084291570789, 9187.816243675223, 9202.355835091614, 9347.719568412958, 5178.61160412963, 5219.608529360313, 5225.0, 5272.868178295574, 5362.624616276901, 2070.6479898417306, 2148.8280937525274, 2183.0, 2211.535577528737, 2230.8215342772537, 488.4236600811006, 508.9923651145236, 971.562796741455, 1050.3277902142636, 1088.2098947231918, 12329.753404931851, 13068.346582670829, 13213.405396757169, 13225.735485290434, 13239.139455935527, 518.9232342888521, 521.2520033751579, 524.3943245551394, 524.4414698346249, 531.2376739379004, 11170.27393219438, 12008.519659213534, 12060.698482538006, 12231.775700934579, 12363.93818030904, 550443.0, 561399.0, 562253.0, 566868.0, 570277.0, 99479.0, 100271.49864250633, 106382.0, 109143.0, 110705.0, 1052.3633201912885, 1074.4198133008088, 1093.8960798724108, 1108.2353176308322, 1109.378747901178, 18102.5474363142, 18320.816791831912, 18642.44072677822, 18684.159212835726, 18993.0, 44845.775771120934, 45501.0, 45972.310415344466, 46826.53173468222, 47442.0, 63905.0, 64512.35487645251, 64927.35072649402, 65469.0, 68325.65837170782, 7731.536107833548, 8462.492250464991, 8636.568171591522, 8783.429077109968, 9158.633654653739, 10523.473826308807, 14073.296335183404, 14115.929420352833, 14398.136111833324, 14646.0, 11964.700882478008, 11966.0, 12082.939585302369, 12126.211796233216, 12309.322987235788, 11605.187636865337, 12089.69775755578, 12127.543650060043, 12269.8960564946, 12518.248905065726, 12015.939920300343, 12124.454399552218, 12639.810402844148, 12853.7642101915, 12904.0, 7936.087349954829, 8477.506064968671, 8566.657333706582, 8701.912980870111, 8716.477011379338, 9145.542722863964, 11001.179268853362, 12039.518419263131, 12205.938970305448, 12883.742325153256], "value": 9566.66818349316, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1540.645651500155, 1542.637480192155, 1721.4061148903625, 1809.8461630761385, 1854.9258029678813, 7443.8883416748795, 8281.66873325067, 8287.17128287171, 8913.331500137483, 8922.152395522431, 8427.115152908947, 8670.263027642643, 8674.392792504526, 8675.045744968049, 8675.392722509427, 2363.2083252110565, 2401.9639705404347, 2411.144043864429, 2414.879256037191, 2417.8186636002283, 2364.893579788905, 2376.7266764322153, 2424.151546958568, 2427.0291883246664, 2428.2108314797674, 2359.539889721505, 2370.419247284418, 2380.6071998120287, 2384.1655420602824, 2392.1627430399394, 2338.754430784777, 2344.577975964334, 2346.5658853112145, 2354.423166324253, 2370.0638247892157, 2307.746147923727, 2312.1329501436962, 2321.141177764221, 2328.452813588822, 2330.778576035291, 8599.527026013568, 8662.393632445732, 8680.218780309802, 8681.34889883255, 8708.521031343274, 5240.8689782755355, 5262.342207224097, 5274.10340242156, 5292.253556326403, 5393.7303134843105, 3372.089535825338, 3372.1906742381652, 3374.105861946586, 3407.488876668495, 3412.77816941898, 1020.8315627921384, 1042.3836171210316, 2224.5328481019005, 2273.476441150322, 2285.0859656137513, 11604.767904641943, 11656.533738650443, 11710.590129345517, 11727.237729547553, 11732.824007639892, 4399.340098985178, 4431.667624928144, 4606.239970404913, 4639.443266808004, 4677.602403795648, 9503.097205765442, 9511.286653501014, 9518.857217141749, 9540.093691099335, 9557.569909354095, 5294.735263236823, 5346.037713211582, 5348.545373643284, 5349.358077030781, 5361.490658387525, 4902.338184345139, 5032.32063671407, 5061.013102444987, 5082.466341034138, 5107.923381149286, 3924.0, 3984.86052988144, 4013.5986401359633, 4064.6545043671617, 4081.2041651878194, 1113.5991043224433, 1131.5247596009697, 1140.6977151054978, 1160.1241062997383, 1161.5353858456685, 896.3367108339781, 962.0571839597094, 1029.4543891737392, 1041.9270651054505, 1046.8482070099792, 5773.336066352424, 5858.033424484997, 5917.142014407973, 5936.584439089309, 5994.910076348859, 464.73974574238537, 466.1865045495564, 470.7011047984486, 478.1966296621709, 481.407868321959, 4369.08249267651, 4373.0, 4418.085264777421, 4430.955690443055, 4523.7285762854335, 10032.297739158335, 10278.588856445807, 10514.106300964351, 10515.316504427188, 10531.789364212826, 10459.633912813015, 10463.68608941733, 10465.633702820365, 10496.26526143178, 10508.054275115277, 7730.497517661334, 8014.278714915686, 8049.758507244792, 8056.073551541531, 8205.79485512867, 6066.241719785027, 6185.226846644169, 6291.370862913672, 6302.3067462578165, 6397.168368112302, 9538.523073846418, 9830.311878168459, 9855.802883942424, 9921.156701680438, 9930.702078937355, 10043.949780251052, 10115.544800483849, 10124.645637402655, 10169.67794186751, 10169.84745228837, 7584.54492730438, 8081.313088387553, 8265.0, 8367.372447066373, 8507.489550626982, 8591.65633374658, 8601.698940537051, 8616.612252448529, 8637.179467950535, 8682.609282582425, 7508.2867127622785, 7546.924530754842, 7603.885941710768, 7645.961770191114, 7743.7676869694, 7330.266973302627, 7342.0, 7357.5217610855125, 7361.4110871129105, 7480.70077196906, 7122.679479423542, 7216.0, 7220.783376498714, 7225.060742103493, 7229.0, 5367.597430192829, 5425.186222066722, 5435.782568697208, 5437.728113594384, 5633.718314084197, 5345.305110335631, 5425.565954723534, 5466.945330546644, 5513.972430137824, 5541.224228608079], "value": 4626.07909960776, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.2405328543631, 359.9586047604525, 361.83898165316435, 364.3532729405307, 368.4160605440377, 5679.233303504026, 5784.739686714098, 5846.830633873226, 5861.560382971278, 5864.618799778023, 5733.455321744438, 5764.827055188351, 5803.709814509279, 5815.912761308584, 5830.883382332361, 4492.168948744476, 4493.775311234425, 4518.5481451854885, 4518.683692141552, 4526.932096018546, 4299.226139294926, 4472.44094488189, 4489.3939318192115, 4509.286471140962, 4512.59386655201, 4470.441194850644, 4472.709273897186, 4476.418065651461, 4476.709013914102, 4478.843240486583, 4479.969606990394, 4492.326151077365, 4492.460904691442, 4502.469160485451, 4518.1415531049, 3795.772253664789, 3918.1380096378753, 3969.1069509360163, 3976.840926362942, 3989.920201595981, 5652.293463317085, 5654.4062873398525, 5657.717114144318, 5666.291713535808, 5666.971665141689, 5129.384473863161, 5141.897162056738, 5143.151380022329, 5151.845444636667, 5185.948140518584, 5856.740800727864, 5931.763766959332, 5959.880802383971, 6017.729202185912, 6033.456988870978, 4279.288284686119, 4289.185054839601, 4295.763732994684, 4297.892552686177, 4305.547917468652, 6218.689065546704, 6271.435570798604, 6272.56092073555, 6292.811215663537, 6317.210348706411, 4357.54245804186, 4415.094905544356, 4453.240969816904, 4461.866144015685, 4477.485089214782, 4502.459704835441, 4506.6169375602785, 4510.932336014962, 4511.887202819956, 4514.774261286922, 5099.546629210658, 5109.259157422227, 5125.0, 5133.948660513422, 5183.2743415921805, 5880.8235752927485, 5963.612365196248, 6061.515078793686, 6075.574709770273, 6077.453029227391, 1533.4326299269342, 1560.7034663413915, 1564.2335255724613, 1567.1537369820398, 1567.6204939653032, 941.924646028316, 971.6987733802403, 971.9076687714655, 992.0179022767409, 995.1193194023341, 5141.562967147835, 5181.559567436735, 5186.247994040843, 5229.790808367623, 5262.315898933114, 5422.2919780269085, 5465.6447330923365, 5481.451854814487, 5487.314085739283, 5494.450554944474, 5025.150729546006, 5100.846974590768, 5218.817341393033, 5223.242629818731, 5229.848599129854, 2935.66239882412, 2947.911562653124, 2949.8967536136133, 2952.818872451037, 2956.216602600313, 5567.4432556744005, 5615.950178184933, 5621.353544342372, 5655.802046928337, 5683.744231509592, 5208.8437346879655, 5531.446855314517, 5546.91679624806, 5551.333839939152, 5556.499745068809, 5600.823826996295, 5608.69152196625, 5609.382967873531, 5628.185907046477, 5647.237622920853, 5080.923786143137, 5438.510534051954, 5459.645123066988, 5462.863428414322, 5478.602956246291, 5360.70516121617, 5374.140137578125, 5396.1366181410785, 5414.3232095988005, 5431.849527274093, 5584.441555844383, 5617.831465056055, 5626.0, 5649.519790817662, 5654.519365853784, 3963.3262345401927, 4014.8394064238273, 4207.852725154605, 4400.955990440183, 4445.2887537993765, 6146.692665366803, 6224.346443623535, 6225.315215326401, 6241.719122639583, 6249.812505624838, 6126.6017708848785, 6140.754369825157, 6143.109249158936, 6154.476869466145, 6170.691465426621, 6026.15633811258, 6173.506119510339, 6176.610262690859, 6178.196834411498, 6187.907181392373, 6088.0, 6124.418180272867, 6130.570860039755, 6131.448169664752, 6144.095330447575, 6173.59871608344, 6184.474319682878, 6184.81445556634, 6187.381261873777, 6200.441960223601, 5922.822315330547, 6009.248843894513, 6016.819495415145, 6029.397060294111, 6052.671030932881], "value": 4458.1287810138165, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [807.5518087461456, 836.3142223376833, 850.124371896946, 870.2950610005896, 891.8795962545056, 16357.345706171769, 16510.422135225268, 16885.91557042213, 16920.576985575368, 17670.558236044104, 16084.276207570658, 16198.919005404956, 16217.675646487092, 16240.593985150377, 16274.51176464705, 870.2081106193365, 884.5488800711652, 900.1763386501343, 901.5987885391004, 902.4089221559889, 891.5319457284912, 892.3218354050903, 892.6340200517789, 894.2890402130322, 894.825509025737, 957.0764212534903, 958.2238386906594, 958.3914214473824, 959.0170075672456, 961.3654987708114, 951.6050838901882, 954.9904500954971, 955.073578628729, 956.8516879883629, 957.2294303086013, 696.8188271049513, 699.5872435263168, 701.2146396036421, 702.4275215699189, 702.9578225306498, 15966.521004369888, 16050.438234661848, 16055.759163612554, 16074.839251607567, 16240.593985150348, 14852.331645075998, 15032.323545440482, 15044.0, 15217.923910380377, 15217.923910380488, 13400.798988015187, 13404.262765547892, 13482.05625606208, 13508.527201547997, 13867.514636987758, 4130.173965206941, 4134.235166494178, 4156.397322388237, 4177.937330940038, 4246.511651160125, 69316.6534167336, 93715.0, 93974.53012734962, 93984.53007734986, 95733.0, 12397.194182378116, 12658.430370633343, 12703.237805731686, 12842.357882105858, 13119.737605247841, 22007.0, 22025.559488810453, 22076.2273320433, 22100.88949555242, 22143.224987125373, 8766.60550275239, 8803.603837827313, 8881.689140880038, 9151.908480915106, 9198.540072996324, 5345.251664766935, 5371.75827087782, 5448.37343705471, 5499.340079190522, 5529.723513824292, 3486.511888335635, 3635.4365073413665, 3645.2527231917393, 3652.36083685354, 3678.9080272993388, 611.1230384398402, 616.3374372549528, 617.1144407774857, 626.2766504687094, 638.4987784589168, 679.7247114918466, 694.989575156373, 775.7207405334075, 786.5516655506307, 793.2583034862422, 10042.849357259647, 10546.103581195684, 10761.623343183108, 10801.945990269998, 10807.243492955418, 700.2962023166787, 748.6892939430076, 758.9582572958541, 768.4198430185286, 792.3542313014874, 4916.410030796327, 5194.558462530727, 5271.655727789389, 5290.391604965402, 5306.442823503554, 125415.0, 130436.0, 133155.33422332827, 133747.0, 135173.32413337872, 114415.42792286152, 116021.0, 116153.0, 119994.0, 120699.0, 100754.0, 102106.4894675522, 102424.0, 103487.0, 105106.47446762717, 9500.097490738368, 9541.284403669892, 9632.75918102053, 9728.75678108053, 9741.123298903132, 59528.0, 59673.40326596679, 60066.39933600608, 61276.38723612885, 61533.0, 80593.19406805857, 83795.0, 88008.5599571998, 88088.0, 92141.5392923031, 12281.508739650313, 14224.502142424966, 14251.857481425053, 14314.785278221043, 15379.923100384427, 16255.756163657317, 16745.246463909396, 16896.493105206864, 17051.744223836406, 18048.368307109187, 15011.474598389004, 15191.544253672408, 15193.6201594961, 15343.923280383528, 17033.14834258257, 13642.181469111885, 13695.246761428218, 14348.139111653334, 14646.487372941896, 15910.351825101921, 15098.169600672069, 15355.61610959735, 15373.692526149638, 15384.153871537173, 15897.947975435434, 11387.886121139014, 11611.767764644828, 11819.290842549475, 11861.76276474483, 12375.133740638068, 12158.934861782765, 12456.12807103494, 12746.49014039428, 12908.483660653845, 13005.349732513147], "value": 8329.663095779664, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1502.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 114.0, 109.0, 111.0, 117.0, 113.0, 113.0, 112.0, 115.0, 112.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 121.0, 142.0, 164.0, 119.0, 145.0, 145.0, 123.0, 172.0, 118.0], "value": 139.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 161.0, 162.0, 163.0, 163.0, 162.0, 161.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 172.0, 76.0, 74.0, 75.0, 75.0, 166.0, 76.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 143.0, 83.0, 83.0, 84.0, 141.0, 84.0, 83.0, 135.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, 119.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 151.0, 148.0, 147.0, 146.0, 147.0, 148.0, 147.0, 149.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 51.0, 51.0, 50.0, 51.0, 51.0, 52.0, 51.0, 61.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 63.0, 60.0, 60.0, 59.0, 60.0, 61.0, 59.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 72.0, 73.0, 81.0, 72.0, 73.0, 74.0, 80.0, 79.0, 82.0], "value": 76.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 134.0, 125.0, 120.0, 134.0, 124.0, 122.0, 138.0, 148.0, 126.0], "value": 130.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 160.0, 154.0, 151.0, 154.0, 152.0, 152.0, 157.0, 152.0, 150.0], "value": 153.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 64.0, 61.0, 62.0, 61.0, 60.0, 63.0, 63.0, 61.0], "value": 61.9, "unit": "score"}]}]} 09:56:58 INFO - Return code: 0 09:56:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:56:58 ERROR - # TBPL SUCCESS # 09:56:58 INFO - Running post-action listener: _resource_record_post_action 09:56:58 INFO - [mozharness: 2016-10-04 16:56:58.420968Z] Finished run-tests step (success) 09:56:58 INFO - Running post-run listener: _resource_record_post_run 09:56:58 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 16384; Write bytes: 287944704; Read time: 400; Write time: 208752 09:56:58 INFO - TinderboxPrint: CPU usage
13.3% 09:56:58 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 400 09:56:58 INFO - TinderboxPrint: I/O write bytes / time
287,944,704 / 208,752 09:56:58 INFO - TinderboxPrint: CPU idle
8,207.8 (86.7%) 09:56:58 INFO - TinderboxPrint: CPU user
1,198.2 (12.7%) 09:56:58 INFO - TinderboxPrint: Swap in / out
0 / 0 09:56:58 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 4096; Write bytes: 70082560; Read time: 252; Write time: 77160 09:56:58 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 12288; Write bytes: 217862144; Read time: 148; Write time: 131592 09:56:59 INFO - Running post-run listener: _upload_blobber_files 09:56:59 INFO - Blob upload gear active. 09:56:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:56:59 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 09:56:59 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:56:59 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:56:59 INFO - (blobuploader) - INFO - Open directory for files ... 09:56:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:56:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:56:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:57:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:57:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:57:00 INFO - (blobuploader) - INFO - Done attempting. 09:57:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:57:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:57:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:57:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:57:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:57:03 INFO - (blobuploader) - INFO - Done attempting. 09:57:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:57:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:57:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:57:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:57:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:57:04 INFO - (blobuploader) - INFO - Done attempting. 09:57:04 INFO - (blobuploader) - INFO - Iteration through files over. 09:57:04 INFO - Return code: 0 09:57:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:57:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:57:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4de4567a31b148f777af42488fd1eeb2e170b2287a99268214641cc972638861e6594a72890715fefa021841fd56bb811113b674de5c063389fc8230ad450925", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ad2d006c5d3892fbc9c67e56cff21b88eb149102f8d384eb11c3ebe9d2b86c6e8b74c9ff44b8bf7b3db1e6bff6161de2984a7738fdb0d84431d140b9de895f93", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/25bc5265fe92fc86907f03205450a8bff7bd0168cc880e72edcd6604eeabfaf45798052059a6be0f8fdbc37429bf4bcba256eb2b248f5fc8d0daf0ee43a0310c"} 09:57:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:57:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:57:04 INFO - Contents: 09:57:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4de4567a31b148f777af42488fd1eeb2e170b2287a99268214641cc972638861e6594a72890715fefa021841fd56bb811113b674de5c063389fc8230ad450925", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ad2d006c5d3892fbc9c67e56cff21b88eb149102f8d384eb11c3ebe9d2b86c6e8b74c9ff44b8bf7b3db1e6bff6161de2984a7738fdb0d84431d140b9de895f93", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/25bc5265fe92fc86907f03205450a8bff7bd0168cc880e72edcd6604eeabfaf45798052059a6be0f8fdbc37429bf4bcba256eb2b248f5fc8d0daf0ee43a0310c"} 09:57:04 INFO - Running post-run listener: copy_logs_to_upload_dir 09:57:04 INFO - Copying logs to upload dir... 09:57:04 INFO - mkdir: /builds/slave/test/build/upload/logs 09:57:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1673.930918 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 53 secs) (at 2016-10-04 09:57:03.489440) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 09:57:03.493022) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1475598549.110116-1000168975 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-Beta/sha512/4de4567a31b148f777af42488fd1eeb2e170b2287a99268214641cc972638861e6594a72890715fefa021841fd56bb811113b674de5c063389fc8230ad450925", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ad2d006c5d3892fbc9c67e56cff21b88eb149102f8d384eb11c3ebe9d2b86c6e8b74c9ff44b8bf7b3db1e6bff6161de2984a7738fdb0d84431d140b9de895f93", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/25bc5265fe92fc86907f03205450a8bff7bd0168cc880e72edcd6604eeabfaf45798052059a6be0f8fdbc37429bf4bcba256eb2b248f5fc8d0daf0ee43a0310c"} build_url:https://queue.taskcluster.net/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011540 build_url: 'https://queue.taskcluster.net/v1/task/A6LewDVcT_iYZtjb9ORMtg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4de4567a31b148f777af42488fd1eeb2e170b2287a99268214641cc972638861e6594a72890715fefa021841fd56bb811113b674de5c063389fc8230ad450925", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ad2d006c5d3892fbc9c67e56cff21b88eb149102f8d384eb11c3ebe9d2b86c6e8b74c9ff44b8bf7b3db1e6bff6161de2984a7738fdb0d84431d140b9de895f93", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/25bc5265fe92fc86907f03205450a8bff7bd0168cc880e72edcd6604eeabfaf45798052059a6be0f8fdbc37429bf4bcba256eb2b248f5fc8d0daf0ee43a0310c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 09:57:03.517351) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 09:57:03.517647) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1475598549.110116-1000168975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 09:57:03.602337) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 09:57:03.602649) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 09:57:03.602925) ========= ========= Total master_lag: 0.16 =========