builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-012 starttime: 1471489250.87 results: success (0) buildid: 20160817183215 builduid: ce6a5fe45e0647c4a65872a36180b8f5 revision: c43cb7e9ce93af133fe4eaee82699b1889d206d2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-17 20:00:50.867049) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-17 20:00:50.867626) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-17 20:00:50.867898) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-17 20:00:50.889458) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 20:00:50.889728) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1471483947.400992-1892230635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-17 20:00:50-- 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% 68.9M=0s 2016-08-17 20:00:51 (68.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125073 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 20:00:51.028734) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 20:00:51.029026) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1471483947.400992-1892230635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013886 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 20:00:51.079012) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 20:00:51.079527) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c43cb7e9ce93af133fe4eaee82699b1889d206d2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c43cb7e9ce93af133fe4eaee82699b1889d206d2 --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=2c5dd2b0a310ecf02fd87158000001b4-1471483947.400992-1892230635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-17 20:00:51,184 truncating revision to first 12 chars 2016-08-17 20:00:51,184 Setting DEBUG logging. 2016-08-17 20:00:51,184 attempt 1/10 2016-08-17 20:00:51,184 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c43cb7e9ce93?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-17 20:00:51,536 unpacking tar archive at: mozilla-aurora-c43cb7e9ce93/testing/mozharness/ program finished with exit code 0 elapsedTime=0.725276 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 20:00:51.820717) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-17 20:00:51.821169) ========= script_repo_revision: c43cb7e9ce93af133fe4eaee82699b1889d206d2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-17 20:00:51.821710) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-17 20:00:51.822110) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-17 20:00:51.833527) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 54 secs) (at 2016-08-17 20:00:51.834105) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1471483947.400992-1892230635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:00:52 INFO - MultiFileLogger online at 20160817 20:00:52 in /builds/slave/test 20:00:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 20:00:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:00:52 INFO - {'append_to_log': False, 20:00:52 INFO - 'base_work_dir': '/builds/slave/test', 20:00:52 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 20:00:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:00:52 INFO - 'branch': 'Mozilla-Aurora', 20:00:52 INFO - 'buildbot_json_path': 'buildprops.json', 20:00:52 INFO - 'config_files': ('talos/linux_config.py',), 20:00:52 INFO - 'default_actions': ('clobber', 20:00:52 INFO - 'read-buildbot-config', 20:00:52 INFO - 'download-and-extract', 20:00:52 INFO - 'populate-webroot', 20:00:52 INFO - 'create-virtualenv', 20:00:52 INFO - 'install', 20:00:52 INFO - 'run-tests'), 20:00:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:00:52 INFO - 'download_minidump_stackwalk': True, 20:00:52 INFO - 'download_symbols': 'ondemand', 20:00:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:00:52 INFO - 'tooltool.py': '/tools/tooltool.py', 20:00:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:00:52 INFO - '/tools/misc-python/virtualenv.py')}, 20:00:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:00:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:00:52 INFO - 'installer_path': 'installer.exe', 20:00:52 INFO - 'log_level': 'info', 20:00:52 INFO - 'log_name': 'talos', 20:00:52 INFO - 'log_to_console': True, 20:00:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:00:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:00:52 INFO - 'opt_config_files': (), 20:00:52 INFO - 'pip_index': False, 20:00:52 INFO - 'sps_profile': False, 20:00:52 INFO - 'sps_profile_interval': 0, 20:00:52 INFO - 'suite': 'dromaeojs-e10s', 20:00:52 INFO - 'system_bits': '32', 20:00:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:00:52 INFO - 'title': 'talos-linux64-ix-012', 20:00:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:00:52 INFO - 'use_talos_json': True, 20:00:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:00:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:00:52 INFO - 'work_dir': 'build'} 20:00:52 INFO - [mozharness: 2016-08-18 03:00:52.037254Z] Running clobber step. 20:00:52 INFO - Running pre-action listener: _resource_record_pre_action 20:00:52 INFO - Running main action method: clobber 20:00:52 INFO - rmtree: /builds/slave/test/build 20:00:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:00:52 INFO - Running post-action listener: _resource_record_post_action 20:00:52 INFO - [mozharness: 2016-08-18 03:00:52.994296Z] Finished clobber step (success) 20:00:52 INFO - [mozharness: 2016-08-18 03:00:52.994396Z] Running read-buildbot-config step. 20:00:52 INFO - Running pre-action listener: _resource_record_pre_action 20:00:52 INFO - Running main action method: read_buildbot_config 20:00:52 INFO - Using buildbot properties: 20:00:52 INFO - { 20:00:52 INFO - "project": "", 20:00:52 INFO - "product": "firefox", 20:00:52 INFO - "script_repo_revision": "production", 20:00:52 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 20:00:52 INFO - "repository": "", 20:00:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 20:00:52 INFO - "buildid": "20160817183215", 20:00:52 INFO - "pgo_build": "True", 20:00:52 INFO - "basedir": "/builds/slave/test", 20:00:52 INFO - "buildnumber": 478, 20:00:52 INFO - "slavename": "talos-linux64-ix-012", 20:00:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:00:52 INFO - "platform": "ubuntu64_hw", 20:00:52 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 20:00:52 INFO - "branch": "mozilla-aurora", 20:00:52 INFO - "repo_path": "releases/mozilla-aurora", 20:00:52 INFO - "revision": "c43cb7e9ce93af133fe4eaee82699b1889d206d2", 20:00:52 INFO - "stage_platform": "linux64-pgo", 20:00:52 INFO - "builduid": "ce6a5fe45e0647c4a65872a36180b8f5", 20:00:52 INFO - "slavebuilddir": "test" 20:00:52 INFO - } 20:00:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 20:00:52 INFO - Running post-action listener: _resource_record_post_action 20:00:52 INFO - [mozharness: 2016-08-18 03:00:52.996827Z] Finished read-buildbot-config step (success) 20:00:52 INFO - [mozharness: 2016-08-18 03:00:52.996917Z] Running download-and-extract step. 20:00:52 INFO - Running pre-action listener: _resource_record_pre_action 20:00:52 INFO - Running main action method: download_and_extract 20:00:52 INFO - mkdir: /builds/slave/test/build/tests 20:00: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')]} 20:00:52 INFO - https://queue.taskcluster.net/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:00:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 20:00:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 20:00:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 20:00:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:00:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 20:00:53 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 20:00:53 INFO - retry: Failed, sleeping 30 seconds before retrying 20:01:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #2 20:01:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 20:01:23 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 20:01:23 INFO - retry: Failed, sleeping 60 seconds before retrying 20:02:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #3 20:02:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 20:02:23 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 20:02:23 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json! 20:02:23 INFO - Caught exception: HTTP Error 404: Not Found 20:02:23 INFO - Caught exception: HTTP Error 404: Not Found 20:02:23 INFO - Caught exception: HTTP Error 404: Not Found 20:02:23 INFO - trying https://queue.taskcluster.net/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 20:02:23 INFO - Downloading https://queue.taskcluster.net/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 20:02:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:02:23 INFO - Downloaded 1361 bytes. 20:02:23 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 20:02:23 INFO - Using the following test package requirements: 20:02:23 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 20:02:23 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 20:02:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 20:02:23 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 20:02:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 20:02:23 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 20:02:23 INFO - u'jsshell-linux-x86_64.zip'], 20:02:23 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 20:02:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 20:02:23 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 20:02:23 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 20:02:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 20:02:23 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 20:02:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 20:02:23 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 20:02:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 20:02:23 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 20:02:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 20:02:23 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:02:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:23 INFO - https://queue.taskcluster.net/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:02:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:02:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:02:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:02:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:02:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:02:23 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 20:02:23 INFO - retry: Failed, sleeping 30 seconds before retrying 20:02:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 20:02:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:02:53 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 20:02:53 INFO - retry: Failed, sleeping 60 seconds before retrying 20:03:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 20:03:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:03:53 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 20:03:53 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 20:03:53 INFO - Caught exception: HTTP Error 404: Not Found 20:03:53 INFO - Caught exception: HTTP Error 404: Not Found 20:03:53 INFO - Caught exception: HTTP Error 404: Not Found 20:03:53 INFO - trying https://queue.taskcluster.net/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:03:53 INFO - Downloading https://queue.taskcluster.net/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:03:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:03:54 INFO - Downloaded 21767551 bytes. 20:03:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:03:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:03:55 INFO - Return code: 0 20:03:55 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:03: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')]} 20:03:55 INFO - https://queue.taskcluster.net/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:03:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:03:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:03:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:03:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:03:55 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:03:55 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 20:03:55 INFO - retry: Failed, sleeping 30 seconds before retrying 20:04:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 20:04:25 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:04:25 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 20:04:25 INFO - retry: Failed, sleeping 60 seconds before retrying 20:05:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 20:05:25 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:05:25 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 20:05:25 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 20:05:25 INFO - Caught exception: HTTP Error 404: Not Found 20:05:25 INFO - Caught exception: HTTP Error 404: Not Found 20:05:25 INFO - Caught exception: HTTP Error 404: Not Found 20:05:25 INFO - trying https://queue.taskcluster.net/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:05:25 INFO - Downloading https://queue.taskcluster.net/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:05:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:05:26 INFO - Downloaded 21767551 bytes. 20:05:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:05:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:05:28 INFO - Return code: 0 20:05:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:28 INFO - https://queue.taskcluster.net/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:05:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 20:05:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 20:05:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 20:05:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:05:28 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 20:05:28 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 20:05:28 INFO - retry: Failed, sleeping 30 seconds before retrying 20:05:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 20:05:58 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 20:05:58 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 20:05:58 INFO - retry: Failed, sleeping 60 seconds before retrying 20:06:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 20:06:58 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 20:06:58 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 20:06:58 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip! 20:06:58 INFO - Caught exception: HTTP Error 404: Not Found 20:06:58 INFO - Caught exception: HTTP Error 404: Not Found 20:06:58 INFO - Caught exception: HTTP Error 404: Not Found 20:06:58 INFO - trying https://queue.taskcluster.net/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 20:06:58 INFO - Downloading https://queue.taskcluster.net/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 20:06:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:06:59 INFO - Downloaded 14413723 bytes. 20:06:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:06:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:06:59 INFO - Return code: 0 20:06:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:59 INFO - https://queue.taskcluster.net/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:06:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 20:06:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 20:06:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 20:06:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:06:59 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 20:06:59 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 20:06:59 INFO - retry: Failed, sleeping 30 seconds before retrying 20:07:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #2 20:07:29 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 20:07:29 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 20:07:29 INFO - retry: Failed, sleeping 60 seconds before retrying 20:08:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #3 20:08:29 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 20:08:29 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 20:08:29 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2! 20:08:29 INFO - Caught exception: HTTP Error 404: Not Found 20:08:29 INFO - Caught exception: HTTP Error 404: Not Found 20:08:29 INFO - Caught exception: HTTP Error 404: Not Found 20:08:29 INFO - trying https://queue.taskcluster.net/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 20:08:29 INFO - Downloading https://queue.taskcluster.net/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 20:08:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:08:30 INFO - Downloaded 63753794 bytes. 20:08:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 20:08:30 INFO - mkdir: /builds/slave/test/properties 20:08:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:08:30 INFO - Writing to file /builds/slave/test/properties/build_url 20:08:30 INFO - Contents: 20:08:30 INFO - build_url:https://queue.taskcluster.net/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 20:08:31 INFO - Running post-action listener: _resource_record_post_action 20:08:31 INFO - Running post-action listener: set_extra_try_arguments 20:08:31 INFO - [mozharness: 2016-08-18 03:08:31.207952Z] Finished download-and-extract step (success) 20:08:31 INFO - [mozharness: 2016-08-18 03:08:31.208183Z] Running populate-webroot step. 20:08:31 INFO - Running pre-action listener: _resource_record_pre_action 20:08:31 INFO - Running main action method: populate_webroot 20:08:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:08:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:08:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:08:31 INFO - '--tppagecycles', 20:08:31 INFO - '7'], 20:08:31 INFO - 'tests': ['tsvgm']}}, 20:08:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:08:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:08:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:08:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:08:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:08:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:08:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:31 INFO - 'talos_options': ['--disable-e10s'], 20:08:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:08:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:08:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:31 INFO - 'talos_options': ['--disable-e10s'], 20:08:31 INFO - 'tests': ['damp', 'tps']}, 20:08:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:31 INFO - 'tests': ['damp', 'tps']}, 20:08:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:08:31 INFO - 'tests': ['dromaeo_dom']}, 20:08:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:08:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:08:31 INFO - 'tests': ['basic_compositor_video']}, 20:08:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:08:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:08:31 INFO - 'tests': ['a11yr', 20:08:31 INFO - 'ts_paint', 20:08:31 INFO - 'tpaint', 20:08:31 INFO - 'sessionrestore', 20:08:31 INFO - 'sessionrestore_no_auto_restore', 20:08:31 INFO - 'tabpaint']}, 20:08:31 INFO - 'other-e10s': {'tests': ['a11yr', 20:08:31 INFO - 'ts_paint', 20:08:31 INFO - 'tpaint', 20:08:31 INFO - 'sessionrestore', 20:08:31 INFO - 'sessionrestore_no_auto_restore', 20:08:31 INFO - 'tabpaint']}, 20:08:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:08:31 INFO - 'ts_paint', 20:08:31 INFO - 'tpaint', 20:08:31 INFO - 'sessionrestore', 20:08:31 INFO - 'sessionrestore_no_auto_restore', 20:08:31 INFO - 'tabpaint']}, 20:08:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:08:31 INFO - 'ts_paint', 20:08:31 INFO - 'tpaint', 20:08:31 INFO - 'sessionrestore', 20:08:31 INFO - 'sessionrestore_no_auto_restore', 20:08:31 INFO - 'tabpaint']}, 20:08:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:08:31 INFO - 'tests': ['a11yr', 20:08:31 INFO - 'ts_paint', 20:08:31 INFO - 'tpaint', 20:08:31 INFO - 'sessionrestore', 20:08:31 INFO - 'sessionrestore_no_auto_restore', 20:08:31 INFO - 'tabpaint']}, 20:08:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:08:31 INFO - 'tests': ['a11yr', 20:08:31 INFO - 'ts_paint', 20:08:31 INFO - 'tpaint', 20:08:31 INFO - 'sessionrestore', 20:08:31 INFO - 'sessionrestore_no_auto_restore', 20:08:31 INFO - 'tabpaint']}, 20:08:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:08:31 INFO - 'tests': ['tsvgx', 20:08:31 INFO - 'tsvgr_opacity', 20:08:31 INFO - 'tart', 20:08:31 INFO - 'tscrollx', 20:08:31 INFO - 'cart']}, 20:08:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:08:31 INFO - 'tsvgr_opacity', 20:08:31 INFO - 'tart', 20:08:31 INFO - 'tscrollx', 20:08:31 INFO - 'cart']}, 20:08:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:31 INFO - 'talos_options': ['--disable-e10s'], 20:08:31 INFO - 'tests': ['tp5o']}, 20:08:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:31 INFO - 'tests': ['tp5o']}, 20:08:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:31 INFO - 'talos_options': ['--disable-e10s', 20:08:31 INFO - '--xperf_path', 20:08:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:08:31 INFO - 'tests': ['tp5n']}, 20:08:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:31 INFO - 'talos_options': ['--xperf_path', 20:08:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:08:31 INFO - 'tests': ['tp5n']}}, 20:08:31 INFO - 'talos.zip': {'path': '', 20:08:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:08:31 INFO - Running post-action listener: _resource_record_post_action 20:08:31 INFO - [mozharness: 2016-08-18 03:08:31.227333Z] Finished populate-webroot step (success) 20:08:31 INFO - [mozharness: 2016-08-18 03:08:31.227421Z] Running create-virtualenv step. 20:08:31 INFO - Running pre-action listener: _resource_record_pre_action 20:08:31 INFO - Running main action method: create_virtualenv 20:08:31 INFO - Creating virtualenv /builds/slave/test/build/venv 20:08:31 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:08:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:08:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:08:31 INFO - Using real prefix '/usr' 20:08:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:08:31 INFO - Installing distribute.............................................................................................................................................................................................done. 20:08:33 INFO - Installing pip.................done. 20:08:33 INFO - Return code: 0 20:08:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:08:33 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')]} 20:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:33 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')]} 20:08:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:33 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 0x1867030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a96400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b25570>, '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 0x1b26470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b26900>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1471483947.400992-1892230635', '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 20:08:33 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 20:08:33 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 20:08:33 INFO - Using env: {'DISPLAY': ':0', 20:08:33 INFO - 'HOME': '/home/cltbld', 20:08:33 INFO - 'LANG': 'en_US.UTF-8', 20:08:33 INFO - 'LANGUAGE': 'en_US:en', 20:08:33 INFO - 'LOGNAME': 'cltbld', 20:08:33 INFO - 'MAIL': '/var/mail/cltbld', 20:08:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:33 INFO - 'MOZ_NO_REMOTE': '1', 20:08:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:08:33 INFO - 'NO_EM_RESTART': '1', 20:08:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:08:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:33 INFO - 'PWD': '/builds/slave/test', 20:08:33 INFO - 'SHELL': '/bin/bash', 20:08:33 INFO - 'SHLVL': '1', 20:08:33 INFO - 'TERM': 'linux', 20:08:33 INFO - 'TMOUT': '86400', 20:08:33 INFO - 'USER': 'cltbld', 20:08:33 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1471483947.400992-1892230635', 20:08:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:33 INFO - '_': '/tools/buildbot/bin/python'} 20:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:34 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:08:34 INFO - Cleaning up... 20:08:34 INFO - Return code: 0 20:08:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1867030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a96400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b25570>, '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 0x1b26470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b26900>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1471483947.400992-1892230635', '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 20:08:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:08:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:08:34 INFO - Using env: {'DISPLAY': ':0', 20:08:34 INFO - 'HOME': '/home/cltbld', 20:08:34 INFO - 'LANG': 'en_US.UTF-8', 20:08:34 INFO - 'LANGUAGE': 'en_US:en', 20:08:34 INFO - 'LOGNAME': 'cltbld', 20:08:34 INFO - 'MAIL': '/var/mail/cltbld', 20:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:34 INFO - 'MOZ_NO_REMOTE': '1', 20:08:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:08:34 INFO - 'NO_EM_RESTART': '1', 20:08:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:34 INFO - 'PWD': '/builds/slave/test', 20:08:34 INFO - 'SHELL': '/bin/bash', 20:08:34 INFO - 'SHLVL': '1', 20:08:34 INFO - 'TERM': 'linux', 20:08:34 INFO - 'TMOUT': '86400', 20:08:34 INFO - 'USER': 'cltbld', 20:08:34 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1471483947.400992-1892230635', 20:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:34 INFO - '_': '/tools/buildbot/bin/python'} 20:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:34 INFO - Downloading/unpacking psutil>=3.1.1 20:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:08:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:08:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:08:36 INFO - Installing collected packages: psutil 20:08:36 INFO - Running setup.py install for psutil 20:08:36 INFO - building 'psutil._psutil_linux' extension 20:08:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 20:08:36 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 20:08:36 INFO - building 'psutil._psutil_posix' extension 20:08:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 20:08:36 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 20:08:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:08:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:08:36 INFO - Successfully installed psutil 20:08:36 INFO - Cleaning up... 20:08:36 INFO - Return code: 0 20:08:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:08:36 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')]} 20:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:36 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')]} 20:08:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:36 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 0x1867030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a96400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b25570>, '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 0x1b26470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b26900>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1471483947.400992-1892230635', '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 20:08:36 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 20:08:36 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 20:08:36 INFO - Using env: {'DISPLAY': ':0', 20:08:36 INFO - 'HOME': '/home/cltbld', 20:08:36 INFO - 'LANG': 'en_US.UTF-8', 20:08:36 INFO - 'LANGUAGE': 'en_US:en', 20:08:36 INFO - 'LOGNAME': 'cltbld', 20:08:36 INFO - 'MAIL': '/var/mail/cltbld', 20:08:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:36 INFO - 'MOZ_NO_REMOTE': '1', 20:08:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:08:36 INFO - 'NO_EM_RESTART': '1', 20:08:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:08:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:36 INFO - 'PWD': '/builds/slave/test', 20:08:36 INFO - 'SHELL': '/bin/bash', 20:08:36 INFO - 'SHLVL': '1', 20:08:36 INFO - 'TERM': 'linux', 20:08:36 INFO - 'TMOUT': '86400', 20:08:36 INFO - 'USER': 'cltbld', 20:08:36 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1471483947.400992-1892230635', 20:08:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:36 INFO - '_': '/tools/buildbot/bin/python'} 20:08:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:08:36 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 20:08:36 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 20:08:36 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 20:08:36 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 20:08:36 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 20:08:36 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 20:08:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:08:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:08:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:08:38 INFO - Installing collected packages: mozsystemmonitor 20:08:38 INFO - Running setup.py install for mozsystemmonitor 20:08:39 INFO - Successfully installed mozsystemmonitor 20:08:39 INFO - Cleaning up... 20:08:39 INFO - Return code: 0 20:08:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1867030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a96400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b25570>, '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 0x1b26470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b26900>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1471483947.400992-1892230635', '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 20:08:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:08:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:08:39 INFO - Using env: {'DISPLAY': ':0', 20:08:39 INFO - 'HOME': '/home/cltbld', 20:08:39 INFO - 'LANG': 'en_US.UTF-8', 20:08:39 INFO - 'LANGUAGE': 'en_US:en', 20:08:39 INFO - 'LOGNAME': 'cltbld', 20:08:39 INFO - 'MAIL': '/var/mail/cltbld', 20:08:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:39 INFO - 'MOZ_NO_REMOTE': '1', 20:08:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:08:39 INFO - 'NO_EM_RESTART': '1', 20:08:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:08:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:39 INFO - 'PWD': '/builds/slave/test', 20:08:39 INFO - 'SHELL': '/bin/bash', 20:08:39 INFO - 'SHLVL': '1', 20:08:39 INFO - 'TERM': 'linux', 20:08:39 INFO - 'TMOUT': '86400', 20:08:39 INFO - 'USER': 'cltbld', 20:08:39 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1471483947.400992-1892230635', 20:08:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:39 INFO - '_': '/tools/buildbot/bin/python'} 20:08:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:39 INFO - Downloading/unpacking jsonschema==2.5.1 20:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:08:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:41 INFO - Downloading functools32-3.2.3-2.tar.gz 20:08:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:08:41 INFO - warning: no files found matching '*.txt' 20:08:41 INFO - no previously-included directories found matching 'build' 20:08:41 INFO - no previously-included directories found matching 'dist' 20:08:41 INFO - no previously-included directories found matching '.git*' 20:08:41 INFO - Installing collected packages: jsonschema, functools32 20:08:41 INFO - Running setup.py install for functools32 20:08:41 INFO - warning: no files found matching '*.txt' 20:08:41 INFO - no previously-included directories found matching 'build' 20:08:41 INFO - no previously-included directories found matching 'dist' 20:08:41 INFO - no previously-included directories found matching '.git*' 20:08:41 INFO - Successfully installed jsonschema functools32 20:08:41 INFO - Cleaning up... 20:08:41 INFO - Return code: 0 20:08:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:08:41 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')]} 20:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:41 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')]} 20:08:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:41 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 0x1867030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a96400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b25570>, '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 0x1b26470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b26900>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1471483947.400992-1892230635', '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 20:08:41 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 20:08:41 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 20:08:41 INFO - Using env: {'DISPLAY': ':0', 20:08:41 INFO - 'HOME': '/home/cltbld', 20:08:41 INFO - 'LANG': 'en_US.UTF-8', 20:08:41 INFO - 'LANGUAGE': 'en_US:en', 20:08:41 INFO - 'LOGNAME': 'cltbld', 20:08:41 INFO - 'MAIL': '/var/mail/cltbld', 20:08:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:41 INFO - 'MOZ_NO_REMOTE': '1', 20:08:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:08:41 INFO - 'NO_EM_RESTART': '1', 20:08:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:08:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:41 INFO - 'PWD': '/builds/slave/test', 20:08:41 INFO - 'SHELL': '/bin/bash', 20:08:41 INFO - 'SHLVL': '1', 20:08:41 INFO - 'TERM': 'linux', 20:08:41 INFO - 'TMOUT': '86400', 20:08:41 INFO - 'USER': 'cltbld', 20:08:41 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1471483947.400992-1892230635', 20:08:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:41 INFO - '_': '/tools/buildbot/bin/python'} 20:08:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:08:41 INFO - Cleaning up... 20:08:41 INFO - Return code: 0 20:08:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:08:41 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')]} 20:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:41 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')]} 20:08:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:41 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 0x1867030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a96400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b25570>, '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 0x1b26470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b26900>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1471483947.400992-1892230635', '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 20:08:41 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 20:08:41 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 20:08:41 INFO - Using env: {'DISPLAY': ':0', 20:08:41 INFO - 'HOME': '/home/cltbld', 20:08:41 INFO - 'LANG': 'en_US.UTF-8', 20:08:41 INFO - 'LANGUAGE': 'en_US:en', 20:08:41 INFO - 'LOGNAME': 'cltbld', 20:08:41 INFO - 'MAIL': '/var/mail/cltbld', 20:08:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:41 INFO - 'MOZ_NO_REMOTE': '1', 20:08:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:08:41 INFO - 'NO_EM_RESTART': '1', 20:08:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:08:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:41 INFO - 'PWD': '/builds/slave/test', 20:08:41 INFO - 'SHELL': '/bin/bash', 20:08:41 INFO - 'SHLVL': '1', 20:08:41 INFO - 'TERM': 'linux', 20:08:41 INFO - 'TMOUT': '86400', 20:08:41 INFO - 'USER': 'cltbld', 20:08:41 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1471483947.400992-1892230635', 20:08:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:41 INFO - '_': '/tools/buildbot/bin/python'} 20:08:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:42 INFO - Downloading/unpacking blobuploader==1.2.4 20:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:43 INFO - Downloading blobuploader-1.2.4.tar.gz 20:08:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:08:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:08:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:44 INFO - Downloading docopt-0.6.1.tar.gz 20:08:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:08:44 INFO - Installing collected packages: blobuploader, requests, docopt 20:08:44 INFO - Running setup.py install for blobuploader 20:08:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:08:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:08:44 INFO - Running setup.py install for requests 20:08:45 INFO - Running setup.py install for docopt 20:08:45 INFO - Successfully installed blobuploader requests docopt 20:08:45 INFO - Cleaning up... 20:08:45 INFO - Return code: 0 20:08:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1867030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a96400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b25570>, '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 0x1b26470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b26900>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1471483947.400992-1892230635', '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 20:08:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:08:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:08:45 INFO - Using env: {'DISPLAY': ':0', 20:08:45 INFO - 'HOME': '/home/cltbld', 20:08:45 INFO - 'LANG': 'en_US.UTF-8', 20:08:45 INFO - 'LANGUAGE': 'en_US:en', 20:08:45 INFO - 'LOGNAME': 'cltbld', 20:08:45 INFO - 'MAIL': '/var/mail/cltbld', 20:08:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:45 INFO - 'MOZ_NO_REMOTE': '1', 20:08:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:08:45 INFO - 'NO_EM_RESTART': '1', 20:08:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:08:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:45 INFO - 'PWD': '/builds/slave/test', 20:08:45 INFO - 'SHELL': '/bin/bash', 20:08:45 INFO - 'SHLVL': '1', 20:08:45 INFO - 'TERM': 'linux', 20:08:45 INFO - 'TMOUT': '86400', 20:08:45 INFO - 'USER': 'cltbld', 20:08:45 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1471483947.400992-1892230635', 20:08:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:45 INFO - '_': '/tools/buildbot/bin/python'} 20:08:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:08:45 INFO - Running setup.py (path:/tmp/pip-6MC9cT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:08:45 INFO - Running setup.py (path:/tmp/pip-czTOk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:08:45 INFO - Running setup.py (path:/tmp/pip-k281B6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:08:45 INFO - Running setup.py (path:/tmp/pip-CEjVrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:08:45 INFO - Running setup.py (path:/tmp/pip-lM6crx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:08:45 INFO - Running setup.py (path:/tmp/pip-9l29Jc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:08:45 INFO - Running setup.py (path:/tmp/pip-phkyXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:08:46 INFO - Running setup.py (path:/tmp/pip-i6xNMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:08:46 INFO - Running setup.py (path:/tmp/pip-Q97oIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:08:46 INFO - Running setup.py (path:/tmp/pip-OzzkSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:08:46 INFO - Running setup.py (path:/tmp/pip-cqHc0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:08:46 INFO - Running setup.py (path:/tmp/pip-hAP5LE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:08:46 INFO - Running setup.py (path:/tmp/pip-1J0Ya6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:08:46 INFO - Running setup.py (path:/tmp/pip-WGQiEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:08:46 INFO - Running setup.py (path:/tmp/pip-TlSoke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:08:46 INFO - Running setup.py (path:/tmp/pip-gcad1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:08:46 INFO - Running setup.py (path:/tmp/pip-HHPPjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:08:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:08:46 INFO - Running setup.py install for manifestparser 20:08:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:08:46 INFO - Running setup.py install for mozcrash 20:08:46 INFO - Running setup.py install for mozdebug 20:08:47 INFO - Running setup.py install for mozdevice 20:08:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:08:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:08:47 INFO - Running setup.py install for mozfile 20:08:47 INFO - Running setup.py install for mozhttpd 20:08:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:08:47 INFO - Running setup.py install for mozinfo 20:08:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:08:47 INFO - Running setup.py install for mozInstall 20:08:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:08:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:08:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:08:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:08:47 INFO - Running setup.py install for mozleak 20:08:47 INFO - Running setup.py install for mozlog 20:08:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:08:47 INFO - Running setup.py install for moznetwork 20:08:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:08:47 INFO - Running setup.py install for mozprocess 20:08:47 INFO - Running setup.py install for mozprofile 20:08:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:08:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:08:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:08:48 INFO - Running setup.py install for mozrunner 20:08:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:08:48 INFO - Running setup.py install for mozscreenshot 20:08:48 INFO - Running setup.py install for moztest 20:08:48 INFO - Running setup.py install for mozversion 20:08:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:08:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:08:48 INFO - Cleaning up... 20:08:48 INFO - Return code: 0 20:08:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:08:48 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')]} 20:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:48 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')]} 20:08:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:48 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 0x1867030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a96400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b25570>, '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 0x1b26470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b26900>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1471483947.400992-1892230635', '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 20:08:48 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 20:08:48 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 20:08:48 INFO - Using env: {'DISPLAY': ':0', 20:08:48 INFO - 'HOME': '/home/cltbld', 20:08:48 INFO - 'LANG': 'en_US.UTF-8', 20:08:48 INFO - 'LANGUAGE': 'en_US:en', 20:08:48 INFO - 'LOGNAME': 'cltbld', 20:08:48 INFO - 'MAIL': '/var/mail/cltbld', 20:08:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:48 INFO - 'MOZ_NO_REMOTE': '1', 20:08:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:08:48 INFO - 'NO_EM_RESTART': '1', 20:08:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:08:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:48 INFO - 'PWD': '/builds/slave/test', 20:08:48 INFO - 'SHELL': '/bin/bash', 20:08:48 INFO - 'SHLVL': '1', 20:08:48 INFO - 'TERM': 'linux', 20:08:48 INFO - 'TMOUT': '86400', 20:08:48 INFO - 'USER': 'cltbld', 20:08:48 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1471483947.400992-1892230635', 20:08:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:48 INFO - '_': '/tools/buildbot/bin/python'} 20:08:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:08:48 INFO - Running setup.py (path:/tmp/pip-SqOLHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:08:48 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)) 20:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:08:48 INFO - Running setup.py (path:/tmp/pip-gCKvHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:08:48 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)) 20:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:08:48 INFO - Running setup.py (path:/tmp/pip-LsTqxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:08:48 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)) 20:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:08:48 INFO - Running setup.py (path:/tmp/pip-DhzWWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:08:49 INFO - Running setup.py (path:/tmp/pip-9fgza7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 20:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:08:49 INFO - Running setup.py (path:/tmp/pip-HPgnnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:08:49 INFO - Running setup.py (path:/tmp/pip-vLrc3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 20:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:08:49 INFO - Running setup.py (path:/tmp/pip-NQU6nt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 20:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:08:49 INFO - Running setup.py (path:/tmp/pip-ov6nMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 20:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:08:49 INFO - Running setup.py (path:/tmp/pip-aI6gYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:08:49 INFO - Running setup.py (path:/tmp/pip-vbT3XF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:08:49 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)) 20:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:08:49 INFO - Running setup.py (path:/tmp/pip-1toukL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:08:49 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)) 20:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:08:49 INFO - Running setup.py (path:/tmp/pip-jB8o59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:08:49 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)) 20:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:08:49 INFO - Running setup.py (path:/tmp/pip-MfA1JB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:08:49 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)) 20:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:08:49 INFO - Running setup.py (path:/tmp/pip-jC1gNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:08:49 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)) 20:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:08:49 INFO - Running setup.py (path:/tmp/pip-5UParK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:08:49 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)) 20:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:08:49 INFO - Running setup.py (path:/tmp/pip-9eRfj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:08:49 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)) 20:08:49 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)) 20:08:49 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)) 20:08:49 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)) 20:08:49 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)) 20:08:49 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)) 20:08:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:51 INFO - Downloading blessings-1.6.tar.gz 20:08:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:08:51 INFO - Installing collected packages: blessings 20:08:51 INFO - Running setup.py install for blessings 20:08:52 INFO - Successfully installed blessings 20:08:52 INFO - Cleaning up... 20:08:52 INFO - Return code: 0 20:08:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:08:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:08:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:08:52 INFO - Reading from file tmpfile_stdout 20:08:52 INFO - Current package versions: 20:08:52 INFO - argparse == 1.2.1 20:08:52 INFO - blessings == 1.6 20:08:52 INFO - blobuploader == 1.2.4 20:08:52 INFO - docopt == 0.6.1 20:08:52 INFO - functools32 == 3.2.3-2 20:08:52 INFO - jsonschema == 2.5.1 20:08:52 INFO - manifestparser == 1.1 20:08:52 INFO - mozInstall == 1.12 20:08:52 INFO - mozcrash == 0.17 20:08:52 INFO - mozdebug == 0.1 20:08:52 INFO - mozdevice == 0.48 20:08:52 INFO - mozfile == 1.2 20:08:52 INFO - mozhttpd == 0.7 20:08:52 INFO - mozinfo == 0.9 20:08:52 INFO - mozleak == 0.1 20:08:52 INFO - mozlog == 3.3 20:08:52 INFO - moznetwork == 0.27 20:08:52 INFO - mozprocess == 0.23 20:08:52 INFO - mozprofile == 0.28 20:08:52 INFO - mozrunner == 6.12 20:08:52 INFO - mozscreenshot == 0.1 20:08:52 INFO - mozsystemmonitor == 0.3 20:08:52 INFO - moztest == 0.7 20:08:52 INFO - mozversion == 1.4 20:08:52 INFO - psutil == 3.1.1 20:08:52 INFO - requests == 1.2.3 20:08:52 INFO - wsgiref == 0.1.2 20:08:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:08: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')]} 20:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08: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')]} 20:08:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1867030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a96400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b25570>, '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 0x1b26470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b26900>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1471483947.400992-1892230635', '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 20:08:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 20:08:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:08:52 INFO - Using env: {'DISPLAY': ':0', 20:08:52 INFO - 'HOME': '/home/cltbld', 20:08:52 INFO - 'LANG': 'en_US.UTF-8', 20:08:52 INFO - 'LANGUAGE': 'en_US:en', 20:08:52 INFO - 'LOGNAME': 'cltbld', 20:08:52 INFO - 'MAIL': '/var/mail/cltbld', 20:08:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:52 INFO - 'MOZ_NO_REMOTE': '1', 20:08:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:08:52 INFO - 'NO_EM_RESTART': '1', 20:08:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:08:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:52 INFO - 'PWD': '/builds/slave/test', 20:08:52 INFO - 'SHELL': '/bin/bash', 20:08:52 INFO - 'SHLVL': '1', 20:08:52 INFO - 'TERM': 'linux', 20:08:52 INFO - 'TMOUT': '86400', 20:08:52 INFO - 'USER': 'cltbld', 20:08:52 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1471483947.400992-1892230635', 20:08:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:52 INFO - '_': '/tools/buildbot/bin/python'} 20:08:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:08:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 20:08:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:08:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:08:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 20:08:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 20:08:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:08:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:08:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 20:08:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:08:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:08:52 INFO - Cleaning up... 20:08:52 INFO - Return code: 0 20:08:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:08: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')]} 20:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08: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')]} 20:08:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1867030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a96400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b25570>, '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 0x1b26470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b26900>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1471483947.400992-1892230635', '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 20:08: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', 'jsonschema'] in /builds/slave/test/build 20:08: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 jsonschema 20:08:52 INFO - Using env: {'DISPLAY': ':0', 20:08:52 INFO - 'HOME': '/home/cltbld', 20:08:52 INFO - 'LANG': 'en_US.UTF-8', 20:08:52 INFO - 'LANGUAGE': 'en_US:en', 20:08:52 INFO - 'LOGNAME': 'cltbld', 20:08:52 INFO - 'MAIL': '/var/mail/cltbld', 20:08:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:52 INFO - 'MOZ_NO_REMOTE': '1', 20:08:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:08:52 INFO - 'NO_EM_RESTART': '1', 20:08:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:08:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:52 INFO - 'PWD': '/builds/slave/test', 20:08:52 INFO - 'SHELL': '/bin/bash', 20:08:52 INFO - 'SHLVL': '1', 20:08:52 INFO - 'TERM': 'linux', 20:08:52 INFO - 'TMOUT': '86400', 20:08:52 INFO - 'USER': 'cltbld', 20:08:52 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1471483947.400992-1892230635', 20:08:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:52 INFO - '_': '/tools/buildbot/bin/python'} 20:08:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:08:52 INFO - Cleaning up... 20:08:52 INFO - Return code: 0 20:08:52 INFO - Running post-action listener: _resource_record_post_action 20:08:52 INFO - Running post-action listener: _start_resource_monitoring 20:08:52 INFO - Starting resource monitoring. 20:08:52 INFO - [mozharness: 2016-08-18 03:08:52.800184Z] Finished create-virtualenv step (success) 20:08:52 INFO - [mozharness: 2016-08-18 03:08:52.800659Z] Running install step. 20:08:52 INFO - Running pre-action listener: _resource_record_pre_action 20:08:52 INFO - Running main action method: install 20:08:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:08:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:08:53 INFO - Reading from file tmpfile_stdout 20:08:53 INFO - Detecting whether we're running mozinstall >=1.0... 20:08:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:08:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:08:53 INFO - Reading from file tmpfile_stdout 20:08:53 INFO - Output received: 20:08:53 INFO - Usage: mozinstall [options] installer 20:08:53 INFO - Options: 20:08:53 INFO - -h, --help show this help message and exit 20:08:53 INFO - -d DEST, --destination=DEST 20:08:53 INFO - Directory to install application into. [default: 20:08:53 INFO - "/builds/slave/test"] 20:08:53 INFO - --app=APP Application being installed. [default: firefox] 20:08:53 INFO - mkdir: /builds/slave/test/build/application 20:08:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:08:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:09:09 INFO - Reading from file tmpfile_stdout 20:09:09 INFO - Output received: 20:09:09 INFO - /builds/slave/test/build/application/firefox/firefox 20:09:09 INFO - Running post-action listener: _resource_record_post_action 20:09:09 INFO - [mozharness: 2016-08-18 03:09:09.554957Z] Finished install step (success) 20:09:09 INFO - [mozharness: 2016-08-18 03:09:09.555230Z] Running run-tests step. 20:09:09 INFO - Running pre-action listener: _resource_record_pre_action 20:09:09 INFO - Running main action method: run_tests 20:09:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:09:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:09:09 INFO - Python 2.7.3 20:09:09 INFO - Return code: 0 20:09:09 INFO - grabbing minidump binary from tooltool 20:09:09 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')]} 20:09:09 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 0x1b25570>, '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 0x1b26470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b26900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:09:09 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 20:09:09 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 20:09:09 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 20:09:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:09:09 INFO - Return code: 0 20:09:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:09:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:09:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:09:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:09:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:09:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 20:09:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 20:09:09 INFO - Using env: {'DISPLAY': ':0', 20:09:09 INFO - 'HOME': '/home/cltbld', 20:09:09 INFO - 'LANG': 'en_US.UTF-8', 20:09:09 INFO - 'LANGUAGE': 'en_US:en', 20:09:09 INFO - 'LOGNAME': 'cltbld', 20:09:09 INFO - 'MAIL': '/var/mail/cltbld', 20:09:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:09:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:09:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:09 INFO - 'MOZ_NO_REMOTE': '1', 20:09:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:09:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:09 INFO - 'NO_EM_RESTART': '1', 20:09:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:09 INFO - 'PWD': '/builds/slave/test', 20:09:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:09:09 INFO - 'SHELL': '/bin/bash', 20:09:09 INFO - 'SHLVL': '1', 20:09:09 INFO - 'TERM': 'linux', 20:09:09 INFO - 'TMOUT': '86400', 20:09:09 INFO - 'USER': 'cltbld', 20:09:09 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1471483947.400992-1892230635', 20:09:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:09 INFO - '_': '/tools/buildbot/bin/python'} 20:09:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 20:09:09 INFO - mozversion application_buildid: 20160817183215 20:09:09 INFO - mozversion application_changeset: c43cb7e9ce93af133fe4eaee82699b1889d206d2 20:09:09 INFO - mozversion application_display_name: FirefoxDeveloperEdition 20:09:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:09:09 INFO - mozversion application_name: Firefox 20:09:09 INFO - mozversion application_remotingname: firefox-dev 20:09:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:09:09 INFO - mozversion application_vendor: Mozilla 20:09:09 INFO - mozversion application_version: 50.0a2 20:09:09 INFO - mozversion platform_buildid: 20160817183215 20:09:09 INFO - mozversion platform_changeset: c43cb7e9ce93af133fe4eaee82699b1889d206d2 20:09:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:09:09 INFO - mozversion platform_version: 50.0a2 20:09:09 INFO - using testdate: 1471489749 20:09:09 INFO - actual date: 1471489749 20:09:09 INFO - starting webserver on 'localhost:52115' 20:09:09 INFO - SUITE-START | Running 2 tests 20:09:09 INFO - TEST-START | dromaeo_css 20:09:09 INFO - operating with platform_type : linux_ 20:09:09 INFO - Initialising browser for dromaeo_css test... 20:09:09 INFO - TEST-INFO | started process 16363 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI72yFw/profile http://localhost:52115/getInfo.html) 20:09:13 INFO - PROCESS | 16363 | __metrics Screen width/height:1600/1200 20:09:13 INFO - PROCESS | 16363 | colorDepth:24 20:09:13 INFO - PROCESS | 16363 | Browser inner width/height: 1024/697 20:09:13 INFO - PROCESS | 16363 | __metrics 20:09:14 ERROR - PROCESS | 16363 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 20:09:15 INFO - TEST-INFO | 16363: exit 0 20:09:15 INFO - Browser initialized. 20:09:15 INFO - Running cycle 1/1 for dromaeo_css test... 20:09:15 INFO - TEST-INFO | started process 16490 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI72yFw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:09:27 INFO - PROCESS | 16490 | RSS: Main: 152666112 20:09:27 INFO - PROCESS | 16490 | 20:10:16 INFO - PROCESS | 16490 | 1471489816596 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] 20:12:24 INFO - PROCESS | 16490 | Cycle 1(1): loaded http://localhost:52115/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52115/tests/dromaeo/cssquery-ext.html) 20:12:25 INFO - PROCESS | 16490 | RSS: Main: 158085120 20:12:25 INFO - PROCESS | 16490 | 20:15:27 INFO - PROCESS | 16490 | Cycle 1(1): loaded http://localhost:52115/tests/dromaeo/cssquery-ext.html (next: http://localhost:52115/tests/dromaeo/cssquery-jquery.html) 20:15:28 INFO - PROCESS | 16490 | RSS: Main: 154030080 20:15:28 INFO - PROCESS | 16490 | 20:18:30 INFO - PROCESS | 16490 | Cycle 1(1): loaded http://localhost:52115/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52115/tests/dromaeo/cssquery-mootools.html) 20:18:30 INFO - PROCESS | 16490 | RSS: Main: 154386432 20:18:30 INFO - PROCESS | 16490 | 20:21:32 INFO - PROCESS | 16490 | Cycle 1(1): loaded http://localhost:52115/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52115/tests/dromaeo/cssquery-prototype.html) 20:21:33 INFO - PROCESS | 16490 | RSS: Main: 152829952 20:21:33 INFO - PROCESS | 16490 | 20:24:35 INFO - PROCESS | 16490 | Cycle 1(1): loaded http://localhost:52115/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52115/tests/dromaeo/cssquery-yui.html) 20:24:36 INFO - PROCESS | 16490 | RSS: Main: 155217920 20:24:36 INFO - PROCESS | 16490 | 20:27:38 INFO - PROCESS | 16490 | Cycle 1(1): loaded http://localhost:52115/tests/dromaeo/cssquery-yui.html (next: http://localhost:52115/tests/dromaeo/cssquery-dojo.html) 20:27:38 INFO - PROCESS | 16490 | RSS: Main: 155414528 20:27:38 INFO - PROCESS | 16490 | 20:27:38 INFO - PROCESS | 16490 | __start_tp_report 20:27:38 INFO - PROCESS | 16490 | _x_x_mozilla_page_load 20:27:38 INFO - PROCESS | 16490 | _x_x_mozilla_page_load_details 20:27:38 INFO - PROCESS | 16490 | |i|pagename|runs| 20:27:38 INFO - PROCESS | 16490 | |0;dojo.html;3199.1362332170315;3207.887723929663;3217.6943190396905;3230.7253883419917;3245.496947973065;5581.637193582419;5622.409646987069;5641.182028605855;5656.943430565693;5673.659580425177;5522.530584900288;5537.086380747182;5563.527100196488;5595.608307418473;5653.1520271959225;5069.873253168664;5113.974430127862;5175.430702622709;5193.117170081076;5212.192110222922;4991.151504244269;5029.270755740416;5073.239014147871;5105.719185444799;5150.896982060375;5112.1564941784745;5121.948780512184;5135.563477104451;5202.115640341151;5259.13224317989;5174.068667639824;5176.58587313016;5187.429382767892;5194.4026436959475;5222.399424066243;4906.429942418427;4929.728864912428;5060.595152387837;5081.8475445736685;5160.690358578498;5398.190271459273;5487.067198576252;5497.890042199134;5514.145307477307;5593.860153496154;5970.641761494281;6006.96996515019;6016.75932962681;6035.185249991239;6039.214902062704;5763.308402991668;6068.726907289182;6069.57512974092;6072.119542666289;6077.270727512727;5540.806071787468;5569.053260945609;5577.470140336702;5622.746976386073;5650.237217975603;6061.969690151521;6097.542684298695;6114.877702445926;6119.173911521888;6119.84700382494;5650.152477128381;5788.913166302509;5845;5847.619904706181;5848.736806843703;5861.472467477947;5863.648181109147;5925.674087925119;5959.314678811906;5976.223090998229;5882.676452795052;5921.171036054956;5928.525717942554;5953.613015154001;5957.165996760457;5689.630174038757;5920.79277225295;5944.494717949023;5966.910496342558;5987.161797348374;4536.546345365437;4579.9084018319445;4582.747948862844;4636.675432719745;4660.5106463821485;4118.608732170439;4122.814473348706;4129.876103716893;4143.047099167208;4144.026153853842;5539;5850.707464626752;5856.4143585641095;5858.765649373977;5870.354261031369;5954.642721436728;5972.432618901197;5987.371326010793;6019.909701354483;6038.18484504595;5707.600467967285;5719.227904232958;5721.170430287585;5743.54051675865;5771.134329850556;4889.9022019560125;5025.6482046256415;5048.217526283432;5057;5110.66780659256;6117.113018612276;6186.505079593621;6195.2255968004;6278.6546739929745;6280.654563998933;5997;6028.8794224116145;6034.275886893601;6043.969780151071;6055.697215139314;5866.853328666817;6107.969460152848;6202.968985155046;6254.906176407267;6266.68666566679;5835.56233282514;5874.942510348178;5878.382769809108;5920.763169473173;5921;5919.526437884872;5950.434708702666;5988.28140623128;6006.789762358297;6017.127516510169;5603.467670571289;5838.474537291664;5867.647941123546;5899.705014749331;5908.911366329423;5818.127280907728;5893.882122357614;5905.35041145465;5954.880902382015;5956.910646340221;5833.329167145663;5856.853578660568;5858.619189752652;5865.354810970704;5866.853328666817;5636;5805.854853628524;5936.910946335895;5940.79207227745;5989.431004054608;5668.744906479136;5760.654360738369;5779.624324418899;5780.537556995514;5804.303483581997 20:27:38 INFO - PROCESS | 16490 | |1;ext.html;590.616099535302;655.9016147577864;663.0816319397634;688.3804575881705;713.176281394989;41538.792306038464;45390;45591.088178236416;45693;45793.77103114484;46037.30944035842;46493.535064649346;46509.30236046462;46525.53474465254;46556;9150.313726470507;9268.212201962808;9292.535373231345;9298.209652179572;9303.441793492411;9189.40268882524;9252.444853308789;9276.72169834906;9282.257419406431;9346.39248448852;9345.345825792198;9350.298727595424;9384.39001464906;9401.012893646172;9404.200642945323;9225;9287.76780580484;9316.953415232914;9337.393069450463;9367.531623418801;9152.771180720536;9153;9165.679201227926;9246.26029917605;9269.165775080275;43296.56703432957;43934.78032609849;44268.55731442709;44396.3340549892;44429.555704442864;3730.8401132737076;3860.478835357219;4203.516595591515;4590.586847183769;4627.791749371287;35290.11774705627;35319;35734.64265357339;36801.26397472063;36853;4547.772611369418;4755.405574303212;4898.461169271377;4920.360353154103;4964.503549645043;395922;396238;398961;401704;402439.98780006205;36665.45001824975;66997;67545.66227168833;67602.32397675961;67615.66192169106;38522.61477385247;40115.39826902599;40564.59435405667;40910.79544602258;41013.589864101574;17901.7314740279;17963;18067;18081.276748929897;18106.366277180234;14593.343299551545;14676.119432834064;14723.116613003254;14729.852701472848;14763.704725905422;9037.909620903838;9116.772080698036;9120.087991200828;9130.178283954476;9180.632774688938;3498.440249560058;3538.7522873398616;3552.0942159749097;3576.3204991051616;3584.6415358464465;1074.2802322443981;1084.810158222308;1132.116948779953;1160.6265187691192;1192.362086283834;35189.82405087958;35196.47205291923;35343.82328088343;35619.4657080144;35701.82149089238;1146.2148428326623;1175.435790820411;1176.276589897207;1182.7338848758961;1214.2297818351105;17300.65398692019;17364.4790656278;17463.650726985645;17484.300627974993;17567.033813140144;640840;643812;644686;645343;650389;63658;64305.678471607345;64367.67816160889;64412;64502;1448.6957738874955;1462.3565631122271;1470.162007655626;1487.9032862863878;1520.9771853422208;32614.673853261163;32907;33300.83349583237;33358.499622505195;33659.663403366634;55587.44412555823;56489.15266271091;56616.43383566276;56661.43338566727;56665;526418;527884;529860;530950;533005;29915.401691965602;30535.389292214477;31713.20716982094;31879.681203187673;32736.508952365257;52274.477255228485;52464.73767631137;52804.73597632141;54075.18887216616;54664;44105.11789764123;44543;45126.54873451223;45895;46080.769596151804;46397.76801115973;46868.7656561715;47233;47520.7623961878;47543.52456475391;42395;43517.78241108901;44174.55825441705;45594.54405455903;45934.31098533591;34242.82878585591;35016.44802029282;35031.82484087563;35406.822965885;35721;30271.243218919702;30678.693213068476;30978.058573336177;31144;31438.68561314449 20:27:38 INFO - PROCESS | 16490 | |2;jquery.html;384.6749496675308;385.5238780106568;395.1425406867098;395.6636858670131;411.4856429463171;14774.926125369358;19312;20128.295509657164;20806.271780487685;20871.68692469612;19814.20743170275;20316.085776140073;20436.182552697876;20678;20700.8964955175;5393.352797664276;5886.234789477383;6053.697315134225;6108.755649774003;6150.077488376757;5892.204552385438;6119.2350956130485;6164;6165.599236049665;6166.260048794151;5321.760520776575;5495.53287970523;5499.752511137009;5503.642263252896;5551;5456.127019676853;5462.9726851365485;5481.75332110054;5508.614396992212;5508.669479831223;5180.766865491024;5306.655067420644;5345.251664766935;5360.973195133999;5372.167314066326;14129.576112716635;14238.216898070603;14251.287435628281;14283.428662853474;14401.78397324041;2416.9516609667708;2729.4131761671138;3078.815271083742;3103.224193951512;3183.7771356005087;13663.043586948917;14976.775348369783;15145.394184232617;15170.620734481616;15656.686866262726;2017.8991050447567;2057.1565658080117;2065.4423305707523;2071.219303525148;2135.540858715384;77221.61389193074;86300.56849715774;86492.13507864966;86674.99999999937;89907;10559.63041293551;10878.40168790724;10954.452277386099;11648.126390520745;11670.533178672758;16384.672306553803;16388.836111638968;16393;16411.91794041022;16419.67160656804;8819.691310804092;8936.872094766779;9074.682386116454;9092.408993415407;9094.95408028072;8952.28381729473;8958.955205223932;9023.503707296031;9116.498592577473;9149.81700365989;4459.10817836434;4528.909421811545;4977.527134922177;5030.346055012825;5139.845804625792;1979.70304454333;1989.4926793667812;2046.785087565814;2068.844836637258;2089.3731880435807;990.7325022244098;994.22450488619;1008.3798463944621;1040.661784919904;1084.0677017764715;20328.390148295573;20766.688499672517;20852.1659133636;20866.165353385695;21170.894145529175;1046.424466543398;1058.5977328615231;1075.93544387337;1078.2991055813784;1086.5436516663021;11116.722081948015;11473.655790326304;11557.595484158013;11607.883921160848;11722.472488738027;452933;470776.9208512468;477895;478498;480596;90746.54626726825;94062.0593794067;94505;96679;98668.50665746625;1089.2048804372853;1127.3799410324452;1138.2089447833841;1154.6247469572422;1160.2864238493435;18619.627607447503;18910.432687019413;19258.037098145316;19481.610367792848;19499.512512186742;41186.17627647371;45240.32139517976;45457.54542454665;45777;46514.76742616265;64033.35966640274;64790.35209647843;65195.67402162959;65919.68160636665;67176.32823671897;8661.842315688378;8706;8748.606312715816;8804.955975220082;8857.424267422597;9578.425294482353;12448.31534265624;13130.146540474838;13811.033227673966;14184;11312.94343528277;11468.541258349573;11551;11616.361100139235;11652.708682283012;11549.538018479167;12003;12117.81823272634;12243.265404075784;12576.30830304342;8228.588570571328;8465.534395608302;8483.533405662747;8564.272036876935;11643;12249.755004900031;12752.872471275168;12992.935035324763;13077.280749558866;13260.005499587376;11768.35274059935;12008.159428840247;12055.216410933612;12183.208091474025;12251.571195008131 20:27:38 INFO - PROCESS | 16490 | |3;mootools.html;1555.8521940415665;1589.848964348387;1762.9823701762987;1841.0426578179338;1856.229664689154;8539;9206.815863682723;9210;9876.25928055396;9920.255980801441;9424.481653509054;9482.241420686345;9531.28515361349;9549.665761698341;9571.712848614536;2419.806415486761;2458.299384675368;2465.0632759551345;2467.494163696447;2472.5054989002183;2404.410919324759;2461.4215659320043;2464.112919349033;2482.689663792026;2485.8632775197357;2392.1746997285995;2430.6232533957177;2433.6592876997233;2434.7443518430578;2447.0823441209545;2330.9533809323802;2349.5653304138705;2351.929442116739;2390.5816482115733;2415.5772739770646;2364.7398786133513;2370.0638247891984;2372.5847976604027;2379.690640216778;2386.3914701751114;9620.182284505825;9646.083622055963;9652.131308182297;9666.468344241064;9722.854157187649;5460.31746031746;5625.915611265835;5628.493435590816;5634.126710359901;5640.125780504029;3432.5880894292595;3464.4110501214855;3503.4744788281705;3540.6459354064386;3564.3584154852115;1163.4066626020706;1182.2020136407975;1182.8284898689642;1189.1854079955258;1210.3766560221493;13425.462981480729;13440.19358838463;13465;13501.392437340244;13561.932190339085;4622.583967442946;4672.883177920511;4858.80564777412;4868.318435419044;4882.707037577757;11334.206605537533;11358.94320528392;11375.715607109723;11379.260348077349;11486.770264594661;5603.187537806995;5625.6905870176715;5631.6902570359025;5650.26546548946;5656.095024796013;4607.6313894889;4981.576565991932;5084.77118529667;5119.744012799345;5234.319538459976;4206;4329.631981281564;4330.523642399334;4351.521332653406;4394.538573449806;1302.5896842494583;1329.1094966372555;1339.3102552185633;1341.2019848190312;1344.5226944434585;934.2712684106408;1015.0002247785925;1036.7045392063226;1056.2236755984345;1060.6340812419703;6363;6387.073874288202;6468.2561505427475;6489.786801022505;6553.672316384162;449.94150760400936;457.1451385908373;459.2032823052002;459.9563041511051;463.6870112673999;4439.933400998988;4480.529544397857;4548.931766023512;4592.127495775792;4596.4024676791805;11694.590689326003;12043.397830108459;12073.034157267397;12166.817497737364;12172.147949643617;11319.717007074889;11989.580364687194;12036.87963120375;12058.698532536757;12113.212641178296;8888.466691998501;9093.408928419763;9105.908940910505;9108.817823643623;9110;6588.769393071219;6623.768168114093;6638.933610663831;6754.763583274562;6858.074159988537;11109.222354435113;11272.323660580392;11335.376554289593;11356.886431135583;11462.94268528652;11398.145139114766;11475.483603237708;11499.597514087302;11587.826182607436;11607.6517704469;8544.658213671384;8708.303335732999;8722;8750.47497150173;8777.078406767198;8721.91278087211;9378.109079637423;9392.342536022687;9472.905270947202;9512.239020878174;8321.251087402163;8369.372297077622;8384.32925365957;8387.329013679013;8539.487630742175;8073.919260807552;8075.636596353061;8182.713605023796;8245.051819040647;8255.876161857697;7432.739854105081;7452.180260171485;7488.5506869588;7502;7510;5450.754716037867;5541;5591.468810463162;5660.801871934463;5713.685747283939;5511.944880551143;5512.145617429305;5593.412691667317;5655.349634791887;5691.117876729114 20:27:38 INFO - PROCESS | 16490 | |4;prototype.html;320.08588639933197;327.55711092636943;328.29416753978944;330.38548300161705;338.97796643218174;5595.580331475136;5733.254676891998;5752.769889204432;5828.30060392753;5840.766369345227;5704.258446401972;5771.567132465061;5773.220615216945;5794.203796822988;5833.8833223335505;4492.371068050467;4496;4523.208438523246;4525.660575456837;4534.591886730193;4455.84404545841;4521.937344723987;4545.659075569329;4551.726896386211;4555.863324100283;4460.107978404316;4494.730316181023;4500.437445319335;4500.774961251941;4510.278355463127;4485.551444855521;4524.728516289;4533.685231282908;4572.611328037121;4588.678792484528;3858.49518687712;3945.7237993340477;3972.165845172517;4027.97986010071;4039.697022723278;5694.373618901917;5719.28508936383;5730.255066841326;5733.397993210736;5759.65442073477;5123.744682552761;5146.330976973007;5180.637355385087;5202.739863006835;5212.765425555859;5851.6008436540815;6025.578209525335;6044.697765111727;6079.513638908877;6094.481969032638;4380.386745855582;4390.209762242795;4405.273129933589;4405.691601587891;4406.537313582092;6275.780347687809;6325.620462772248;6334.334894836068;6400.263969643504;6439.8068057958335;4426.15902978433;4443.755593442327;4458.977705111453;4462.843800466968;4464.129494748493;4525.094981003813;4529.297958816389;4529.750863702462;4531.252343363308;4534.206513860061;5158.63889527737;5182.222666600041;5190.92213616796;5202.089634314056;5217.295665085241;5822.534197264294;5920.585559010828;6077.9392206078255;6139.6009259398;6182.598131121463;1442.6104951662992;1497.7867926979181;1508.1629695518873;1509.1548732709718;1511.8110236220473;920.5903372999085;940.5955439161227;944.891337496183;952;964.9228061755043;5187.740612969412;5221.738913054332;5228.37259528859;5253.159494480941;5275.786569089131;5460.645058071292;5490.890182196414;5498.890022199534;5506.678397184647;5514.724263786875;5117.437081920985;5250.527452529291;5281.551068159172;5282.81510147143;5315.245968830277;2944.911652650424;2998.190488568118;3002.4445477586714;3012.51799712045;3025.4570169213857;5663.518600918968;5665.26949996749;5680.346760122557;5695.895736823441;5726.226959360433;5269.736513174403;5550.750216240279;5602.38373778884;5621.943780562224;5659.773609055592;5724.370319264877;5741.999999999916;5760.790234050896;5791.391903850035;5793.681347525842;5524.613277070566;5570.637908535932;5610.298712660918;5835.912461313169;6368.745250189941;6195.2255968004;6220.377962203744;6230.43926046658;6257.342978987141;6274.717637706223;6294.929861923392;6592.340765923561;6634.800955971135;6660.433863121689;6661.367170118831;4252.851150209728;4309.6767742418815;4317.805698743501;4323.437953066082;4361;6112.908306375319;6124.845704462116;6409.262934762562;6412.61524308543;6414.967925160345;6141.232345956755;6152.846178845564;6185.381461853779;6190.2571691397325;6209;6093.786717464867;6139.539534534839;6161.322254551906;6201.224846894138;6230.719617617127;6037.63774173551;6050.364711705208;6055.515558755201;6116.26604807426;6119.632822030514;6156.29202641702;6194.0798352510865;6223.635018692868;6251.843703907439;6267.717952692049;5891.556568640711;6002.429769171922;6033.818985430444;6067.696615169136;6130.938690613215 20:27:38 INFO - PROCESS | 16490 | |5;yui.html;788.530824159625;821.909589945106;835.4152093534527;886.1448702002566;933.8785957825481;15882.444114455982;17038.48884533463;17927.01401422921;18052.4584262472;18119.547011324725;15939.681206375866;16046.518604441857;16048.919755401235;16066.437674681389;16094.83905160948;889.7908991387019;891.652255620307;913.8126684029792;921.9585118669676;922.077922077922;912.4935660708304;917.1516347378681;920.0293690156882;920.6501529418812;921.5484412637826;949.6154057606681;951.0679534056628;955.1928620315857;956.0535070280407;958.750724811547;947.6398968392001;952.6379975609259;954.9188318992894;955.9044095590455;956.416585882611;699.1191099214975;702.9507934444591;703.7255470366562;705.0341032785066;706.3536863769644;16692.081935493545;16866.831331686648;16919.57701057471;16965.915170424192;17010.234539445755;16183.514494565065;16457.07142113011;16463.259153338127;16656.75014874778;16748.162591870358;13219.140755850838;13324;13694.452221911111;13907.513237036756;14028.579142625635;4005.379166229239;4070.9185816283803;4086.7752273624938;4131.153113611703;4154.543000269968;81778.59110704467;83660.16339836645;83850.58074709648;84270;84410.99999999939;11879.40602969848;12367.196132251374;12443.626691199097;12576.30830304342;12740.36298185087;22228.55542889133;22288.777112228996;22303;22309.330720078422;22380.552388952456;8949;9100.226480749077;9116.544172791333;9188.173064424234;9218.170364667078;5211.348581427322;5297.205419187153;5343.7862485500145;5379.955646621639;5465;3759.6240375962734;3912.941305880414;3939.684825213976;3942.940855887164;3946.5856085111222;665.9067730517731;675.7161991963387;685.1606781692486;698.1587187439123;709.51752808091;818.4925346285341;824.9248711365954;837.9245867871921;858.9914100859037;860.9009963854237;9926.35478693897;10131.392116473035;10373.118284945713;10689.572417103229;10718.517666705016;672.1329484964439;697.5361384679233;748.4349316266184;764.3121190928209;769.6882762481204;4499;4814.566688997937;4820.301056346881;4839.41926968766;4865.829695960695;78567.60716196382;133665;135827;137996.48014079526;139988.3000585011;113703;117590.41204793921;117741.41129294298;118503;121178.3941080289;98727;101569;101974;102624;104782;9000.50497222659;9367.531623418938;9391.624335026523;9488.33581649278;9561.378510396802;51068.74465627648;58139.127913082186;58338.416615833296;58813.70593147007;59025.70487147537;52434;69662.30337696559;69914.30085699282;70085;75032.62483687546;14173.964502926627;14197.574072777834;14628.707425851637;14633.268336582916;15516.534503964898;15202.543923682308;15244.77132842986;15861.762073569136;16513.091779952218;16881.240344184294;15495.14776687293;15726.842731572538;16399.590010249838;16467.67064658724;16656.666866662355;14830.258487075818;15331.156786376856;15553.68892622164;16291.918540407221;16297.429589964295;15288.61778455503;15634.9218253908;15706.764398533802;15774;16652.750208746635;12180.817287740869;12222.633321000385;12395.380230988594;12551.623451296477;12991.350432478528;12821.294828784134;13003.739925201633;13141.408636611566;13393;13395.665108372368 20:27:38 INFO - PROCESS | 16490 | __end_tp_report 20:27:38 INFO - PROCESS | 16490 | __start_cc_report 20:27:38 INFO - PROCESS | 16490 | _x_x_mozilla_cycle_collect,341 20:27:38 INFO - PROCESS | 16490 | __end_cc_report 20:27:38 INFO - PROCESS | 16490 | __startTimestamp1471490858869__endTimestamp 20:27:38 INFO - PROCESS | 16490 | 20:27:38 INFO - PROCESS | 16490 | ------- Summary: start ------- 20:27:38 INFO - PROCESS | 16490 | Number of tests: 6 20:27:38 INFO - PROCESS | 16490 | 20:27:38 INFO - PROCESS | 16490 | [#0] dojo.html Cycles:165 Average:5561.52 Median:5805.85 stddev:628.33 (10.8%) stddev-sans-first:602.31 20:27:38 INFO - PROCESS | 16490 | Values: 3199.1 3207.9 3217.7 3230.7 3245.5 5581.6 5622.4 5641.2 5656.9 5673.7 5522.5 5537.1 5563.5 5595.6 5653.2 5069.9 5114.0 5175.4 5193.1 5212.2 4991.2 5029.3 5073.2 5105.7 5150.9 5112.2 5121.9 5135.6 5202.1 5259.1 5174.1 5176.6 5187.4 5194.4 5222.4 4906.4 4929.7 5060.6 5081.8 5160.7 5398.2 5487.1 5497.9 5514.1 5593.9 5970.6 6007.0 6016.8 6035.2 6039.2 5763.3 6068.7 6069.6 6072.1 6077.3 5540.8 5569.1 5577.5 5622.7 5650.2 6062.0 6097.5 6114.9 6119.2 6119.8 5650.2 5788.9 5845.0 5847.6 5848.7 5861.5 5863.6 5925.7 5959.3 5976.2 5882.7 5921.2 5928.5 5953.6 5957.2 5689.6 5920.8 5944.5 5966.9 5987.2 4536.5 4579.9 4582.7 4636.7 4660.5 4118.6 4122.8 4129.9 4143.0 4144.0 5539.0 5850.7 5856.4 5858.8 5870.4 5954.6 5972.4 5987.4 6019.9 6038.2 5707.6 5719.2 5721.2 5743.5 5771.1 4889.9 5025.6 5048.2 5057.0 5110.7 6117.1 6186.5 6195.2 6278.7 6280.7 5997.0 6028.9 6034.3 6044.0 6055.7 5866.9 6108.0 6203.0 6254.9 6266.7 5835.6 5874.9 5878.4 5920.8 5921.0 5919.5 5950.4 5988.3 6006.8 6017.1 5603.5 5838.5 5867.6 5899.7 5908.9 5818.1 5893.9 5905.4 5954.9 5956.9 5833.3 5856.9 5858.6 5865.4 5866.9 5636.0 5805.9 5936.9 5940.8 5989.4 5668.7 5760.7 5779.6 5780.5 5804.3 20:27:38 INFO - PROCESS | 16490 | 20:27:38 INFO - PROCESS | 16490 | [#1] ext.html Cycles:180 Average:67933.70 Median:45258.27 stddev:142397.09 (314.6%) stddev-sans-first:142706.78 20:27:38 INFO - PROCESS | 16490 | Values: 590.6 655.9 663.1 688.4 713.2 41538.8 45390.0 45591.1 45693.0 45793.8 46037.3 46493.5 46509.3 46525.5 46556.0 9150.3 9268.2 9292.5 9298.2 9303.4 9189.4 9252.4 9276.7 9282.3 9346.4 9345.3 9350.3 9384.4 9401.0 9404.2 9225.0 9287.8 9317.0 9337.4 9367.5 9152.8 9153.0 9165.7 9246.3 9269.2 43296.6 43934.8 44268.6 44396.3 44429.6 3730.8 3860.5 4203.5 4590.6 4627.8 35290.1 35319.0 35734.6 36801.3 36853.0 4547.8 4755.4 4898.5 4920.4 4964.5 395922.0 396238.0 398961.0 401704.0 402440.0 36665.5 66997.0 67545.7 67602.3 67615.7 38522.6 40115.4 40564.6 40910.8 41013.6 17901.7 17963.0 18067.0 18081.3 18106.4 14593.3 14676.1 14723.1 14729.9 14763.7 9037.9 9116.8 9120.1 9130.2 9180.6 3498.4 3538.8 3552.1 3576.3 3584.6 1074.3 1084.8 1132.1 1160.6 1192.4 35189.8 35196.5 35343.8 35619.5 35701.8 1146.2 1175.4 1176.3 1182.7 1214.2 17300.7 17364.5 17463.7 17484.3 17567.0 640840.0 643812.0 644686.0 645343.0 650389.0 63658.0 64305.7 64367.7 64412.0 64502.0 1448.7 1462.4 1470.2 1487.9 1521.0 32614.7 32907.0 33300.8 33358.5 33659.7 55587.4 56489.2 56616.4 56661.4 56665.0 526418.0 527884.0 529860.0 530950.0 533005.0 29915.4 30535.4 31713.2 31879.7 32736.5 52274.5 52464.7 52804.7 54075.2 54664.0 44105.1 44543.0 45126.5 45895.0 46080.8 46397.8 46868.8 47233.0 47520.8 47543.5 42395.0 43517.8 44174.6 45594.5 45934.3 34242.8 35016.4 35031.8 35406.8 35721.0 30271.2 30678.7 30978.1 31144.0 31438.7 20:27:38 INFO - PROCESS | 16490 | 20:27:38 INFO - PROCESS | 16490 | [#2] jquery.html Cycles:180 Average:29199.45 Median:11630.13 stddev:78170.05 (672.1%) stddev-sans-first:78359.39 20:27:38 INFO - PROCESS | 16490 | Values: 384.7 385.5 395.1 395.7 411.5 14774.9 19312.0 20128.3 20806.3 20871.7 19814.2 20316.1 20436.2 20678.0 20700.9 5393.4 5886.2 6053.7 6108.8 6150.1 5892.2 6119.2 6164.0 6165.6 6166.3 5321.8 5495.5 5499.8 5503.6 5551.0 5456.1 5463.0 5481.8 5508.6 5508.7 5180.8 5306.7 5345.3 5361.0 5372.2 14129.6 14238.2 14251.3 14283.4 14401.8 2417.0 2729.4 3078.8 3103.2 3183.8 13663.0 14976.8 15145.4 15170.6 15656.7 2017.9 2057.2 2065.4 2071.2 2135.5 77221.6 86300.6 86492.1 86675.0 89907.0 10559.6 10878.4 10954.5 11648.1 11670.5 16384.7 16388.8 16393.0 16411.9 16419.7 8819.7 8936.9 9074.7 9092.4 9095.0 8952.3 8959.0 9023.5 9116.5 9149.8 4459.1 4528.9 4977.5 5030.3 5139.8 1979.7 1989.5 2046.8 2068.8 2089.4 990.7 994.2 1008.4 1040.7 1084.1 20328.4 20766.7 20852.2 20866.2 21170.9 1046.4 1058.6 1075.9 1078.3 1086.5 11116.7 11473.7 11557.6 11607.9 11722.5 452933.0 470776.9 477895.0 478498.0 480596.0 90746.5 94062.1 94505.0 96679.0 98668.5 1089.2 1127.4 1138.2 1154.6 1160.3 18619.6 18910.4 19258.0 19481.6 19499.5 41186.2 45240.3 45457.5 45777.0 46514.8 64033.4 64790.4 65195.7 65919.7 67176.3 8661.8 8706.0 8748.6 8805.0 8857.4 9578.4 12448.3 13130.1 13811.0 14184.0 11312.9 11468.5 11551.0 11616.4 11652.7 11549.5 12003.0 12117.8 12243.3 12576.3 8228.6 8465.5 8483.5 8564.3 11643.0 12249.8 12752.9 12992.9 13077.3 13260.0 11768.4 12008.2 12055.2 12183.2 12251.6 20:27:38 INFO - PROCESS | 16490 | 20:27:38 INFO - PROCESS | 16490 | [#3] mootools.html Cycles:180 Average:6298.65 Median:2526.04 stddev:3689.31 (146.1%) stddev-sans-first:3682.45 20:27:38 INFO - PROCESS | 16490 | Values: 1555.9 1589.8 1763.0 1841.0 1856.2 8539.0 9206.8 9210.0 9876.3 9920.3 9424.5 9482.2 9531.3 9549.7 9571.7 2419.8 2458.3 2465.1 2467.5 2472.5 2404.4 2461.4 2464.1 2482.7 2485.9 2392.2 2430.6 2433.7 2434.7 2447.1 2331.0 2349.6 2351.9 2390.6 2415.6 2364.7 2370.1 2372.6 2379.7 2386.4 9620.2 9646.1 9652.1 9666.5 9722.9 5460.3 5625.9 5628.5 5634.1 5640.1 3432.6 3464.4 3503.5 3540.6 3564.4 1163.4 1182.2 1182.8 1189.2 1210.4 13425.5 13440.2 13465.0 13501.4 13561.9 4622.6 4672.9 4858.8 4868.3 4882.7 11334.2 11358.9 11375.7 11379.3 11486.8 5603.2 5625.7 5631.7 5650.3 5656.1 4607.6 4981.6 5084.8 5119.7 5234.3 4206.0 4329.6 4330.5 4351.5 4394.5 1302.6 1329.1 1339.3 1341.2 1344.5 934.3 1015.0 1036.7 1056.2 1060.6 6363.0 6387.1 6468.3 6489.8 6553.7 449.9 457.1 459.2 460.0 463.7 4439.9 4480.5 4548.9 4592.1 4596.4 11694.6 12043.4 12073.0 12166.8 12172.1 11319.7 11989.6 12036.9 12058.7 12113.2 8888.5 9093.4 9105.9 9108.8 9110.0 6588.8 6623.8 6638.9 6754.8 6858.1 11109.2 11272.3 11335.4 11356.9 11462.9 11398.1 11475.5 11499.6 11587.8 11607.7 8544.7 8708.3 8722.0 8750.5 8777.1 8721.9 9378.1 9392.3 9472.9 9512.2 8321.3 8369.4 8384.3 8387.3 8539.5 8073.9 8075.6 8182.7 8245.1 8255.9 7432.7 7452.2 7488.6 7502.0 7510.0 5450.8 5541.0 5591.5 5660.8 5713.7 5511.9 5512.1 5593.4 5655.3 5691.1 20:27:38 INFO - PROCESS | 16490 | 20:27:38 INFO - PROCESS | 16490 | [#4] prototype.html Cycles:180 Average:5000.78 Median:5606.34 stddev:1478.49 (26.4%) stddev-sans-first:1440.29 20:27:38 INFO - PROCESS | 16490 | Values: 320.1 327.6 328.3 330.4 339.0 5595.6 5733.3 5752.8 5828.3 5840.8 5704.3 5771.6 5773.2 5794.2 5833.9 4492.4 4496.0 4523.2 4525.7 4534.6 4455.8 4521.9 4545.7 4551.7 4555.9 4460.1 4494.7 4500.4 4500.8 4510.3 4485.6 4524.7 4533.7 4572.6 4588.7 3858.5 3945.7 3972.2 4028.0 4039.7 5694.4 5719.3 5730.3 5733.4 5759.7 5123.7 5146.3 5180.6 5202.7 5212.8 5851.6 6025.6 6044.7 6079.5 6094.5 4380.4 4390.2 4405.3 4405.7 4406.5 6275.8 6325.6 6334.3 6400.3 6439.8 4426.2 4443.8 4459.0 4462.8 4464.1 4525.1 4529.3 4529.8 4531.3 4534.2 5158.6 5182.2 5190.9 5202.1 5217.3 5822.5 5920.6 6077.9 6139.6 6182.6 1442.6 1497.8 1508.2 1509.2 1511.8 920.6 940.6 944.9 952.0 964.9 5187.7 5221.7 5228.4 5253.2 5275.8 5460.6 5490.9 5498.9 5506.7 5514.7 5117.4 5250.5 5281.6 5282.8 5315.2 2944.9 2998.2 3002.4 3012.5 3025.5 5663.5 5665.3 5680.3 5695.9 5726.2 5269.7 5550.8 5602.4 5621.9 5659.8 5724.4 5742.0 5760.8 5791.4 5793.7 5524.6 5570.6 5610.3 5835.9 6368.7 6195.2 6220.4 6230.4 6257.3 6274.7 6294.9 6592.3 6634.8 6660.4 6661.4 4252.9 4309.7 4317.8 4323.4 4361.0 6112.9 6124.8 6409.3 6412.6 6415.0 6141.2 6152.8 6185.4 6190.3 6209.0 6093.8 6139.5 6161.3 6201.2 6230.7 6037.6 6050.4 6055.5 6116.3 6119.6 6156.3 6194.1 6223.6 6251.8 6267.7 5891.6 6002.4 6033.8 6067.7 6130.9 20:27:38 INFO - PROCESS | 16490 | 20:27:38 INFO - PROCESS | 16490 | [#5] yui.html Cycles:180 Average:22957.20 Median:3944.76 stddev:33533.26 (850.1%) stddev-sans-first:33586.01 20:27:38 INFO - PROCESS | 16490 | Values: 788.5 821.9 835.4 886.1 933.9 15882.4 17038.5 17927.0 18052.5 18119.5 15939.7 16046.5 16048.9 16066.4 16094.8 889.8 891.7 913.8 922.0 922.1 912.5 917.2 920.0 920.7 921.5 949.6 951.1 955.2 956.1 958.8 947.6 952.6 954.9 955.9 956.4 699.1 703.0 703.7 705.0 706.4 16692.1 16866.8 16919.6 16965.9 17010.2 16183.5 16457.1 16463.3 16656.8 16748.2 13219.1 13324.0 13694.5 13907.5 14028.6 4005.4 4070.9 4086.8 4131.2 4154.5 81778.6 83660.2 83850.6 84270.0 84411.0 11879.4 12367.2 12443.6 12576.3 12740.4 22228.6 22288.8 22303.0 22309.3 22380.6 8949.0 9100.2 9116.5 9188.2 9218.2 5211.3 5297.2 5343.8 5380.0 5465.0 3759.6 3912.9 3939.7 3942.9 3946.6 665.9 675.7 685.2 698.2 709.5 818.5 824.9 837.9 859.0 860.9 9926.4 10131.4 10373.1 10689.6 10718.5 672.1 697.5 748.4 764.3 769.7 4499.0 4814.6 4820.3 4839.4 4865.8 78567.6 133665.0 135827.0 137996.5 139988.3 113703.0 117590.4 117741.4 118503.0 121178.4 98727.0 101569.0 101974.0 102624.0 104782.0 9000.5 9367.5 9391.6 9488.3 9561.4 51068.7 58139.1 58338.4 58813.7 59025.7 52434.0 69662.3 69914.3 70085.0 75032.6 14174.0 14197.6 14628.7 14633.3 15516.5 15202.5 15244.8 15861.8 16513.1 16881.2 15495.1 15726.8 16399.6 16467.7 16656.7 14830.3 15331.2 15553.7 16291.9 16297.4 15288.6 15634.9 15706.8 15774.0 16652.8 12180.8 12222.6 12395.4 12551.6 12991.4 12821.3 13003.7 13141.4 13393.0 13395.7 20:27:38 INFO - PROCESS | 16490 | -------- Summary: end -------- 20:27:38 INFO - PROCESS | 16490 | 20:27:39 INFO - TEST-INFO | 16490: exit 0 20:27:39 INFO - TEST-OK | dromaeo_css | took 1109717ms 20:27:39 INFO - TEST-START | kraken 20:27:39 INFO - operating with platform_type : linux_ 20:27:39 INFO - Initialising browser for kraken test... 20:27:39 INFO - TEST-INFO | started process 16761 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOJSj4N/profile http://localhost:52115/getInfo.html) 20:27:43 INFO - PROCESS | 16761 | __metrics Screen width/height:1600/1200 20:27:43 INFO - PROCESS | 16761 | colorDepth:24 20:27:43 INFO - PROCESS | 16761 | Browser inner width/height: 1024/697 20:27:43 INFO - PROCESS | 16761 | __metrics 20:27:43 ERROR - PROCESS | 16761 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 20:27:44 INFO - TEST-INFO | 16761: exit 0 20:27:44 INFO - Browser initialized. 20:27:44 INFO - Running cycle 1/1 for kraken test... 20:27:44 INFO - TEST-INFO | started process 16886 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOJSj4N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:27:56 INFO - PROCESS | 16886 | RSS: Main: 152215552 20:27:56 INFO - PROCESS | 16886 | 20:27:59 INFO - PROCESS | 16886 | Cycle 1(1): loaded http://localhost:52115/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52115/tests/kraken/driver.html?testName=audio-beat-detection) 20:27:59 INFO - PROCESS | 16886 | RSS: Main: 157569024 20:27:59 INFO - PROCESS | 16886 | 20:28:02 INFO - PROCESS | 16886 | Cycle 1(1): loaded http://localhost:52115/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52115/tests/kraken/driver.html?testName=audio-dft) 20:28:03 INFO - PROCESS | 16886 | RSS: Main: 156475392 20:28:03 INFO - PROCESS | 16886 | 20:28:05 INFO - PROCESS | 16886 | Cycle 1(1): loaded http://localhost:52115/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52115/tests/kraken/driver.html?testName=audio-fft) 20:28:06 INFO - PROCESS | 16886 | RSS: Main: 157298688 20:28:06 INFO - PROCESS | 16886 | 20:28:08 INFO - PROCESS | 16886 | Cycle 1(1): loaded http://localhost:52115/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52115/tests/kraken/driver.html?testName=audio-oscillator) 20:28:09 INFO - PROCESS | 16886 | RSS: Main: 156864512 20:28:09 INFO - PROCESS | 16886 | 20:28:11 INFO - PROCESS | 16886 | Cycle 1(1): loaded http://localhost:52115/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52115/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:28:12 INFO - PROCESS | 16886 | RSS: Main: 156528640 20:28:12 INFO - PROCESS | 16886 | 20:28:15 INFO - PROCESS | 16886 | Cycle 1(1): loaded http://localhost:52115/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52115/tests/kraken/driver.html?testName=imaging-darkroom) 20:28:15 INFO - PROCESS | 16886 | RSS: Main: 156004352 20:28:15 INFO - PROCESS | 16886 | 20:28:19 INFO - PROCESS | 16886 | Cycle 1(1): loaded http://localhost:52115/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52115/tests/kraken/driver.html?testName=imaging-desaturate) 20:28:19 INFO - PROCESS | 16886 | RSS: Main: 154726400 20:28:19 INFO - PROCESS | 16886 | 20:28:22 INFO - PROCESS | 16886 | Cycle 1(1): loaded http://localhost:52115/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52115/tests/kraken/driver.html?testName=json-parse-financial) 20:28:23 INFO - PROCESS | 16886 | RSS: Main: 156430336 20:28:23 INFO - PROCESS | 16886 | 20:28:24 INFO - PROCESS | 16886 | Cycle 1(1): loaded http://localhost:52115/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52115/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:28:25 INFO - PROCESS | 16886 | RSS: Main: 156209152 20:28:25 INFO - PROCESS | 16886 | 20:28:27 INFO - PROCESS | 16886 | Cycle 1(1): loaded http://localhost:52115/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52115/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:28:27 INFO - PROCESS | 16886 | RSS: Main: 156368896 20:28:27 INFO - PROCESS | 16886 | 20:28:29 INFO - PROCESS | 16886 | Cycle 1(1): loaded http://localhost:52115/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52115/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:28:30 INFO - PROCESS | 16886 | RSS: Main: 157462528 20:28:30 INFO - PROCESS | 16886 | 20:28:33 INFO - PROCESS | 16886 | Cycle 1(1): loaded http://localhost:52115/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52115/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:28:33 INFO - PROCESS | 16886 | RSS: Main: 157229056 20:28:33 INFO - PROCESS | 16886 | 20:28:36 INFO - PROCESS | 16886 | Cycle 1(1): loaded http://localhost:52115/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52115/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:28:37 INFO - PROCESS | 16886 | RSS: Main: 157265920 20:28:37 INFO - PROCESS | 16886 | 20:28:38 INFO - PROCESS | 16886 | Cycle 1(1): loaded http://localhost:52115/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52115/tests/kraken/driver.html?testName=ai-astar) 20:28:39 INFO - PROCESS | 16886 | RSS: Main: 158433280 20:28:39 INFO - PROCESS | 16886 | 20:28:39 INFO - PROCESS | 16886 | __start_tp_report 20:28:39 INFO - PROCESS | 16886 | _x_x_mozilla_page_load 20:28:39 INFO - PROCESS | 16886 | _x_x_mozilla_page_load_details 20:28:39 INFO - PROCESS | 16886 | |i|pagename|runs| 20:28:39 INFO - PROCESS | 16886 | |0;ai-astar;112;112;107;113;113;113;114;112;113;115 20:28:39 INFO - PROCESS | 16886 | |1;audio-beat-detection;146;115;148;177;117;148;148;118;169;120 20:28:39 INFO - PROCESS | 16886 | |2;audio-dft;162;161;163;160;160;163;162;160;161;163 20:28:39 INFO - PROCESS | 16886 | |3;audio-fft;75;80;75;179;76;76;76;75;184;77 20:28:39 INFO - PROCESS | 16886 | |4;audio-oscillator;84;84;155;84;83;85;138;83;83;147 20:28:39 INFO - PROCESS | 16886 | |5;imaging-gaussian-blur;117;117;117;117;117;118;117;117;118;120 20:28:39 INFO - PROCESS | 16886 | |6;imaging-darkroom;148;148;149;147;147;146;148;147;147;148 20:28:39 INFO - PROCESS | 16886 | |7;imaging-desaturate;95;96;95;95;96;96;95;95;95;95 20:28:39 INFO - PROCESS | 16886 | |8;json-parse-financial;52;53;55;54;51;54;58;56;51;54 20:28:39 INFO - PROCESS | 16886 | |9;json-stringify-tinderbox;61;60;61;61;61;59;59;60;60;60 20:28:39 INFO - PROCESS | 16886 | |10;stanford-crypto-aes;74;74;78;72;80;81;73;72;79;72 20:28:39 INFO - PROCESS | 16886 | |11;stanford-crypto-ccm;121;134;135;122;120;130;120;130;197;117 20:28:39 INFO - PROCESS | 16886 | |12;stanford-crypto-pbkdf2;155;158;158;151;155;153;167;153;154;154 20:28:39 INFO - PROCESS | 16886 | |13;stanford-crypto-sha256-iterative;62;69;66;65;62;62;65;63;62;61 20:28:39 INFO - PROCESS | 16886 | __end_tp_report 20:28:39 INFO - PROCESS | 16886 | __start_cc_report 20:28:39 INFO - PROCESS | 16886 | _x_x_mozilla_cycle_collect,888 20:28:39 INFO - PROCESS | 16886 | __end_cc_report 20:28:39 INFO - PROCESS | 16886 | __startTimestamp1471490919148__endTimestamp 20:28:39 INFO - PROCESS | 16886 | 20:28:39 INFO - PROCESS | 16886 | ------- Summary: start ------- 20:28:39 INFO - PROCESS | 16886 | Number of tests: 14 20:28:39 INFO - PROCESS | 16886 | 20:28:39 INFO - PROCESS | 16886 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.00 stddev:2.12 (1.9%) stddev-sans-first:2.24 20:28:39 INFO - PROCESS | 16886 | Values: 112.0 112.0 107.0 113.0 113.0 113.0 114.0 112.0 113.0 115.0 20:28:39 INFO - PROCESS | 16886 | 20:28:39 INFO - PROCESS | 16886 | [#1] audio-beat-detection Cycles:10 Average:140.60 Median:148.00 stddev:22.29 (15.1%) stddev-sans-first:23.56 20:28:39 INFO - PROCESS | 16886 | Values: 146.0 115.0 148.0 177.0 117.0 148.0 148.0 118.0 169.0 120.0 20:28:39 INFO - PROCESS | 16886 | 20:28:39 INFO - PROCESS | 16886 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.27 (0.8%) stddev-sans-first:1.33 20:28:39 INFO - PROCESS | 16886 | Values: 162.0 161.0 163.0 160.0 160.0 163.0 162.0 160.0 161.0 163.0 20:28:39 INFO - PROCESS | 16886 | 20:28:39 INFO - PROCESS | 16886 | [#3] audio-fft Cycles:10 Average:97.30 Median:76.00 stddev:44.42 (58.4%) stddev-sans-first:46.37 20:28:39 INFO - PROCESS | 16886 | Values: 75.0 80.0 75.0 179.0 76.0 76.0 76.0 75.0 184.0 77.0 20:28:39 INFO - PROCESS | 16886 | 20:28:39 INFO - PROCESS | 16886 | [#4] audio-oscillator Cycles:10 Average:102.60 Median:83.50 stddev:30.68 (36.7%) stddev-sans-first:31.79 20:28:39 INFO - PROCESS | 16886 | Values: 84.0 84.0 155.0 84.0 83.0 85.0 138.0 83.0 83.0 147.0 20:28:39 INFO - PROCESS | 16886 | 20:28:39 INFO - PROCESS | 16886 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.00 stddev:0.97 (0.8%) stddev-sans-first:1.01 20:28:39 INFO - PROCESS | 16886 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 118.0 120.0 20:28:39 INFO - PROCESS | 16886 | 20:28:39 INFO - PROCESS | 16886 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 20:28:39 INFO - PROCESS | 16886 | Values: 148.0 148.0 149.0 147.0 147.0 146.0 148.0 147.0 147.0 148.0 20:28:39 INFO - PROCESS | 16886 | 20:28:39 INFO - PROCESS | 16886 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 20:28:39 INFO - PROCESS | 16886 | Values: 95.0 96.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 20:28:39 INFO - PROCESS | 16886 | 20:28:39 INFO - PROCESS | 16886 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:2.20 (4.1%) stddev-sans-first:2.24 20:28:39 INFO - PROCESS | 16886 | Values: 52.0 53.0 55.0 54.0 51.0 54.0 58.0 56.0 51.0 54.0 20:28:39 INFO - PROCESS | 16886 | 20:28:39 INFO - PROCESS | 16886 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.50 stddev:0.79 (1.3%) stddev-sans-first:0.78 20:28:39 INFO - PROCESS | 16886 | Values: 61.0 60.0 61.0 61.0 61.0 59.0 59.0 60.0 60.0 60.0 20:28:39 INFO - PROCESS | 16886 | 20:28:39 INFO - PROCESS | 16886 | [#10] stanford-crypto-aes Cycles:10 Average:75.50 Median:76.00 stddev:3.60 (4.7%) stddev-sans-first:3.77 20:28:39 INFO - PROCESS | 16886 | Values: 74.0 74.0 78.0 72.0 80.0 81.0 73.0 72.0 79.0 72.0 20:28:39 INFO - PROCESS | 16886 | 20:28:39 INFO - PROCESS | 16886 | [#11] stanford-crypto-ccm Cycles:10 Average:132.60 Median:130.00 stddev:23.51 (18.1%) stddev-sans-first:24.56 20:28:39 INFO - PROCESS | 16886 | Values: 121.0 134.0 135.0 122.0 120.0 130.0 120.0 130.0 197.0 117.0 20:28:39 INFO - PROCESS | 16886 | 20:28:39 INFO - PROCESS | 16886 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.80 Median:155.00 stddev:4.49 (2.9%) stddev-sans-first:4.76 20:28:39 INFO - PROCESS | 16886 | Values: 155.0 158.0 158.0 151.0 155.0 153.0 167.0 153.0 154.0 154.0 20:28:39 INFO - PROCESS | 16886 | 20:28:39 INFO - PROCESS | 16886 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.00 stddev:2.50 (3.9%) stddev-sans-first:2.57 20:28:39 INFO - PROCESS | 16886 | Values: 62.0 69.0 66.0 65.0 62.0 62.0 65.0 63.0 62.0 61.0 20:28:39 INFO - PROCESS | 16886 | -------- Summary: end -------- 20:28:39 INFO - PROCESS | 16886 | 20:28:40 INFO - TEST-INFO | 16886: exit 0 20:28:40 INFO - TEST-OK | kraken | took 60550ms 20:28:40 INFO - SUITE-END | took 1170s 20:28:40 INFO - Completed test suite (00:19:30) 20:28:40 INFO - javascript benchmark 20:28:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7659.834422168348, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3199.1362332170315, 3207.887723929663, 3217.6943190396905, 3230.7253883419917, 3245.496947973065, 5581.637193582419, 5622.409646987069, 5641.182028605855, 5656.943430565693, 5673.659580425177, 5522.530584900288, 5537.086380747182, 5563.527100196488, 5595.608307418473, 5653.1520271959225, 5069.873253168664, 5113.974430127862, 5175.430702622709, 5193.117170081076, 5212.192110222922, 4991.151504244269, 5029.270755740416, 5073.239014147871, 5105.719185444799, 5150.896982060375, 5112.1564941784745, 5121.948780512184, 5135.563477104451, 5202.115640341151, 5259.13224317989, 5174.068667639824, 5176.58587313016, 5187.429382767892, 5194.4026436959475, 5222.399424066243, 4906.429942418427, 4929.728864912428, 5060.595152387837, 5081.8475445736685, 5160.690358578498, 5398.190271459273, 5487.067198576252, 5497.890042199134, 5514.145307477307, 5593.860153496154, 5970.641761494281, 6006.96996515019, 6016.75932962681, 6035.185249991239, 6039.214902062704, 5763.308402991668, 6068.726907289182, 6069.57512974092, 6072.119542666289, 6077.270727512727, 5540.806071787468, 5569.053260945609, 5577.470140336702, 5622.746976386073, 5650.237217975603, 6061.969690151521, 6097.542684298695, 6114.877702445926, 6119.173911521888, 6119.84700382494, 5650.152477128381, 5788.913166302509, 5845.0, 5847.619904706181, 5848.736806843703, 5861.472467477947, 5863.648181109147, 5925.674087925119, 5959.314678811906, 5976.223090998229, 5882.676452795052, 5921.171036054956, 5928.525717942554, 5953.613015154001, 5957.165996760457, 5689.630174038757, 5920.79277225295, 5944.494717949023, 5966.910496342558, 5987.161797348374, 4536.546345365437, 4579.9084018319445, 4582.747948862844, 4636.675432719745, 4660.5106463821485, 4118.608732170439, 4122.814473348706, 4129.876103716893, 4143.047099167208, 4144.026153853842, 5539.0, 5850.707464626752, 5856.4143585641095, 5858.765649373977, 5870.354261031369, 5954.642721436728, 5972.432618901197, 5987.371326010793, 6019.909701354483, 6038.18484504595, 5707.600467967285, 5719.227904232958, 5721.170430287585, 5743.54051675865, 5771.134329850556, 4889.9022019560125, 5025.6482046256415, 5048.217526283432, 5057.0, 5110.66780659256, 6117.113018612276, 6186.505079593621, 6195.2255968004, 6278.6546739929745, 6280.654563998933, 5997.0, 6028.8794224116145, 6034.275886893601, 6043.969780151071, 6055.697215139314, 5866.853328666817, 6107.969460152848, 6202.968985155046, 6254.906176407267, 6266.68666566679, 5835.56233282514, 5874.942510348178, 5878.382769809108, 5920.763169473173, 5921.0, 5919.526437884872, 5950.434708702666, 5988.28140623128, 6006.789762358297, 6017.127516510169, 5603.467670571289, 5838.474537291664, 5867.647941123546, 5899.705014749331, 5908.911366329423, 5818.127280907728, 5893.882122357614, 5905.35041145465, 5954.880902382015, 5956.910646340221, 5833.329167145663, 5856.853578660568, 5858.619189752652, 5865.354810970704, 5866.853328666817, 5636.0, 5805.854853628524, 5936.910946335895, 5940.79207227745, 5989.431004054608, 5668.744906479136, 5760.654360738369, 5779.624324418899, 5780.537556995514, 5804.303483581997], "value": 5519.307204340409, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.616099535302, 655.9016147577864, 663.0816319397634, 688.3804575881705, 713.176281394989, 41538.792306038464, 45390.0, 45591.088178236416, 45693.0, 45793.77103114484, 46037.30944035842, 46493.535064649346, 46509.30236046462, 46525.53474465254, 46556.0, 9150.313726470507, 9268.212201962808, 9292.535373231345, 9298.209652179572, 9303.441793492411, 9189.40268882524, 9252.444853308789, 9276.72169834906, 9282.257419406431, 9346.39248448852, 9345.345825792198, 9350.298727595424, 9384.39001464906, 9401.012893646172, 9404.200642945323, 9225.0, 9287.76780580484, 9316.953415232914, 9337.393069450463, 9367.531623418801, 9152.771180720536, 9153.0, 9165.679201227926, 9246.26029917605, 9269.165775080275, 43296.56703432957, 43934.78032609849, 44268.55731442709, 44396.3340549892, 44429.555704442864, 3730.8401132737076, 3860.478835357219, 4203.516595591515, 4590.586847183769, 4627.791749371287, 35290.11774705627, 35319.0, 35734.64265357339, 36801.26397472063, 36853.0, 4547.772611369418, 4755.405574303212, 4898.461169271377, 4920.360353154103, 4964.503549645043, 395922.0, 396238.0, 398961.0, 401704.0, 402439.98780006205, 36665.45001824975, 66997.0, 67545.66227168833, 67602.32397675961, 67615.66192169106, 38522.61477385247, 40115.39826902599, 40564.59435405667, 40910.79544602258, 41013.589864101574, 17901.7314740279, 17963.0, 18067.0, 18081.276748929897, 18106.366277180234, 14593.343299551545, 14676.119432834064, 14723.116613003254, 14729.852701472848, 14763.704725905422, 9037.909620903838, 9116.772080698036, 9120.087991200828, 9130.178283954476, 9180.632774688938, 3498.440249560058, 3538.7522873398616, 3552.0942159749097, 3576.3204991051616, 3584.6415358464465, 1074.2802322443981, 1084.810158222308, 1132.116948779953, 1160.6265187691192, 1192.362086283834, 35189.82405087958, 35196.47205291923, 35343.82328088343, 35619.4657080144, 35701.82149089238, 1146.2148428326623, 1175.435790820411, 1176.276589897207, 1182.7338848758961, 1214.2297818351105, 17300.65398692019, 17364.4790656278, 17463.650726985645, 17484.300627974993, 17567.033813140144, 640840.0, 643812.0, 644686.0, 645343.0, 650389.0, 63658.0, 64305.678471607345, 64367.67816160889, 64412.0, 64502.0, 1448.6957738874955, 1462.3565631122271, 1470.162007655626, 1487.9032862863878, 1520.9771853422208, 32614.673853261163, 32907.0, 33300.83349583237, 33358.499622505195, 33659.663403366634, 55587.44412555823, 56489.15266271091, 56616.43383566276, 56661.43338566727, 56665.0, 526418.0, 527884.0, 529860.0, 530950.0, 533005.0, 29915.401691965602, 30535.389292214477, 31713.20716982094, 31879.681203187673, 32736.508952365257, 52274.477255228485, 52464.73767631137, 52804.73597632141, 54075.18887216616, 54664.0, 44105.11789764123, 44543.0, 45126.54873451223, 45895.0, 46080.769596151804, 46397.76801115973, 46868.7656561715, 47233.0, 47520.7623961878, 47543.52456475391, 42395.0, 43517.78241108901, 44174.55825441705, 45594.54405455903, 45934.31098533591, 34242.82878585591, 35016.44802029282, 35031.82484087563, 35406.822965885, 35721.0, 30271.243218919702, 30678.693213068476, 30978.058573336177, 31144.0, 31438.68561314449], "value": 20656.435531742056, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.6749496675308, 385.5238780106568, 395.1425406867098, 395.6636858670131, 411.4856429463171, 14774.926125369358, 19312.0, 20128.295509657164, 20806.271780487685, 20871.68692469612, 19814.20743170275, 20316.085776140073, 20436.182552697876, 20678.0, 20700.8964955175, 5393.352797664276, 5886.234789477383, 6053.697315134225, 6108.755649774003, 6150.077488376757, 5892.204552385438, 6119.2350956130485, 6164.0, 6165.599236049665, 6166.260048794151, 5321.760520776575, 5495.53287970523, 5499.752511137009, 5503.642263252896, 5551.0, 5456.127019676853, 5462.9726851365485, 5481.75332110054, 5508.614396992212, 5508.669479831223, 5180.766865491024, 5306.655067420644, 5345.251664766935, 5360.973195133999, 5372.167314066326, 14129.576112716635, 14238.216898070603, 14251.287435628281, 14283.428662853474, 14401.78397324041, 2416.9516609667708, 2729.4131761671138, 3078.815271083742, 3103.224193951512, 3183.7771356005087, 13663.043586948917, 14976.775348369783, 15145.394184232617, 15170.620734481616, 15656.686866262726, 2017.8991050447567, 2057.1565658080117, 2065.4423305707523, 2071.219303525148, 2135.540858715384, 77221.61389193074, 86300.56849715774, 86492.13507864966, 86674.99999999937, 89907.0, 10559.63041293551, 10878.40168790724, 10954.452277386099, 11648.126390520745, 11670.533178672758, 16384.672306553803, 16388.836111638968, 16393.0, 16411.91794041022, 16419.67160656804, 8819.691310804092, 8936.872094766779, 9074.682386116454, 9092.408993415407, 9094.95408028072, 8952.28381729473, 8958.955205223932, 9023.503707296031, 9116.498592577473, 9149.81700365989, 4459.10817836434, 4528.909421811545, 4977.527134922177, 5030.346055012825, 5139.845804625792, 1979.70304454333, 1989.4926793667812, 2046.785087565814, 2068.844836637258, 2089.3731880435807, 990.7325022244098, 994.22450488619, 1008.3798463944621, 1040.661784919904, 1084.0677017764715, 20328.390148295573, 20766.688499672517, 20852.1659133636, 20866.165353385695, 21170.894145529175, 1046.424466543398, 1058.5977328615231, 1075.93544387337, 1078.2991055813784, 1086.5436516663021, 11116.722081948015, 11473.655790326304, 11557.595484158013, 11607.883921160848, 11722.472488738027, 452933.0, 470776.9208512468, 477895.0, 478498.0, 480596.0, 90746.54626726825, 94062.0593794067, 94505.0, 96679.0, 98668.50665746625, 1089.2048804372853, 1127.3799410324452, 1138.2089447833841, 1154.6247469572422, 1160.2864238493435, 18619.627607447503, 18910.432687019413, 19258.037098145316, 19481.610367792848, 19499.512512186742, 41186.17627647371, 45240.32139517976, 45457.54542454665, 45777.0, 46514.76742616265, 64033.35966640274, 64790.35209647843, 65195.67402162959, 65919.68160636665, 67176.32823671897, 8661.842315688378, 8706.0, 8748.606312715816, 8804.955975220082, 8857.424267422597, 9578.425294482353, 12448.31534265624, 13130.146540474838, 13811.033227673966, 14184.0, 11312.94343528277, 11468.541258349573, 11551.0, 11616.361100139235, 11652.708682283012, 11549.538018479167, 12003.0, 12117.81823272634, 12243.265404075784, 12576.30830304342, 8228.588570571328, 8465.534395608302, 8483.533405662747, 8564.272036876935, 11643.0, 12249.755004900031, 12752.872471275168, 12992.935035324763, 13077.280749558866, 13260.005499587376, 11768.35274059935, 12008.159428840247, 12055.216410933612, 12183.208091474025, 12251.571195008131], "value": 9600.821325876388, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1555.8521940415665, 1589.848964348387, 1762.9823701762987, 1841.0426578179338, 1856.229664689154, 8539.0, 9206.815863682723, 9210.0, 9876.25928055396, 9920.255980801441, 9424.481653509054, 9482.241420686345, 9531.28515361349, 9549.665761698341, 9571.712848614536, 2419.806415486761, 2458.299384675368, 2465.0632759551345, 2467.494163696447, 2472.5054989002183, 2404.410919324759, 2461.4215659320043, 2464.112919349033, 2482.689663792026, 2485.8632775197357, 2392.1746997285995, 2430.6232533957177, 2433.6592876997233, 2434.7443518430578, 2447.0823441209545, 2330.9533809323802, 2349.5653304138705, 2351.929442116739, 2390.5816482115733, 2415.5772739770646, 2364.7398786133513, 2370.0638247891984, 2372.5847976604027, 2379.690640216778, 2386.3914701751114, 9620.182284505825, 9646.083622055963, 9652.131308182297, 9666.468344241064, 9722.854157187649, 5460.31746031746, 5625.915611265835, 5628.493435590816, 5634.126710359901, 5640.125780504029, 3432.5880894292595, 3464.4110501214855, 3503.4744788281705, 3540.6459354064386, 3564.3584154852115, 1163.4066626020706, 1182.2020136407975, 1182.8284898689642, 1189.1854079955258, 1210.3766560221493, 13425.462981480729, 13440.19358838463, 13465.0, 13501.392437340244, 13561.932190339085, 4622.583967442946, 4672.883177920511, 4858.80564777412, 4868.318435419044, 4882.707037577757, 11334.206605537533, 11358.94320528392, 11375.715607109723, 11379.260348077349, 11486.770264594661, 5603.187537806995, 5625.6905870176715, 5631.6902570359025, 5650.26546548946, 5656.095024796013, 4607.6313894889, 4981.576565991932, 5084.77118529667, 5119.744012799345, 5234.319538459976, 4206.0, 4329.631981281564, 4330.523642399334, 4351.521332653406, 4394.538573449806, 1302.5896842494583, 1329.1094966372555, 1339.3102552185633, 1341.2019848190312, 1344.5226944434585, 934.2712684106408, 1015.0002247785925, 1036.7045392063226, 1056.2236755984345, 1060.6340812419703, 6363.0, 6387.073874288202, 6468.2561505427475, 6489.786801022505, 6553.672316384162, 449.94150760400936, 457.1451385908373, 459.2032823052002, 459.9563041511051, 463.6870112673999, 4439.933400998988, 4480.529544397857, 4548.931766023512, 4592.127495775792, 4596.4024676791805, 11694.590689326003, 12043.397830108459, 12073.034157267397, 12166.817497737364, 12172.147949643617, 11319.717007074889, 11989.580364687194, 12036.87963120375, 12058.698532536757, 12113.212641178296, 8888.466691998501, 9093.408928419763, 9105.908940910505, 9108.817823643623, 9110.0, 6588.769393071219, 6623.768168114093, 6638.933610663831, 6754.763583274562, 6858.074159988537, 11109.222354435113, 11272.323660580392, 11335.376554289593, 11356.886431135583, 11462.94268528652, 11398.145139114766, 11475.483603237708, 11499.597514087302, 11587.826182607436, 11607.6517704469, 8544.658213671384, 8708.303335732999, 8722.0, 8750.47497150173, 8777.078406767198, 8721.91278087211, 9378.109079637423, 9392.342536022687, 9472.905270947202, 9512.239020878174, 8321.251087402163, 8369.372297077622, 8384.32925365957, 8387.329013679013, 8539.487630742175, 8073.919260807552, 8075.636596353061, 8182.713605023796, 8245.051819040647, 8255.876161857697, 7432.739854105081, 7452.180260171485, 7488.5506869588, 7502.0, 7510.0, 5450.754716037867, 5541.0, 5591.468810463162, 5660.801871934463, 5713.685747283939, 5511.944880551143, 5512.145617429305, 5593.412691667317, 5655.349634791887, 5691.117876729114], "value": 4895.275836810124, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.08588639933197, 327.55711092636943, 328.29416753978944, 330.38548300161705, 338.97796643218174, 5595.580331475136, 5733.254676891998, 5752.769889204432, 5828.30060392753, 5840.766369345227, 5704.258446401972, 5771.567132465061, 5773.220615216945, 5794.203796822988, 5833.8833223335505, 4492.371068050467, 4496.0, 4523.208438523246, 4525.660575456837, 4534.591886730193, 4455.84404545841, 4521.937344723987, 4545.659075569329, 4551.726896386211, 4555.863324100283, 4460.107978404316, 4494.730316181023, 4500.437445319335, 4500.774961251941, 4510.278355463127, 4485.551444855521, 4524.728516289, 4533.685231282908, 4572.611328037121, 4588.678792484528, 3858.49518687712, 3945.7237993340477, 3972.165845172517, 4027.97986010071, 4039.697022723278, 5694.373618901917, 5719.28508936383, 5730.255066841326, 5733.397993210736, 5759.65442073477, 5123.744682552761, 5146.330976973007, 5180.637355385087, 5202.739863006835, 5212.765425555859, 5851.6008436540815, 6025.578209525335, 6044.697765111727, 6079.513638908877, 6094.481969032638, 4380.386745855582, 4390.209762242795, 4405.273129933589, 4405.691601587891, 4406.537313582092, 6275.780347687809, 6325.620462772248, 6334.334894836068, 6400.263969643504, 6439.8068057958335, 4426.15902978433, 4443.755593442327, 4458.977705111453, 4462.843800466968, 4464.129494748493, 4525.094981003813, 4529.297958816389, 4529.750863702462, 4531.252343363308, 4534.206513860061, 5158.63889527737, 5182.222666600041, 5190.92213616796, 5202.089634314056, 5217.295665085241, 5822.534197264294, 5920.585559010828, 6077.9392206078255, 6139.6009259398, 6182.598131121463, 1442.6104951662992, 1497.7867926979181, 1508.1629695518873, 1509.1548732709718, 1511.8110236220473, 920.5903372999085, 940.5955439161227, 944.891337496183, 952.0, 964.9228061755043, 5187.740612969412, 5221.738913054332, 5228.37259528859, 5253.159494480941, 5275.786569089131, 5460.645058071292, 5490.890182196414, 5498.890022199534, 5506.678397184647, 5514.724263786875, 5117.437081920985, 5250.527452529291, 5281.551068159172, 5282.81510147143, 5315.245968830277, 2944.911652650424, 2998.190488568118, 3002.4445477586714, 3012.51799712045, 3025.4570169213857, 5663.518600918968, 5665.26949996749, 5680.346760122557, 5695.895736823441, 5726.226959360433, 5269.736513174403, 5550.750216240279, 5602.38373778884, 5621.943780562224, 5659.773609055592, 5724.370319264877, 5741.999999999916, 5760.790234050896, 5791.391903850035, 5793.681347525842, 5524.613277070566, 5570.637908535932, 5610.298712660918, 5835.912461313169, 6368.745250189941, 6195.2255968004, 6220.377962203744, 6230.43926046658, 6257.342978987141, 6274.717637706223, 6294.929861923392, 6592.340765923561, 6634.800955971135, 6660.433863121689, 6661.367170118831, 4252.851150209728, 4309.6767742418815, 4317.805698743501, 4323.437953066082, 4361.0, 6112.908306375319, 6124.845704462116, 6409.262934762562, 6412.61524308543, 6414.967925160345, 6141.232345956755, 6152.846178845564, 6185.381461853779, 6190.2571691397325, 6209.0, 6093.786717464867, 6139.539534534839, 6161.322254551906, 6201.224846894138, 6230.719617617127, 6037.63774173551, 6050.364711705208, 6055.515558755201, 6116.26604807426, 6119.632822030514, 6156.29202641702, 6194.0798352510865, 6223.635018692868, 6251.843703907439, 6267.717952692049, 5891.556568640711, 6002.429769171922, 6033.818985430444, 6067.696615169136, 6130.938690613215], "value": 4514.619893127402, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [788.530824159625, 821.909589945106, 835.4152093534527, 886.1448702002566, 933.8785957825481, 15882.444114455982, 17038.48884533463, 17927.01401422921, 18052.4584262472, 18119.547011324725, 15939.681206375866, 16046.518604441857, 16048.919755401235, 16066.437674681389, 16094.83905160948, 889.7908991387019, 891.652255620307, 913.8126684029792, 921.9585118669676, 922.077922077922, 912.4935660708304, 917.1516347378681, 920.0293690156882, 920.6501529418812, 921.5484412637826, 949.6154057606681, 951.0679534056628, 955.1928620315857, 956.0535070280407, 958.750724811547, 947.6398968392001, 952.6379975609259, 954.9188318992894, 955.9044095590455, 956.416585882611, 699.1191099214975, 702.9507934444591, 703.7255470366562, 705.0341032785066, 706.3536863769644, 16692.081935493545, 16866.831331686648, 16919.57701057471, 16965.915170424192, 17010.234539445755, 16183.514494565065, 16457.07142113011, 16463.259153338127, 16656.75014874778, 16748.162591870358, 13219.140755850838, 13324.0, 13694.452221911111, 13907.513237036756, 14028.579142625635, 4005.379166229239, 4070.9185816283803, 4086.7752273624938, 4131.153113611703, 4154.543000269968, 81778.59110704467, 83660.16339836645, 83850.58074709648, 84270.0, 84410.99999999939, 11879.40602969848, 12367.196132251374, 12443.626691199097, 12576.30830304342, 12740.36298185087, 22228.55542889133, 22288.777112228996, 22303.0, 22309.330720078422, 22380.552388952456, 8949.0, 9100.226480749077, 9116.544172791333, 9188.173064424234, 9218.170364667078, 5211.348581427322, 5297.205419187153, 5343.7862485500145, 5379.955646621639, 5465.0, 3759.6240375962734, 3912.941305880414, 3939.684825213976, 3942.940855887164, 3946.5856085111222, 665.9067730517731, 675.7161991963387, 685.1606781692486, 698.1587187439123, 709.51752808091, 818.4925346285341, 824.9248711365954, 837.9245867871921, 858.9914100859037, 860.9009963854237, 9926.35478693897, 10131.392116473035, 10373.118284945713, 10689.572417103229, 10718.517666705016, 672.1329484964439, 697.5361384679233, 748.4349316266184, 764.3121190928209, 769.6882762481204, 4499.0, 4814.566688997937, 4820.301056346881, 4839.41926968766, 4865.829695960695, 78567.60716196382, 133665.0, 135827.0, 137996.48014079526, 139988.3000585011, 113703.0, 117590.41204793921, 117741.41129294298, 118503.0, 121178.3941080289, 98727.0, 101569.0, 101974.0, 102624.0, 104782.0, 9000.50497222659, 9367.531623418938, 9391.624335026523, 9488.33581649278, 9561.378510396802, 51068.74465627648, 58139.127913082186, 58338.416615833296, 58813.70593147007, 59025.70487147537, 52434.0, 69662.30337696559, 69914.30085699282, 70085.0, 75032.62483687546, 14173.964502926627, 14197.574072777834, 14628.707425851637, 14633.268336582916, 15516.534503964898, 15202.543923682308, 15244.77132842986, 15861.762073569136, 16513.091779952218, 16881.240344184294, 15495.14776687293, 15726.842731572538, 16399.590010249838, 16467.67064658724, 16656.666866662355, 14830.258487075818, 15331.156786376856, 15553.68892622164, 16291.918540407221, 16297.429589964295, 15288.61778455503, 15634.9218253908, 15706.764398533802, 15774.0, 16652.750208746635, 12180.817287740869, 12222.633321000385, 12395.380230988594, 12551.623451296477, 12991.350432478528, 12821.294828784134, 13003.739925201633, 13141.408636611566, 13393.0, 13395.665108372368], "value": 8348.874111232502, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1516.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 107.0, 113.0, 113.0, 113.0, 114.0, 112.0, 113.0, 115.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 115.0, 148.0, 177.0, 117.0, 148.0, 148.0, 118.0, 169.0, 120.0], "value": 140.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 160.0, 160.0, 163.0, 162.0, 160.0, 161.0, 163.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 80.0, 75.0, 179.0, 76.0, 76.0, 76.0, 75.0, 184.0, 77.0], "value": 97.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 155.0, 84.0, 83.0, 85.0, 138.0, 83.0, 83.0, 147.0], "value": 102.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 120.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 149.0, 147.0, 147.0, 146.0, 148.0, 147.0, 147.0, 148.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 55.0, 54.0, 51.0, 54.0, 58.0, 56.0, 51.0, 54.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 61.0, 61.0, 61.0, 59.0, 59.0, 60.0, 60.0, 60.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 78.0, 72.0, 80.0, 81.0, 73.0, 72.0, 79.0, 72.0], "value": 75.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 134.0, 135.0, 122.0, 120.0, 130.0, 120.0, 130.0, 197.0, 117.0], "value": 132.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 158.0, 158.0, 151.0, 155.0, 153.0, 167.0, 153.0, 154.0, 154.0], "value": 155.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 69.0, 66.0, 65.0, 62.0, 62.0, 65.0, 63.0, 62.0, 61.0], "value": 63.7, "unit": "score"}]}]} 20:28:40 INFO - Return code: 0 20:28:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:28:40 ERROR - # TBPL SUCCESS # 20:28:40 INFO - Running post-action listener: _resource_record_post_action 20:28:40 INFO - [mozharness: 2016-08-18 03:28:40.434222Z] Finished run-tests step (success) 20:28:40 INFO - Running post-run listener: _resource_record_post_run 20:28:40 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 330883072; Read time: 12; Write time: 173792 20:28:40 INFO - TinderboxPrint: CPU usage
13.2% 20:28:40 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 20:28:40 INFO - TinderboxPrint: I/O write bytes / time
330,883,072 / 173,792 20:28:40 INFO - TinderboxPrint: CPU idle
8,214.8 (86.7%) 20:28:40 INFO - TinderboxPrint: CPU user
1,202.2 (12.7%) 20:28:40 INFO - TinderboxPrint: Swap in / out
0 / 0 20:28:40 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 77078528; Read time: 0; Write time: 34552 20:28:40 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 253530112; Read time: 12; Write time: 139216 20:28:41 INFO - Running post-run listener: _upload_blobber_files 20:28:41 INFO - Blob upload gear active. 20:28:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:28:41 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:28:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:28:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:28:41 INFO - (blobuploader) - INFO - Open directory for files ... 20:28:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:28:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:28:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:28:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:28:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:28:42 INFO - (blobuploader) - INFO - Done attempting. 20:28:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:28:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:28:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:28:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:28:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:28:45 INFO - (blobuploader) - INFO - Done attempting. 20:28:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:28:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:28:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:28:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:28:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:28:46 INFO - (blobuploader) - INFO - Done attempting. 20:28:46 INFO - (blobuploader) - INFO - Iteration through files over. 20:28:46 INFO - Return code: 0 20:28:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:28:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:28:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d8654d246ac34b5cbdffd9c963baad24727e945b387970ede1bd9bf55c37a6895d4a0407b041991d7b190e715a6be30bb3ff6493d4b8e8ffd84d7c5cb1dfc4a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6f3f8374baedad941ffcbb5282365b88fdeaa51a9ea1e7a5cd5d5b2647ca4e73b919ab11c39efe54ce448d1325d00546c62e28c9e637073651e9c5c26e86b08d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b42e9ee4054b2268a70841b077c374094f8b108fe766b98fbe4fa47ad9b027aa086f2a4c1fce541693d49dee5fb36c5cb081289a488edc14209e68e137d608fe"} 20:28:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:28:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:28:46 INFO - Contents: 20:28:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d8654d246ac34b5cbdffd9c963baad24727e945b387970ede1bd9bf55c37a6895d4a0407b041991d7b190e715a6be30bb3ff6493d4b8e8ffd84d7c5cb1dfc4a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6f3f8374baedad941ffcbb5282365b88fdeaa51a9ea1e7a5cd5d5b2647ca4e73b919ab11c39efe54ce448d1325d00546c62e28c9e637073651e9c5c26e86b08d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b42e9ee4054b2268a70841b077c374094f8b108fe766b98fbe4fa47ad9b027aa086f2a4c1fce541693d49dee5fb36c5cb081289a488edc14209e68e137d608fe"} 20:28:46 INFO - Running post-run listener: copy_logs_to_upload_dir 20:28:46 INFO - Copying logs to upload dir... 20:28:46 INFO - mkdir: /builds/slave/test/build/upload/logs 20:28:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1674.812316 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 54 secs) (at 2016-08-17 20:28:46.663703) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-17 20:28:46.667335) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1471483947.400992-1892230635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d8654d246ac34b5cbdffd9c963baad24727e945b387970ede1bd9bf55c37a6895d4a0407b041991d7b190e715a6be30bb3ff6493d4b8e8ffd84d7c5cb1dfc4a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6f3f8374baedad941ffcbb5282365b88fdeaa51a9ea1e7a5cd5d5b2647ca4e73b919ab11c39efe54ce448d1325d00546c62e28c9e637073651e9c5c26e86b08d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b42e9ee4054b2268a70841b077c374094f8b108fe766b98fbe4fa47ad9b027aa086f2a4c1fce541693d49dee5fb36c5cb081289a488edc14209e68e137d608fe"} build_url:https://queue.taskcluster.net/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011204 build_url: 'https://queue.taskcluster.net/v1/task/N0__1FNGQWiCwW28vLzidA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d8654d246ac34b5cbdffd9c963baad24727e945b387970ede1bd9bf55c37a6895d4a0407b041991d7b190e715a6be30bb3ff6493d4b8e8ffd84d7c5cb1dfc4a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6f3f8374baedad941ffcbb5282365b88fdeaa51a9ea1e7a5cd5d5b2647ca4e73b919ab11c39efe54ce448d1325d00546c62e28c9e637073651e9c5c26e86b08d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b42e9ee4054b2268a70841b077c374094f8b108fe766b98fbe4fa47ad9b027aa086f2a4c1fce541693d49dee5fb36c5cb081289a488edc14209e68e137d608fe"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-17 20:28:46.694139) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 20:28:46.695018) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1471483947.400992-1892230635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004413 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 20:28:46.777879) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-17 20:28:46.778230) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-17 20:28:46.778497) ========= ========= Total master_lag: 0.18 =========