builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-041 starttime: 1472035104.52 results: success (0) buildid: 20160824004001 builduid: c6f6518889fd4558969fa50b85b0737c revision: a72bfbdf5c9b36e68ca806a25944180f2652f0c9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-24 03:38:24.521994) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-24 03:38:24.522670) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-24 03:38:24.522947) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-24 03:38:24.566708) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 03:38:24.566977) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1472030880.976961-587025349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-24 03:38:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 44.4M=0s 2016-08-24 03:38:25 (44.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129233 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 03:38:24.713888) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 03:38:24.714184) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1472030880.976961-587025349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021040 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 03:38:24.766344) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 03:38:24.766657) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a72bfbdf5c9b36e68ca806a25944180f2652f0c9 --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 a72bfbdf5c9b36e68ca806a25944180f2652f0c9 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1472030880.976961-587025349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-24 03:38:25,280 truncating revision to first 12 chars 2016-08-24 03:38:25,280 Setting DEBUG logging. 2016-08-24 03:38:25,280 attempt 1/10 2016-08-24 03:38:25,280 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a72bfbdf5c9b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-24 03:38:25,550 unpacking tar archive at: mozilla-aurora-a72bfbdf5c9b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.583932 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 03:38:25.363593) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-24 03:38:25.363866) ========= script_repo_revision: a72bfbdf5c9b36e68ca806a25944180f2652f0c9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-24 03:38:25.364244) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-24 03:38:25.364516) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-24 03:38:25.376384) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 2 secs) (at 2016-08-24 03:38:25.376667) ========= /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=8c6b6742ce8f6f39ef4ce27d000001f1-1472030880.976961-587025349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:38:25 INFO - MultiFileLogger online at 20160824 03:38:25 in /builds/slave/test 03:38:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:38:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:38:25 INFO - {'append_to_log': False, 03:38:25 INFO - 'base_work_dir': '/builds/slave/test', 03:38:25 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:38:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:38:25 INFO - 'branch': 'Mozilla-Aurora', 03:38:25 INFO - 'buildbot_json_path': 'buildprops.json', 03:38:25 INFO - 'config_files': ('talos/linux_config.py',), 03:38:25 INFO - 'default_actions': ('clobber', 03:38:25 INFO - 'read-buildbot-config', 03:38:25 INFO - 'download-and-extract', 03:38:25 INFO - 'populate-webroot', 03:38:25 INFO - 'create-virtualenv', 03:38:25 INFO - 'install', 03:38:25 INFO - 'run-tests'), 03:38:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:38:25 INFO - 'download_minidump_stackwalk': True, 03:38:25 INFO - 'download_symbols': 'ondemand', 03:38:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:38:25 INFO - 'tooltool.py': '/tools/tooltool.py', 03:38:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:38:25 INFO - '/tools/misc-python/virtualenv.py')}, 03:38:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:38:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:38:25 INFO - 'installer_path': 'installer.exe', 03:38:25 INFO - 'log_level': 'info', 03:38:25 INFO - 'log_name': 'talos', 03:38:25 INFO - 'log_to_console': True, 03:38:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:38:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:38:25 INFO - 'opt_config_files': (), 03:38:25 INFO - 'pip_index': False, 03:38:25 INFO - 'sps_profile': False, 03:38:25 INFO - 'sps_profile_interval': 0, 03:38:25 INFO - 'suite': 'dromaeojs-e10s', 03:38:25 INFO - 'system_bits': '32', 03:38:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:38:25 INFO - 'title': 'talos-linux64-ix-041', 03:38:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:38:25 INFO - 'use_talos_json': True, 03:38:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:38:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:38:25 INFO - 'work_dir': 'build'} 03:38:25 INFO - [mozharness: 2016-08-24 10:38:25.981487Z] Running clobber step. 03:38:25 INFO - Running pre-action listener: _resource_record_pre_action 03:38:25 INFO - Running main action method: clobber 03:38:25 INFO - rmtree: /builds/slave/test/build 03:38:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:38:26 INFO - Running post-action listener: _resource_record_post_action 03:38:26 INFO - [mozharness: 2016-08-24 10:38:26.446350Z] Finished clobber step (success) 03:38:26 INFO - [mozharness: 2016-08-24 10:38:26.446450Z] Running read-buildbot-config step. 03:38:26 INFO - Running pre-action listener: _resource_record_pre_action 03:38:26 INFO - Running main action method: read_buildbot_config 03:38:26 INFO - Using buildbot properties: 03:38:26 INFO - { 03:38:26 INFO - "project": "", 03:38:26 INFO - "product": "firefox", 03:38:26 INFO - "script_repo_revision": "production", 03:38:26 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:38:26 INFO - "repository": "", 03:38:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:38:26 INFO - "buildid": "20160824004001", 03:38:26 INFO - "stage_platform": "linux64-pgo", 03:38:26 INFO - "basedir": "/builds/slave/test", 03:38:26 INFO - "nightly_build": "True", 03:38:26 INFO - "buildnumber": 469, 03:38:26 INFO - "slavename": "talos-linux64-ix-041", 03:38:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:38:26 INFO - "platform": "ubuntu64_hw", 03:38:26 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:38:26 INFO - "branch": "mozilla-aurora", 03:38:26 INFO - "repo_path": "releases/mozilla-aurora", 03:38:26 INFO - "revision": "a72bfbdf5c9b36e68ca806a25944180f2652f0c9", 03:38:26 INFO - "pgo_build": "True", 03:38:26 INFO - "builduid": "c6f6518889fd4558969fa50b85b0737c", 03:38:26 INFO - "slavebuilddir": "test" 03:38:26 INFO - } 03:38:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 03:38:26 INFO - Running post-action listener: _resource_record_post_action 03:38:26 INFO - [mozharness: 2016-08-24 10:38:26.448976Z] Finished read-buildbot-config step (success) 03:38:26 INFO - [mozharness: 2016-08-24 10:38:26.449065Z] Running download-and-extract step. 03:38:26 INFO - Running pre-action listener: _resource_record_pre_action 03:38:26 INFO - Running main action method: download_and_extract 03:38:26 INFO - mkdir: /builds/slave/test/build/tests 03:38:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:26 INFO - https://queue.taskcluster.net/v1/task/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:38:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:38:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:38:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/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 03:38:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/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 03:38:26 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:38:26 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:38:26 INFO - retry: Failed, sleeping 30 seconds before retrying 03:38:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/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 03:38:56 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:38:56 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:38:56 INFO - retry: Failed, sleeping 60 seconds before retrying 03:39:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/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 03:39:56 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:39:56 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:39:56 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/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! 03:39:56 INFO - Caught exception: HTTP Error 404: Not Found 03:39:56 INFO - Caught exception: HTTP Error 404: Not Found 03:39:56 INFO - Caught exception: HTTP Error 404: Not Found 03:39:56 INFO - trying https://queue.taskcluster.net/v1/task/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:39:56 INFO - Downloading https://queue.taskcluster.net/v1/task/M3_4sXe8SUikK_eYtJaosw/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 03:39:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M3_4sXe8SUikK_eYtJaosw/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 03:39:57 INFO - Downloaded 1361 bytes. 03:39:57 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:39:57 INFO - Using the following test package requirements: 03:39:57 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:39:57 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:57 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:39:57 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:57 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:39:57 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:57 INFO - u'jsshell-linux-x86_64.zip'], 03:39:57 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:57 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:39:57 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:39:57 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:57 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:39:57 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:57 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:39:57 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:57 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:39:57 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:57 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:39:57 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:39:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:57 INFO - https://queue.taskcluster.net/v1/task/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:39:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:39:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:39:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/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 03:39:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/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 03:39:57 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:39:57 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:39:57 INFO - retry: Failed, sleeping 30 seconds before retrying 03:40:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/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 03:40:27 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:40:27 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:40:27 INFO - retry: Failed, sleeping 60 seconds before retrying 03:41:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/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 03:41:27 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:41:27 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:41:27 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/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! 03:41:27 INFO - Caught exception: HTTP Error 404: Not Found 03:41:27 INFO - Caught exception: HTTP Error 404: Not Found 03:41:27 INFO - Caught exception: HTTP Error 404: Not Found 03:41:27 INFO - trying https://queue.taskcluster.net/v1/task/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:41:27 INFO - Downloading https://queue.taskcluster.net/v1/task/M3_4sXe8SUikK_eYtJaosw/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 03:41:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M3_4sXe8SUikK_eYtJaosw/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 03:41:28 INFO - Downloaded 21770217 bytes. 03:41:28 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'] 03:41:28 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 03:41:29 INFO - Return code: 0 03:41:29 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 03:41:29 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')]} 03:41:29 INFO - https://queue.taskcluster.net/v1/task/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:41:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:41:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:41:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/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 03:41:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/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 03:41:29 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:41:29 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:41:29 INFO - retry: Failed, sleeping 30 seconds before retrying 03:41:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/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 03:41:59 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:41:59 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:41:59 INFO - retry: Failed, sleeping 60 seconds before retrying 03:42:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/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 03:42:59 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:42:59 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:42:59 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/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! 03:42:59 INFO - Caught exception: HTTP Error 404: Not Found 03:42:59 INFO - Caught exception: HTTP Error 404: Not Found 03:42:59 INFO - Caught exception: HTTP Error 404: Not Found 03:42:59 INFO - trying https://queue.taskcluster.net/v1/task/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:42:59 INFO - Downloading https://queue.taskcluster.net/v1/task/M3_4sXe8SUikK_eYtJaosw/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 03:42:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M3_4sXe8SUikK_eYtJaosw/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 03:43:00 INFO - Downloaded 21770217 bytes. 03:43:00 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'] 03:43:00 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 03:43:01 INFO - Return code: 0 03:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:01 INFO - https://queue.taskcluster.net/v1/task/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:43:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:43:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:43:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/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 03:43:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/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 03:43:01 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:43:01 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:43:01 INFO - retry: Failed, sleeping 30 seconds before retrying 03:43:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/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 03:43:31 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:43:31 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:43:31 INFO - retry: Failed, sleeping 60 seconds before retrying 03:44:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/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 03:44:31 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:44:31 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:44:31 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/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! 03:44:31 INFO - Caught exception: HTTP Error 404: Not Found 03:44:31 INFO - Caught exception: HTTP Error 404: Not Found 03:44:31 INFO - Caught exception: HTTP Error 404: Not Found 03:44:31 INFO - trying https://queue.taskcluster.net/v1/task/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:44:31 INFO - Downloading https://queue.taskcluster.net/v1/task/M3_4sXe8SUikK_eYtJaosw/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 03:44:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M3_4sXe8SUikK_eYtJaosw/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 03:44:32 INFO - Downloaded 14413723 bytes. 03:44:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:44:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:44:32 INFO - Return code: 0 03:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:32 INFO - https://queue.taskcluster.net/v1/task/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:44:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:44:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:44:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/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 03:44:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/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 03:44:32 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:44:32 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:44:32 INFO - retry: Failed, sleeping 30 seconds before retrying 03:45:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/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 03:45:02 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:45:02 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:45:02 INFO - retry: Failed, sleeping 60 seconds before retrying 03:46:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/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 03:46:02 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:46:02 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:46:02 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_4sXe8SUikK_eYtJaosw/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! 03:46:02 INFO - Caught exception: HTTP Error 404: Not Found 03:46:02 INFO - Caught exception: HTTP Error 404: Not Found 03:46:02 INFO - Caught exception: HTTP Error 404: Not Found 03:46:02 INFO - trying https://queue.taskcluster.net/v1/task/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:46:02 INFO - Downloading https://queue.taskcluster.net/v1/task/M3_4sXe8SUikK_eYtJaosw/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 03:46:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M3_4sXe8SUikK_eYtJaosw/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 03:46:05 INFO - Downloaded 63736207 bytes. 03:46:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:46:05 INFO - mkdir: /builds/slave/test/properties 03:46:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:46:05 INFO - Writing to file /builds/slave/test/properties/build_url 03:46:05 INFO - Contents: 03:46:05 INFO - build_url:https://queue.taskcluster.net/v1/task/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:46:06 INFO - Running post-action listener: _resource_record_post_action 03:46:06 INFO - Running post-action listener: set_extra_try_arguments 03:46:06 INFO - [mozharness: 2016-08-24 10:46:06.071634Z] Finished download-and-extract step (success) 03:46:06 INFO - [mozharness: 2016-08-24 10:46:06.071866Z] Running populate-webroot step. 03:46:06 INFO - Running pre-action listener: _resource_record_pre_action 03:46:06 INFO - Running main action method: populate_webroot 03:46:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:46:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:46:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:46:06 INFO - '--tppagecycles', 03:46:06 INFO - '7'], 03:46:06 INFO - 'tests': ['tsvgm']}}, 03:46:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:46:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:46:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:46:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:46:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:46:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:46:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:06 INFO - 'talos_options': ['--disable-e10s'], 03:46:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:46:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:46:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:06 INFO - 'talos_options': ['--disable-e10s'], 03:46:06 INFO - 'tests': ['damp', 'tps']}, 03:46:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:06 INFO - 'tests': ['damp', 'tps']}, 03:46:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:46:06 INFO - 'tests': ['dromaeo_dom']}, 03:46:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:46:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:46:06 INFO - 'tests': ['basic_compositor_video']}, 03:46:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:46:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:46:06 INFO - 'tests': ['a11yr', 03:46:06 INFO - 'ts_paint', 03:46:06 INFO - 'tpaint', 03:46:06 INFO - 'sessionrestore', 03:46:06 INFO - 'sessionrestore_no_auto_restore', 03:46:06 INFO - 'tabpaint']}, 03:46:06 INFO - 'other-e10s': {'tests': ['a11yr', 03:46:06 INFO - 'ts_paint', 03:46:06 INFO - 'tpaint', 03:46:06 INFO - 'sessionrestore', 03:46:06 INFO - 'sessionrestore_no_auto_restore', 03:46:06 INFO - 'tabpaint']}, 03:46:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:46:06 INFO - 'ts_paint', 03:46:06 INFO - 'tpaint', 03:46:06 INFO - 'sessionrestore', 03:46:06 INFO - 'sessionrestore_no_auto_restore', 03:46:06 INFO - 'tabpaint']}, 03:46:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:46:06 INFO - 'ts_paint', 03:46:06 INFO - 'tpaint', 03:46:06 INFO - 'sessionrestore', 03:46:06 INFO - 'sessionrestore_no_auto_restore', 03:46:06 INFO - 'tabpaint']}, 03:46:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:46:06 INFO - 'tests': ['a11yr', 03:46:06 INFO - 'ts_paint', 03:46:06 INFO - 'tpaint', 03:46:06 INFO - 'sessionrestore', 03:46:06 INFO - 'sessionrestore_no_auto_restore', 03:46:06 INFO - 'tabpaint']}, 03:46:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:46:06 INFO - 'tests': ['a11yr', 03:46:06 INFO - 'ts_paint', 03:46:06 INFO - 'tpaint', 03:46:06 INFO - 'sessionrestore', 03:46:06 INFO - 'sessionrestore_no_auto_restore', 03:46:06 INFO - 'tabpaint']}, 03:46:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:46:06 INFO - 'tests': ['tsvgx', 03:46:06 INFO - 'tsvgr_opacity', 03:46:06 INFO - 'tart', 03:46:06 INFO - 'tscrollx', 03:46:06 INFO - 'cart']}, 03:46:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:46:06 INFO - 'tsvgr_opacity', 03:46:06 INFO - 'tart', 03:46:06 INFO - 'tscrollx', 03:46:06 INFO - 'cart']}, 03:46:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:06 INFO - 'talos_options': ['--disable-e10s'], 03:46:06 INFO - 'tests': ['tp5o']}, 03:46:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:06 INFO - 'tests': ['tp5o']}, 03:46:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:06 INFO - 'talos_options': ['--disable-e10s', 03:46:06 INFO - '--xperf_path', 03:46:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:46:06 INFO - 'tests': ['tp5n']}, 03:46:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:06 INFO - 'talos_options': ['--xperf_path', 03:46:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:46:06 INFO - 'tests': ['tp5n']}}, 03:46:06 INFO - 'talos.zip': {'path': '', 03:46:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:46:06 INFO - Running post-action listener: _resource_record_post_action 03:46:06 INFO - [mozharness: 2016-08-24 10:46:06.091220Z] Finished populate-webroot step (success) 03:46:06 INFO - [mozharness: 2016-08-24 10:46:06.091309Z] Running create-virtualenv step. 03:46:06 INFO - Running pre-action listener: _resource_record_pre_action 03:46:06 INFO - Running main action method: create_virtualenv 03:46:06 INFO - Creating virtualenv /builds/slave/test/build/venv 03:46:06 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 03:46:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:46:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:46:06 INFO - Using real prefix '/usr' 03:46:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:46:06 INFO - Installing distribute.............................................................................................................................................................................................done. 03:46:08 INFO - Installing pip.................done. 03:46:08 INFO - Return code: 0 03:46:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:46:08 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')]} 03:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:08 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')]} 03:46:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:08 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 0x2496030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c5400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2754570>, '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 0x2755470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2755900>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1472030880.976961-587025349', '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 03:46:08 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 03:46:08 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 03:46:08 INFO - Using env: {'DISPLAY': ':0', 03:46:08 INFO - 'HOME': '/home/cltbld', 03:46:08 INFO - 'LANG': 'en_US.UTF-8', 03:46:08 INFO - 'LANGUAGE': 'en_US:en', 03:46:08 INFO - 'LOGNAME': 'cltbld', 03:46:08 INFO - 'MAIL': '/var/mail/cltbld', 03:46:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:08 INFO - 'MOZ_NO_REMOTE': '1', 03:46:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:08 INFO - 'NO_EM_RESTART': '1', 03:46:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:08 INFO - 'PWD': '/builds/slave/test', 03:46:08 INFO - 'SHELL': '/bin/bash', 03:46:08 INFO - 'SHLVL': '1', 03:46:08 INFO - 'TERM': 'linux', 03:46:08 INFO - 'TMOUT': '86400', 03:46:08 INFO - 'USER': 'cltbld', 03:46:08 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472030880.976961-587025349', 03:46:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:08 INFO - '_': '/tools/buildbot/bin/python'} 03:46:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:08 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 03:46:08 INFO - Cleaning up... 03:46:08 INFO - Return code: 0 03:46:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:46:08 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')]} 03:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:08 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')]} 03:46:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:08 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 0x2496030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c5400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2754570>, '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 0x2755470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2755900>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1472030880.976961-587025349', '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 03:46:08 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 03:46:08 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 03:46:08 INFO - Using env: {'DISPLAY': ':0', 03:46:08 INFO - 'HOME': '/home/cltbld', 03:46:08 INFO - 'LANG': 'en_US.UTF-8', 03:46:08 INFO - 'LANGUAGE': 'en_US:en', 03:46:08 INFO - 'LOGNAME': 'cltbld', 03:46:08 INFO - 'MAIL': '/var/mail/cltbld', 03:46:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:08 INFO - 'MOZ_NO_REMOTE': '1', 03:46:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:08 INFO - 'NO_EM_RESTART': '1', 03:46:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:08 INFO - 'PWD': '/builds/slave/test', 03:46:08 INFO - 'SHELL': '/bin/bash', 03:46:08 INFO - 'SHLVL': '1', 03:46:08 INFO - 'TERM': 'linux', 03:46:08 INFO - 'TMOUT': '86400', 03:46:08 INFO - 'USER': 'cltbld', 03:46:08 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472030880.976961-587025349', 03:46:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:08 INFO - '_': '/tools/buildbot/bin/python'} 03:46:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:09 INFO - Downloading/unpacking psutil>=3.1.1 03:46:09 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 03:46:09 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 03:46:09 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 03:46:09 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 03:46:09 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 03:46:09 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 03:46:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:46:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:46:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:46:11 INFO - Installing collected packages: psutil 03:46:11 INFO - Running setup.py install for psutil 03:46:11 INFO - building 'psutil._psutil_linux' extension 03:46:11 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 03:46:11 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 03:46:11 INFO - building 'psutil._psutil_posix' extension 03:46:11 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 03:46:11 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 03:46:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:46:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:46:11 INFO - Successfully installed psutil 03:46:11 INFO - Cleaning up... 03:46:11 INFO - Return code: 0 03:46:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:46:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2496030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c5400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2754570>, '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 0x2755470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2755900>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1472030880.976961-587025349', '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 03:46:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:46:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:46:11 INFO - Using env: {'DISPLAY': ':0', 03:46:11 INFO - 'HOME': '/home/cltbld', 03:46:11 INFO - 'LANG': 'en_US.UTF-8', 03:46:11 INFO - 'LANGUAGE': 'en_US:en', 03:46:11 INFO - 'LOGNAME': 'cltbld', 03:46:11 INFO - 'MAIL': '/var/mail/cltbld', 03:46:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:11 INFO - 'MOZ_NO_REMOTE': '1', 03:46:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:11 INFO - 'NO_EM_RESTART': '1', 03:46:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:11 INFO - 'PWD': '/builds/slave/test', 03:46:11 INFO - 'SHELL': '/bin/bash', 03:46:11 INFO - 'SHLVL': '1', 03:46:11 INFO - 'TERM': 'linux', 03:46:11 INFO - 'TMOUT': '86400', 03:46:11 INFO - 'USER': 'cltbld', 03:46:11 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472030880.976961-587025349', 03:46:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:11 INFO - '_': '/tools/buildbot/bin/python'} 03:46:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:46:11 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 03:46:11 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 03:46:11 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 03:46:11 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 03:46:11 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 03:46:11 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 03:46:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:46:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:46:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:46:13 INFO - Installing collected packages: mozsystemmonitor 03:46:13 INFO - Running setup.py install for mozsystemmonitor 03:46:13 INFO - Successfully installed mozsystemmonitor 03:46:13 INFO - Cleaning up... 03:46:13 INFO - Return code: 0 03:46:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:46:13 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')]} 03:46:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:13 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')]} 03:46:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:13 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 0x2496030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c5400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2754570>, '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 0x2755470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2755900>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1472030880.976961-587025349', '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 03:46:13 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 03:46:13 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 03:46:13 INFO - Using env: {'DISPLAY': ':0', 03:46:13 INFO - 'HOME': '/home/cltbld', 03:46:13 INFO - 'LANG': 'en_US.UTF-8', 03:46:13 INFO - 'LANGUAGE': 'en_US:en', 03:46:13 INFO - 'LOGNAME': 'cltbld', 03:46:13 INFO - 'MAIL': '/var/mail/cltbld', 03:46:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:13 INFO - 'MOZ_NO_REMOTE': '1', 03:46:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:13 INFO - 'NO_EM_RESTART': '1', 03:46:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:13 INFO - 'PWD': '/builds/slave/test', 03:46:13 INFO - 'SHELL': '/bin/bash', 03:46:13 INFO - 'SHLVL': '1', 03:46:13 INFO - 'TERM': 'linux', 03:46:13 INFO - 'TMOUT': '86400', 03:46:13 INFO - 'USER': 'cltbld', 03:46:13 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472030880.976961-587025349', 03:46:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:13 INFO - '_': '/tools/buildbot/bin/python'} 03:46:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:14 INFO - Downloading/unpacking jsonschema==2.5.1 03:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:46:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:46:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:16 INFO - Downloading functools32-3.2.3-2.tar.gz 03:46:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:46:16 INFO - warning: no files found matching '*.txt' 03:46:16 INFO - no previously-included directories found matching 'build' 03:46:16 INFO - no previously-included directories found matching 'dist' 03:46:16 INFO - no previously-included directories found matching '.git*' 03:46:16 INFO - Installing collected packages: jsonschema, functools32 03:46:16 INFO - Running setup.py install for functools32 03:46:16 INFO - warning: no files found matching '*.txt' 03:46:16 INFO - no previously-included directories found matching 'build' 03:46:16 INFO - no previously-included directories found matching 'dist' 03:46:16 INFO - no previously-included directories found matching '.git*' 03:46:16 INFO - Successfully installed jsonschema functools32 03:46:16 INFO - Cleaning up... 03:46:16 INFO - Return code: 0 03:46:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:46:16 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')]} 03:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:16 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')]} 03:46:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:16 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 0x2496030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c5400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2754570>, '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 0x2755470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2755900>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1472030880.976961-587025349', '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 03:46:16 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 03:46:16 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 03:46:16 INFO - Using env: {'DISPLAY': ':0', 03:46:16 INFO - 'HOME': '/home/cltbld', 03:46:16 INFO - 'LANG': 'en_US.UTF-8', 03:46:16 INFO - 'LANGUAGE': 'en_US:en', 03:46:16 INFO - 'LOGNAME': 'cltbld', 03:46:16 INFO - 'MAIL': '/var/mail/cltbld', 03:46:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:16 INFO - 'MOZ_NO_REMOTE': '1', 03:46:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:16 INFO - 'NO_EM_RESTART': '1', 03:46:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:16 INFO - 'PWD': '/builds/slave/test', 03:46:16 INFO - 'SHELL': '/bin/bash', 03:46:16 INFO - 'SHLVL': '1', 03:46:16 INFO - 'TERM': 'linux', 03:46:16 INFO - 'TMOUT': '86400', 03:46:16 INFO - 'USER': 'cltbld', 03:46:16 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472030880.976961-587025349', 03:46:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:16 INFO - '_': '/tools/buildbot/bin/python'} 03:46:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:46:16 INFO - Cleaning up... 03:46:16 INFO - Return code: 0 03:46:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:46:16 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')]} 03:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:16 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')]} 03:46:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:16 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 0x2496030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c5400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2754570>, '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 0x2755470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2755900>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1472030880.976961-587025349', '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 03:46:16 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 03:46:16 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 03:46:16 INFO - Using env: {'DISPLAY': ':0', 03:46:16 INFO - 'HOME': '/home/cltbld', 03:46:16 INFO - 'LANG': 'en_US.UTF-8', 03:46:16 INFO - 'LANGUAGE': 'en_US:en', 03:46:16 INFO - 'LOGNAME': 'cltbld', 03:46:16 INFO - 'MAIL': '/var/mail/cltbld', 03:46:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:16 INFO - 'MOZ_NO_REMOTE': '1', 03:46:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:16 INFO - 'NO_EM_RESTART': '1', 03:46:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:16 INFO - 'PWD': '/builds/slave/test', 03:46:16 INFO - 'SHELL': '/bin/bash', 03:46:16 INFO - 'SHLVL': '1', 03:46:16 INFO - 'TERM': 'linux', 03:46:16 INFO - 'TMOUT': '86400', 03:46:16 INFO - 'USER': 'cltbld', 03:46:16 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472030880.976961-587025349', 03:46:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:16 INFO - '_': '/tools/buildbot/bin/python'} 03:46:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:16 INFO - Downloading/unpacking blobuploader==1.2.4 03:46:16 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 03:46:16 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 03:46:16 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 03:46:16 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 03:46:16 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 03:46:16 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 03:46:18 INFO - Downloading blobuploader-1.2.4.tar.gz 03:46:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:46:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:46:18 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 03:46:18 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 03:46:18 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 03:46:18 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 03:46:18 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 03:46:18 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 03:46:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:46:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:46:19 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 03:46:19 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 03:46:19 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 03:46:19 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 03:46:19 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 03:46:19 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 03:46:19 INFO - Downloading docopt-0.6.1.tar.gz 03:46:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:46:19 INFO - Installing collected packages: blobuploader, requests, docopt 03:46:19 INFO - Running setup.py install for blobuploader 03:46:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:46:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:46:19 INFO - Running setup.py install for requests 03:46:19 INFO - Running setup.py install for docopt 03:46:20 INFO - Successfully installed blobuploader requests docopt 03:46:20 INFO - Cleaning up... 03:46:20 INFO - Return code: 0 03:46:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:46:20 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')]} 03:46:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:20 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')]} 03:46:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:20 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 0x2496030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c5400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2754570>, '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 0x2755470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2755900>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1472030880.976961-587025349', '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 03:46:20 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 03:46:20 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 03:46:20 INFO - Using env: {'DISPLAY': ':0', 03:46:20 INFO - 'HOME': '/home/cltbld', 03:46:20 INFO - 'LANG': 'en_US.UTF-8', 03:46:20 INFO - 'LANGUAGE': 'en_US:en', 03:46:20 INFO - 'LOGNAME': 'cltbld', 03:46:20 INFO - 'MAIL': '/var/mail/cltbld', 03:46:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:20 INFO - 'MOZ_NO_REMOTE': '1', 03:46:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:20 INFO - 'NO_EM_RESTART': '1', 03:46:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:20 INFO - 'PWD': '/builds/slave/test', 03:46:20 INFO - 'SHELL': '/bin/bash', 03:46:20 INFO - 'SHLVL': '1', 03:46:20 INFO - 'TERM': 'linux', 03:46:20 INFO - 'TMOUT': '86400', 03:46:20 INFO - 'USER': 'cltbld', 03:46:20 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472030880.976961-587025349', 03:46:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:20 INFO - '_': '/tools/buildbot/bin/python'} 03:46:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:46:20 INFO - Running setup.py (path:/tmp/pip-ceyjMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:46:20 INFO - Running setup.py (path:/tmp/pip-L9YmRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:46:20 INFO - Running setup.py (path:/tmp/pip-zWPdjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:46:20 INFO - Running setup.py (path:/tmp/pip-VE1zoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:46:20 INFO - Running setup.py (path:/tmp/pip-FcXwTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:46:20 INFO - Running setup.py (path:/tmp/pip-jtCw2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:46:20 INFO - Running setup.py (path:/tmp/pip-Epbgk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:46:20 INFO - Running setup.py (path:/tmp/pip-zWylQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:46:20 INFO - Running setup.py (path:/tmp/pip-6P7FmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:46:20 INFO - Running setup.py (path:/tmp/pip-nyfAsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:46:21 INFO - Running setup.py (path:/tmp/pip-A7n3M_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:46:21 INFO - Running setup.py (path:/tmp/pip-ILAQrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:46:21 INFO - Running setup.py (path:/tmp/pip-Go4ejD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:46:21 INFO - Running setup.py (path:/tmp/pip-he84jH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:46:21 INFO - Running setup.py (path:/tmp/pip-u4CY84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:46:21 INFO - Running setup.py (path:/tmp/pip-B0Q0hp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:46:21 INFO - Running setup.py (path:/tmp/pip-OPSIXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:46:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:46:21 INFO - Running setup.py install for manifestparser 03:46:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:46:21 INFO - Running setup.py install for mozcrash 03:46:21 INFO - Running setup.py install for mozdebug 03:46:21 INFO - Running setup.py install for mozdevice 03:46:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:46:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:46:21 INFO - Running setup.py install for mozfile 03:46:22 INFO - Running setup.py install for mozhttpd 03:46:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:46:22 INFO - Running setup.py install for mozinfo 03:46:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:46:22 INFO - Running setup.py install for mozInstall 03:46:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:46:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:46:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:46:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:46:22 INFO - Running setup.py install for mozleak 03:46:22 INFO - Running setup.py install for mozlog 03:46:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:46:22 INFO - Running setup.py install for moznetwork 03:46:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:46:22 INFO - Running setup.py install for mozprocess 03:46:22 INFO - Running setup.py install for mozprofile 03:46:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:46:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:46:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:46:22 INFO - Running setup.py install for mozrunner 03:46:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:46:23 INFO - Running setup.py install for mozscreenshot 03:46:23 INFO - Running setup.py install for moztest 03:46:23 INFO - Running setup.py install for mozversion 03:46:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:46:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:46:23 INFO - Cleaning up... 03:46:23 INFO - Return code: 0 03:46:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:46: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')]} 03:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46: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')]} 03:46:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:23 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 0x2496030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c5400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2754570>, '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 0x2755470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2755900>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1472030880.976961-587025349', '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 03:46:23 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 03:46:23 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 03:46:23 INFO - Using env: {'DISPLAY': ':0', 03:46:23 INFO - 'HOME': '/home/cltbld', 03:46:23 INFO - 'LANG': 'en_US.UTF-8', 03:46:23 INFO - 'LANGUAGE': 'en_US:en', 03:46:23 INFO - 'LOGNAME': 'cltbld', 03:46:23 INFO - 'MAIL': '/var/mail/cltbld', 03:46:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:23 INFO - 'MOZ_NO_REMOTE': '1', 03:46:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:23 INFO - 'NO_EM_RESTART': '1', 03:46:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:23 INFO - 'PWD': '/builds/slave/test', 03:46:23 INFO - 'SHELL': '/bin/bash', 03:46:23 INFO - 'SHLVL': '1', 03:46:23 INFO - 'TERM': 'linux', 03:46:23 INFO - 'TMOUT': '86400', 03:46:23 INFO - 'USER': 'cltbld', 03:46:23 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472030880.976961-587025349', 03:46:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:23 INFO - '_': '/tools/buildbot/bin/python'} 03:46:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:46:23 INFO - Running setup.py (path:/tmp/pip-Xl9_xo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:46:23 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)) 03:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:46:23 INFO - Running setup.py (path:/tmp/pip-nsQV_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:46:23 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)) 03:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:46:23 INFO - Running setup.py (path:/tmp/pip-Cl8l3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:46:23 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)) 03:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:46:23 INFO - Running setup.py (path:/tmp/pip-u3BmUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:46:23 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)) 03:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:46:23 INFO - Running setup.py (path:/tmp/pip-fbG6YR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:46:23 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)) 03:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:46:23 INFO - Running setup.py (path:/tmp/pip-JNojDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:46:23 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)) 03:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:46:23 INFO - Running setup.py (path:/tmp/pip-DVO5fP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:46:24 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)) 03:46:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:46:24 INFO - Running setup.py (path:/tmp/pip-00fwhr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:46:24 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)) 03:46:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:46:24 INFO - Running setup.py (path:/tmp/pip-5m155Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:46:24 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)) 03:46:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:46:24 INFO - Running setup.py (path:/tmp/pip-9R9EWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:46:24 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)) 03:46:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:46:24 INFO - Running setup.py (path:/tmp/pip-wZHoyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:46:24 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)) 03:46:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:46:24 INFO - Running setup.py (path:/tmp/pip-7OVnLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:46:24 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)) 03:46:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:46:24 INFO - Running setup.py (path:/tmp/pip-SVywz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:46:24 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)) 03:46:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:46:24 INFO - Running setup.py (path:/tmp/pip-G_TjlU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:46:24 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)) 03:46:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:46:24 INFO - Running setup.py (path:/tmp/pip-fcG2Xb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:46:24 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)) 03:46:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:46:24 INFO - Running setup.py (path:/tmp/pip-qLaW_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:46:24 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)) 03:46:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:46:24 INFO - Running setup.py (path:/tmp/pip-CQI_RL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:46:24 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)) 03:46:24 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)) 03:46:24 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)) 03:46:24 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)) 03:46:24 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)) 03:46:24 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)) 03:46:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:46:24 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 03:46:24 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 03:46:24 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 03:46:24 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 03:46:24 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 03:46:24 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 03:46:26 INFO - Downloading blessings-1.6.tar.gz 03:46:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:46:26 INFO - Installing collected packages: blessings 03:46:26 INFO - Running setup.py install for blessings 03:46:26 INFO - Successfully installed blessings 03:46:26 INFO - Cleaning up... 03:46:26 INFO - Return code: 0 03:46:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:46:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:46:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:46:27 INFO - Reading from file tmpfile_stdout 03:46:27 INFO - Current package versions: 03:46:27 INFO - argparse == 1.2.1 03:46:27 INFO - blessings == 1.6 03:46:27 INFO - blobuploader == 1.2.4 03:46:27 INFO - docopt == 0.6.1 03:46:27 INFO - functools32 == 3.2.3-2 03:46:27 INFO - jsonschema == 2.5.1 03:46:27 INFO - manifestparser == 1.1 03:46:27 INFO - mozInstall == 1.12 03:46:27 INFO - mozcrash == 0.17 03:46:27 INFO - mozdebug == 0.1 03:46:27 INFO - mozdevice == 0.48 03:46:27 INFO - mozfile == 1.2 03:46:27 INFO - mozhttpd == 0.7 03:46:27 INFO - mozinfo == 0.9 03:46:27 INFO - mozleak == 0.1 03:46:27 INFO - mozlog == 3.3 03:46:27 INFO - moznetwork == 0.27 03:46:27 INFO - mozprocess == 0.23 03:46:27 INFO - mozprofile == 0.28 03:46:27 INFO - mozrunner == 6.12 03:46:27 INFO - mozscreenshot == 0.1 03:46:27 INFO - mozsystemmonitor == 0.3 03:46:27 INFO - moztest == 0.7 03:46:27 INFO - mozversion == 1.4 03:46:27 INFO - psutil == 3.1.1 03:46:27 INFO - requests == 1.2.3 03:46:27 INFO - wsgiref == 0.1.2 03:46:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:46:27 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')]} 03:46:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:27 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')]} 03:46:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:27 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 0x2496030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c5400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2754570>, '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 0x2755470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2755900>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1472030880.976961-587025349', '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 03:46:27 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 03:46:27 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 03:46:27 INFO - Using env: {'DISPLAY': ':0', 03:46:27 INFO - 'HOME': '/home/cltbld', 03:46:27 INFO - 'LANG': 'en_US.UTF-8', 03:46:27 INFO - 'LANGUAGE': 'en_US:en', 03:46:27 INFO - 'LOGNAME': 'cltbld', 03:46:27 INFO - 'MAIL': '/var/mail/cltbld', 03:46:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:27 INFO - 'MOZ_NO_REMOTE': '1', 03:46:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:27 INFO - 'NO_EM_RESTART': '1', 03:46:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:27 INFO - 'PWD': '/builds/slave/test', 03:46:27 INFO - 'SHELL': '/bin/bash', 03:46:27 INFO - 'SHLVL': '1', 03:46:27 INFO - 'TERM': 'linux', 03:46:27 INFO - 'TMOUT': '86400', 03:46:27 INFO - 'USER': 'cltbld', 03:46:27 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472030880.976961-587025349', 03:46:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:27 INFO - '_': '/tools/buildbot/bin/python'} 03:46:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:27 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)) 03:46:27 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)) 03:46:27 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)) 03:46:27 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)) 03:46:27 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)) 03:46:27 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)) 03:46:27 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)) 03:46:27 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)) 03:46:27 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)) 03:46:27 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)) 03:46:27 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)) 03:46:27 INFO - Cleaning up... 03:46:27 INFO - Return code: 0 03:46:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:46:27 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')]} 03:46:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:27 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')]} 03:46:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:27 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 0x2496030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c5400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2754570>, '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 0x2755470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2755900>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1472030880.976961-587025349', '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 03:46:27 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 03:46:27 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 03:46:27 INFO - Using env: {'DISPLAY': ':0', 03:46:27 INFO - 'HOME': '/home/cltbld', 03:46:27 INFO - 'LANG': 'en_US.UTF-8', 03:46:27 INFO - 'LANGUAGE': 'en_US:en', 03:46:27 INFO - 'LOGNAME': 'cltbld', 03:46:27 INFO - 'MAIL': '/var/mail/cltbld', 03:46:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:27 INFO - 'MOZ_NO_REMOTE': '1', 03:46:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:27 INFO - 'NO_EM_RESTART': '1', 03:46:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:27 INFO - 'PWD': '/builds/slave/test', 03:46:27 INFO - 'SHELL': '/bin/bash', 03:46:27 INFO - 'SHLVL': '1', 03:46:27 INFO - 'TERM': 'linux', 03:46:27 INFO - 'TMOUT': '86400', 03:46:27 INFO - 'USER': 'cltbld', 03:46:27 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472030880.976961-587025349', 03:46:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:27 INFO - '_': '/tools/buildbot/bin/python'} 03:46:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:46:27 INFO - Cleaning up... 03:46:27 INFO - Return code: 0 03:46:27 INFO - Running post-action listener: _resource_record_post_action 03:46:27 INFO - Running post-action listener: _start_resource_monitoring 03:46:27 INFO - Starting resource monitoring. 03:46:27 INFO - [mozharness: 2016-08-24 10:46:27.586478Z] Finished create-virtualenv step (success) 03:46:27 INFO - [mozharness: 2016-08-24 10:46:27.586952Z] Running install step. 03:46:27 INFO - Running pre-action listener: _resource_record_pre_action 03:46:27 INFO - Running main action method: install 03:46:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:46:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:46:27 INFO - Reading from file tmpfile_stdout 03:46:27 INFO - Detecting whether we're running mozinstall >=1.0... 03:46:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:46:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:46:27 INFO - Reading from file tmpfile_stdout 03:46:27 INFO - Output received: 03:46:27 INFO - Usage: mozinstall [options] installer 03:46:27 INFO - Options: 03:46:27 INFO - -h, --help show this help message and exit 03:46:27 INFO - -d DEST, --destination=DEST 03:46:27 INFO - Directory to install application into. [default: 03:46:27 INFO - "/builds/slave/test"] 03:46:27 INFO - --app=APP Application being installed. [default: firefox] 03:46:27 INFO - mkdir: /builds/slave/test/build/application 03:46:27 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'] 03:46:27 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 03:46:44 INFO - Reading from file tmpfile_stdout 03:46:44 INFO - Output received: 03:46:44 INFO - /builds/slave/test/build/application/firefox/firefox 03:46:44 INFO - Running post-action listener: _resource_record_post_action 03:46:44 INFO - [mozharness: 2016-08-24 10:46:44.582047Z] Finished install step (success) 03:46:44 INFO - [mozharness: 2016-08-24 10:46:44.582389Z] Running run-tests step. 03:46:44 INFO - Running pre-action listener: _resource_record_pre_action 03:46:44 INFO - Running main action method: run_tests 03:46:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:46:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:46:44 INFO - Python 2.7.3 03:46:44 INFO - Return code: 0 03:46:44 INFO - grabbing minidump binary from tooltool 03:46:44 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')]} 03:46:44 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 0x2754570>, '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 0x2755470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2755900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:46:44 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 03:46:44 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 03:46:44 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 03:46:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:46:44 INFO - Return code: 0 03:46:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:46:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:46:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:46:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:46:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:46:44 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/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 03:46:44 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/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 03:46:44 INFO - Using env: {'DISPLAY': ':0', 03:46:44 INFO - 'HOME': '/home/cltbld', 03:46:44 INFO - 'LANG': 'en_US.UTF-8', 03:46:44 INFO - 'LANGUAGE': 'en_US:en', 03:46:44 INFO - 'LOGNAME': 'cltbld', 03:46:44 INFO - 'MAIL': '/var/mail/cltbld', 03:46:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:46:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:46:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:44 INFO - 'MOZ_NO_REMOTE': '1', 03:46:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:46:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:44 INFO - 'NO_EM_RESTART': '1', 03:46:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:44 INFO - 'PWD': '/builds/slave/test', 03:46:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:46:44 INFO - 'SHELL': '/bin/bash', 03:46:44 INFO - 'SHLVL': '1', 03:46:44 INFO - 'TERM': 'linux', 03:46:44 INFO - 'TMOUT': '86400', 03:46:44 INFO - 'USER': 'cltbld', 03:46:44 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472030880.976961-587025349', 03:46:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:44 INFO - '_': '/tools/buildbot/bin/python'} 03:46:44 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/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 03:46:44 INFO - mozversion application_buildid: 20160824004001 03:46:44 INFO - mozversion application_changeset: a72bfbdf5c9b36e68ca806a25944180f2652f0c9 03:46:44 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:46:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:46:44 INFO - mozversion application_name: Firefox 03:46:44 INFO - mozversion application_remotingname: firefox-dev 03:46:44 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:46:44 INFO - mozversion application_vendor: Mozilla 03:46:44 INFO - mozversion application_version: 50.0a2 03:46:44 INFO - mozversion platform_buildid: 20160824004001 03:46:44 INFO - mozversion platform_changeset: a72bfbdf5c9b36e68ca806a25944180f2652f0c9 03:46:44 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:46:44 INFO - mozversion platform_version: 50.0a2 03:46:44 INFO - using testdate: 1472035604 03:46:44 INFO - actual date: 1472035604 03:46:44 INFO - starting webserver on 'localhost:51039' 03:46:44 INFO - SUITE-START | Running 2 tests 03:46:44 INFO - TEST-START | dromaeo_css 03:46:44 INFO - operating with platform_type : linux_ 03:46:44 INFO - Initialising browser for dromaeo_css test... 03:46:44 INFO - TEST-INFO | started process 18058 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIzXtP9/profile http://localhost:51039/getInfo.html) 03:46:49 INFO - PROCESS | 18058 | __metrics Screen width/height:1600/1200 03:46:49 INFO - PROCESS | 18058 | colorDepth:24 03:46:49 INFO - PROCESS | 18058 | Browser inner width/height: 1024/697 03:46:49 INFO - PROCESS | 18058 | __metrics 03:46:50 ERROR - PROCESS | 18058 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 03:46:50 INFO - TEST-INFO | 18058: exit 0 03:46:50 INFO - Browser initialized. 03:46:50 INFO - Running cycle 1/1 for dromaeo_css test... 03:46:50 INFO - TEST-INFO | started process 18186 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIzXtP9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:47:02 INFO - PROCESS | 18186 | RSS: Main: 152576000 03:47:02 INFO - PROCESS | 18186 | 03:47:52 INFO - PROCESS | 18186 | 1472035672204 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] 03:50:00 INFO - PROCESS | 18186 | Cycle 1(1): loaded http://localhost:51039/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51039/tests/dromaeo/cssquery-ext.html) 03:50:01 INFO - PROCESS | 18186 | RSS: Main: 158035968 03:50:01 INFO - PROCESS | 18186 | 03:53:03 INFO - PROCESS | 18186 | Cycle 1(1): loaded http://localhost:51039/tests/dromaeo/cssquery-ext.html (next: http://localhost:51039/tests/dromaeo/cssquery-jquery.html) 03:53:04 INFO - PROCESS | 18186 | RSS: Main: 152956928 03:53:04 INFO - PROCESS | 18186 | 03:56:05 INFO - PROCESS | 18186 | Cycle 1(1): loaded http://localhost:51039/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51039/tests/dromaeo/cssquery-mootools.html) 03:56:06 INFO - PROCESS | 18186 | RSS: Main: 153935872 03:56:06 INFO - PROCESS | 18186 | 03:59:08 INFO - PROCESS | 18186 | Cycle 1(1): loaded http://localhost:51039/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51039/tests/dromaeo/cssquery-prototype.html) 03:59:08 INFO - PROCESS | 18186 | RSS: Main: 152641536 03:59:08 INFO - PROCESS | 18186 | 04:02:11 INFO - PROCESS | 18186 | Cycle 1(1): loaded http://localhost:51039/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51039/tests/dromaeo/cssquery-yui.html) 04:02:11 INFO - PROCESS | 18186 | RSS: Main: 155213824 04:02:11 INFO - PROCESS | 18186 | 04:05:14 INFO - PROCESS | 18186 | Cycle 1(1): loaded http://localhost:51039/tests/dromaeo/cssquery-yui.html (next: http://localhost:51039/tests/dromaeo/cssquery-dojo.html) 04:05:14 INFO - PROCESS | 18186 | RSS: Main: 155578368 04:05:14 INFO - PROCESS | 18186 | 04:05:14 INFO - PROCESS | 18186 | __start_tp_report 04:05:14 INFO - PROCESS | 18186 | _x_x_mozilla_page_load 04:05:14 INFO - PROCESS | 18186 | _x_x_mozilla_page_load_details 04:05:14 INFO - PROCESS | 18186 | |i|pagename|runs| 04:05:14 INFO - PROCESS | 18186 | |0;dojo.html;3254.788438751481;3277.9016629501125;3292.983535082324;3304.09137487191;3304.3721692878335;5786.594938354312;5825.65046097234;5834.2998840139135;5835.0663893777;5846.561507886904;5784.537237021039;5817.970910145444;5832.825015249549;5852.0344143216425;5868.559858010655;5275.182346736253;5296.046711591912;5297.576193904479;5335.599830012745;5348.411674715778;5185.896282074356;5189.377274727038;5228.137357336035;5246;5258.211268309746;5308.442613525563;5335.1730481775385;5343.759530821103;5355.0628639988045;5362.51737343639;5322.175062865262;5325.094733895247;5339.9733001335135;5347.41178470368;5381.381141168777;5010.0981823271795;5044.9495505045215;5138.74306284688;5233.528982391565;5299.258103865462;5102.795888164469;5608.214849920973;5633.943660563383;5697.829065128053;5789.478946894799;6175.505959523227;6211.968940155315;6214.533909956771;6225.346338634424;6243.937560624381;6229.221347331583;6246.656433896179;6252.843678908063;6255.280642726054;6267.749290028393;5585;5725.656460612377;5729.054705973509;5746.9712651436475;5839.532837373;6229.3770622937345;6259.71831267594;6269.780557680459;6285.811425657146;6320.241571011508;6031;6059.242594675666;6100.450959413585;6103.450689437883;6112.847178820565;6020.518358531307;6112.99135642614;6114.847128821726;6118.619179173164;6233.2208473940755;6134.938650613526;6184.536159788034;6186.505079593621;6200.627962322275;6200.906986395207;6192.566520343623;6213.316535181127;6224.657643829542;6227.719752611143;6228.377162283826;4545.795439205178;4560.771961401917;4565.360849481075;4600.5169457207185;4648.233041548175;4182.2890108681595;4184.602462766033;4190.141021090669;4193.203291374629;4216.683748718859;5910.645361278337;5943.970280148572;5947.672877991666;5948.940510594925;5956.493698035715;6117.663528505975;6127.158986117706;6134.944813464463;6199.225096862892;6238.719257633326;5950.9702451487465;5951.315598706205;5952.255968003999;5962.821115366546;5984.192134061933;5068.619853511002;5169.948300517022;5203.973980130151;5216.40011398694;5239.266502689627;6242.687865606701;6278;6302.779402720975;6409.487241020707;6410.775622853178;6154.753809847735;6179.5983261086985;6181.412765787243;6189.3501182377;6191.721372538336;6280.0893870389455;6397.296297407374;6399.072134540559;6399.93600064012;6400.871982560416;6095.420935011344;6109.969450152721;6116.174316467398;6174.938250617616;6183.659898705614;6289.96855015722;6290;6296.087067375296;6307.526935479949;6314.62112273265;5912.763489460545;6085.087236914498;6131.294901086432;6135.386461353829;6160.291566469734;5959.106134079922;5960.850978725566;5988.161657367885;6053.9091913622215;6067.605605635619;5944.078667806497;5950.5239580834295;5989.131575921554;5990.6705131218205;5996.640201587918;5939.346671866005;6021.7591296347655;6054.031354983182;6087.239095113111;6102.816915492543;5870.5010074144175;5886.705664716833;5937.762489500545;5938.8218353449465;5992.161097446274 04:05:14 INFO - PROCESS | 18186 | |1;ext.html;584.5060923519627;641.3041849593191;664.2394458345195;679.1273213920114;716.0047533927838;41175.58824411755;46409;46584.30123548141;46611.76694116533;46620.3006954896;46624.30063549041;46652.30021549671;46670.766646166805;46724;46950.29574556376;8868.246199073086;9080.909190908105;9084.137006984325;9144.817103657922;9174.633014679404;9098.31762617803;9217.078292170763;9225.261979041661;9232.769180770467;9250.398724082947;9204.493752843591;9234.261259099256;9239.722808315728;9315.441073535576;9327.813443731122;9151.771205719877;9152.725418237464;9216.216621587173;9257.814843703089;9265.073492650748;9150.54247287633;9221.953890230507;9235.445873247627;9253.6298548058;9256.213221876149;43936.3409548857;44186.779066104464;44352.556474435165;44442.77778611086;44469.55530444686;3847.5190601174854;3927.450156977997;3929.5677475477673;3995.5205375354853;4512.165249428866;35745.64254357449;35867.92396228117;36093.27813443716;36234.63765362339;36398.454023189675;4687.5781179693995;4692.741899195543;4712.942985392931;4770.427548694179;4871.537203965618;362729;367181;368547;370784;371505;64456.35543644597;64753;64777.35222647808;64794;64851.67574162193;39318;39994.400083998764;40258.39612405816;42442.57557424448;69051;14825.851741482662;14936;14971.326290316962;15097.245137743288;15103.924480377527;11726.824097638542;11737.941310293394;11805.17363784544;11827.763444731228;11834.881651183377;21139.154433822783;21486;21507;21614.135434582757;21624.243151489623;7415.555066696015;7472.685580684313;7606.657700403495;7651;7841.803954901059;1007.9092881640687;1055.4406164732704;1135.7387800805861;1229.225587879648;1232.2994267910406;33657.831710841776;33716.49425258623;33880.32239355249;34486.82756586201;34492;1146.3293973025707;1173.266708307308;1185.5020891225706;1195.9222650527688;1217.7625363054296;18056.72914906251;18143.72784408235;18162.727559086623;18285;18387.816121838878;705388;711059;715293;715771;717222;64426.677866610364;64584;64651;64744.35255647383;64887;1364.3451143451;1366.269046060353;1371.8079468874366;1416.199847086393;1428.550006747871;32726.672733273313;33980.32039359248;34038.319233615686;34059.4891076639;34342.65657343494;57901.420985789606;58213.4178658208;58232.708836455546;58278;58482.415175847695;538010;539553;541950;545196;548477;31134.22164445907;31408;31650.366992659558;31880.36239275248;32016.67983320137;53068.20397693961;53094.469055310496;53149.7342513285;53261.201081983025;54252;44498.34423153982;45068.54931450775;45488.772556138334;45995.3100703483;46151;44659;46434.30348544707;46641.53358466372;46674.29988550243;46694.76652616715;38775.2244955105;43465.78267108644;44190.558094418644;44241;44398.556014440735;37580.624193757714;39011.6098839008;39789.2042159161;41217.38173927453;42471.78764106283;30561.847190763903;30595;30725.08321813353;30989.69010309868;31094.22264443407 04:05:14 INFO - PROCESS | 18186 | |2;jquery.html;402.42855145693113;402.81671839313117;414.4384359193293;421.36794807788306;423.7605752749696;19161.52096197596;20483.795162048376;20867.165313387464;21561.67657485139;21609.02759375828;20046.799532004676;20256.291029813958;20372.89813550934;20640.277590284342;20790.272340468087;5726.62776919501;5977.133315669225;5983.521318294548;5984.820455386323;5993.610415323012;5798.826035218929;5822.912656310159;5884.558658100638;5913.881722365551;5944.048952167654;5726.656400615955;5843.620164689303;5855.970720146393;5865.736041878125;5890.941090589104;5606.411326810667;5811.6803575803315;5847.502962248214;5884.852878678024;5886.970565147169;5704.914426283609;5777.335606405275;5779.335376431723;5795.681237531934;5880.529557635379;14573.708525829425;14761.55715328542;14902.180380079091;16336.428225012067;25057.12300069489;2412.9517409651708;2417.3835671903553;2427.8664673442954;2555.220657699401;2741.232454912628;10368;10755.731106722316;11235.21353505255;11985.460654270491;15216.315265813066;1931.2082046361065;1949.2690241159564;1967.1836187982112;2048.1602542957316;2067.286786058807;84725;86915;87431.56284218538;87471.56264218701;87636;9846;10051.64819231338;10391.06480416751;10548.894511054792;10635.361878287173;13920;14044.36800343987;14077.296135193199;14174.07868488545;14189.78715319271;7504.399648028145;7604.619769011527;7663.6971714808615;7704.305052888468;7721.961390193013;7306.634668266672;7382.151052628909;7420.406367490587;7469.029026226556;7599.278068583476;4287.828486860553;4306.870793876189;4374;4464.285714285764;4490.50604433512;2020.282799606148;2103.2218079310446;2114.669395701776;2123.7982391673077;2141.4646338415396;968.4479846487435;976.3604838830578;986.146982859821;1030.1141018723893;1095.8684957805115;20331.39005829798;20683;20983.580328393346;20992.580148396948;21069.683954740383;993.9403635781877;1002.2533212756543;1005.7535903703639;1049.611643691839;1049.8477720730605;10688.51901664427;11119.888801112047;11251.324920504796;11360.829587556193;11640.708982275512;540621;550455;552883;553094;554481;96520;97175;98514;99038.5048074755;100205;1003.1924300937815;1021.1881554164308;1029.5109822834243;1040.5837664934088;1041.9426931518688;16241.3503459865;18135.45593632193;18262.44587933927;18408.35570755017;18434.72347914809;38692.6130738689;44459.33311000273;45028.32457513074;45222.54777452315;45578.54421455876;60597.69701151466;62348.37651623425;62540;63360.36639633729;64650.030249547235;8382.245597896219;8443.873341899754;8538.573071346284;8540.572971351283;8648.30813534903;9663.420194788336;11895;13423.865761342653;13714.657133571342;14752.704945901236;12316.199447035913;12380.380980950737;12763.489460421479;12807.80788288195;12938.159019663692;12295.877041229473;12296.385180741107;12371.195872268274;12680.873191268338;12810.743785124432;12384.62846114618;12473.126881118234;12943.611691649265;13025.609231723063;13170.539031133865;8650.956745216234;12596.307203103917;13112.409941552844;13616.727665446833;13772.586822395344;12478.812817807559;12743.681407964876;13049.151805132637;13059.412326445523;13087 04:05:14 INFO - PROCESS | 18186 | |3;mootools.html;1549.8527639874212;1566.3812793946393;1770.5485101299175;1865.384423140362;1884.1238823946871;8255.91744082559;8853.734387968363;8945.418547794388;9548.474833884142;9566.712998610044;9013.819723605524;9256.352055356128;9318.813623727521;9325.766855828608;9353.111454411837;2421.8425802322836;2442.291735396742;2467.716212635543;2469.1358024691303;2469.790067844235;2381.1427885961125;2390.438247011951;2437.7196622388387;2441.5361081394567;2449.4121410861444;2394.5450364430703;2406.6871306730186;2412.95174096518;2414.6619473273754;2443.1815341860497;2325.686032385623;2340.8361414700976;2344.42561572415;2350.612148995414;2354.611489104313;2402.1112188490197;2402.519496100769;2403.531311394279;2403.663487111806;2414.9517009659885;9405.965343812244;9468.526573671357;9484.241260699197;9484.478353690543;9487.525623718855;5423.728813559306;5763.567732420085;5764.682942438164;5767.423257674241;5775.335836378828;3338.2322065924973;3377.696007359325;3406.097384193191;3409.8295085245886;3419;1217.4704003758304;1219.1283232488724;1220.1215125109907;1258.8174714666413;1264.1467009768462;12821.615351539469;12883.871161288454;12923.418446169944;12935.417906194243;12977.805332920014;4745.366321691426;4784.521547845187;4954.876128096755;4975.726335051534;5074.416442109131;10952.671419857417;10965.067969222546;10967.341959482297;11015.284006539548;11018.669439916815;5699.544036477155;5727.541796656257;5740.483356497935;5746.798862039892;5749.568782341341;4551.613112885376;5135.281060651511;5229.660072095302;5246.186841039645;5278.9208161877605;4271.957280427218;4319.416878721332;4433.689641725113;4445.711028783184;4450.710703804242;1349.466960550577;1380.5030189131905;1389.298404305819;1391.6451304917182;1409.7321508913274;886.7206829848577;1008.6268080810147;1029.8609687692065;1041.6927006533092;1077.2297807067985;6024.728887200086;6036;6131.356207598138;6150.231221097363;6233.532485063638;498.14568015852984;513.3352308760165;515.6648178683811;516.1277441124488;528.0890463949656;4286.77826819355;4342.652587792969;4373.978130109329;4383.7588932609015;4483.372327874035;11374.943125284486;11640.592579259684;11686.883131168579;11770.176087673952;11821.468033938494;11233;11240.325580465198;11456.4844581994;11542.884571154182;11623.476943537562;8438.535880526508;8534;8587.355948303903;8587.441816282048;8603.225709686158;6235.314115447207;6414.294427613052;6452.290248072614;6465.741370345321;6554.508411869034;10489.632862850069;10575.471226438493;10642.04221620058;10755.731106722082;10837.078848297982;10774.353538787698;10915.672529824118;10916.07213386871;10922.56309747633;10944.343339399662;7171.533850299714;8129.79675508117;8203.671853125808;8292.543910085004;8340.374471914509;9189.356745027784;9224.354295199271;9278.211352035152;9286;9299.67451139207;7844.84310313802;8075.798105047185;8081.757547273592;8321.542315172723;8357.95821020891;8169.5098294102545;8207.261346478846;8244.258016778518;8315.085340612406;8478.83042339162;7115.039469671528;7208.89186662211;7284.053073100463;7354;7431.70273189088;5247.370315562157;5247.842564723064;5258.842234732964;5262.6316157870115;5387.326584176978;5116.2069879168785;5168.508991645787;5280.867978300574;5290.470952904679;5333.839984800462 04:05:14 INFO - PROCESS | 18186 | |4;prototype.html;331.82413320939895;333.6113427856547;333.65466741922114;350.7860205274782;352.1723948720507;5695.45893140151;5803.0694499277915;5972.6117802342815;6040.637561746298;6076.605020673659;5760.913586296209;5825.912611310823;5836.708164591774;5845.357010728816;5872.73572689229;4590.42619672541;4605.319058543624;4607.424071991001;4612.308153776943;4631.305304204363;4454.242778727608;4523.728576285417;4545.136424079431;4568.45178578571;4621.607163391116;4485.900954266193;4487.439070116236;4520.344550040242;4522.886927826798;4530.821986283573;4522.163399771053;4536.77316134192;4549.795259213327;4566.840160594396;4588.128255631419;3902.2585708715255;3978.403239514067;4033.3546632538946;4037.232925744129;4040.939385909214;5676.3188417389765;5682.460166284196;5709.943660422835;5723.427657234285;5744.138379243105;5243.213517972296;5247.580193584504;5258.922725523397;5259.605529585297;5281.128613778722;5922.200502932092;6098.512119030467;6122.142899994004;6127.325994140641;6134.294556126013;4406.294992801137;4424.933625995613;4441.311596702516;4451.844185453494;4456.77716114193;6199.125546533417;6419.711112999927;6426.164598602199;6428.8071357859335;6464.967675161641;4512.842050528216;4518.209313370147;4543.409356783597;4547.477040140427;4581.289900065429;4596.850787303174;4626.930596041062;4627.583517483443;4630.930536041962;4633;5174.741262936838;5216.321878155815;5253.474652534716;5256.369235691742;5288.92066619001;5934.525237980951;6089.939100609025;6102.69486525672;6123.693815309217;6148.4773794227995;1534.6547026918854;1548.914809685478;1549.2253873063469;1552.9844701553066;1564.2022568489924;927.9443233406017;970.9951450242703;979.3536266064364;981.7153025622489;991.1674193677345;5242.322456813783;5256.395514515803;5265.420803711589;5268.394134674485;5281.947180528223;5533.399302327899;5538.504603757044;5573.216570697419;5615.466530679579;5633.408492108351;5092.096887998508;5259.579913423354;5326.147816349366;5337.572994160458;5367.75845086972;2950.631171103612;2958.5946675329046;3000.7149320814488;3014.1861697341596;3016.9396612067635;5681.715914204273;5752.597318187771;5753.568482363839;5756.495924272955;5759.337676167294;6001.609895356788;6468.870622587522;6482.611043337321;6494.480441564758;6496.935030649727;6554.901676474857;6585;6631.801045968628;6642.933570664328;6685.732570697215;6206.255249370104;6291.615844514199;6371.713272902638;6386.9680651596445;6442.033694945608;6282.246130464374;6321.367863213642;6321.810345689637;6367.840803979938;6370;6394.90407643895;6561.540692151694;6576.76390027393;6666.899996500153;6691.832704182434;4469.597736203757;4524.751138687404;4533.206688829376;4556.6582506312825;4568.223402021597;6141.723622436912;6287.182666253358;6429.678516074271;6458.967705161444;6493.967530162319;6170.81487555374;6209.410106039919;6233.158523599256;6247;6263.248410190807;6175.166352542349;6222.564420490703;6236;6318.652474113784;6337.302896681454;6126.908096378647;6135.84660383494;6155.2921414037955;6157.138000679998;6196.876062478816;6215.875682486416;6256.499480041494;6293.496520278275;6311.589746666452;6343.11196432509;5915.763369465173;6030.160800955575;6093.9390606093375;6109.969450152721;6175.505959523317 04:05:14 INFO - PROCESS | 18186 | |5;yui.html;778.8481246157002;819.606588837358;831.4138532334705;910.2808781062959;938.8591711243317;15716.607084822885;15719;17135.657286854257;17687.204075816586;18019.639607207882;15422.228888555555;15540.53378398647;15548.37806487742;15550.377984880592;15563.299651515681;738.4830618566998;867.5575456517158;871.5903525343078;875.7066382761783;892.0232345581578;876.5704804645742;879.2702057292464;880.916312950272;881.7971866470716;884.2263019857625;904.3398319226968;913.0777914306532;913.6528119314685;920.8802855628759;921.138735282513;915.4324318922278;916.3402350307801;920.2729843423688;921.4056933277998;924.5977999570208;667.3160010988776;668.2281964331205;669.5380187670492;676.4182802789597;677.864427114579;16240.675186496323;16314.510564683078;16324.183790810412;16357.83642163575;16414.26135823891;14161.929190354085;14203.147811131365;14718.484853030093;14828.777568336483;14854.257287135708;13916.165030098227;14269.714605707932;14563.199024053672;14864.331105100297;14885.330160142712;4734.218853889104;4738.3129446230105;4809.422869255712;4809.735464549449;4928.802847886081;93980;95505;96073;96465;97070;11274.943625281821;11598.942005290088;11737.823932641017;11853.703657408634;12017.63947081589;20929.372118836458;21279.680804787942;21280.574388512145;21627;21688.56622867534;8511.787205319917;8619.051904290523;8854.424462409923;8859.778505537413;8948.373613847098;4861.368022157168;4876.4879687633;4906.852794416173;5013.724245166478;5162.74186290684;3753.2681127180485;3874.728768986144;3874.9806250969127;3884.1843212925037;3885.0870045539277;652.9020646903002;661.5501459007921;666.3469799596422;677.3091446724313;679.3342524326188;637.9936200638027;678;682.6859644563457;705.3827900586987;725.2783480436893;9762.974887636838;10031.247656425798;10066.396016239049;10072.446015469219;10131.581578579006;647.5273050673035;677.6882633988322;677.8576498935279;700.7302188657403;706.7102487979904;4695.366125573072;4749.952500474951;4808.656980139455;4847.103285892122;4857.732824694675;74350.25649743542;94565.5271723637;129454.35272823575;132978.33510832384;135759.32120339334;118572.40713796376;118883;119836.2764355738;121251;122743;77784;78317.60841195758;78801;91633.08366916378;96763.03236967682;9459.195968342492;9518.857217141887;9549.952250238704;9625.807483850424;9629.229661626912;54590.72704636451;55675.72162139163;55758;56795.71602141963;56939.14591281217;71441.6427917857;78758.6062069686;80897.59551202206;81648.59175704083;84486.57756711177;13064.80402793978;13076.476940922257;13250.271235082164;13299.933500332436;13453.865461345262;14934.477293294682;14957.102573845605;15987.120708361152;16461.176941153135;16498.75251871199;14104.858951410355;14653;14704.338304776096;15148.772768408704;15494.922525387752;14272.21502817355;15314.387424502895;15323.233838307817;15524.456644017406;15545;14711.411543538139;14726;14735.705285894437;14883.776743349075;14902.478413255483;11046.668599942015;11288.435578220891;11337.498507700227;11599.826002610136;11700.30892894656;11709.531618735155;11831;11900.107491938312;11999.443964532826;12114.75770484603 04:05:14 INFO - PROCESS | 18186 | __end_tp_report 04:05:14 INFO - PROCESS | 18186 | __start_cc_report 04:05:14 INFO - PROCESS | 18186 | _x_x_mozilla_cycle_collect,321 04:05:14 INFO - PROCESS | 18186 | __end_cc_report 04:05:14 INFO - PROCESS | 18186 | __startTimestamp1472036714510__endTimestamp 04:05:14 INFO - PROCESS | 18186 | 04:05:14 INFO - PROCESS | 18186 | ------- Summary: start ------- 04:05:14 INFO - PROCESS | 18186 | Number of tests: 6 04:05:14 INFO - PROCESS | 18186 | 04:05:14 INFO - PROCESS | 18186 | [#0] dojo.html Cycles:165 Average:5736.60 Median:5960.85 stddev:672.96 (11.3%) stddev-sans-first:646.25 04:05:14 INFO - PROCESS | 18186 | Values: 3254.8 3277.9 3293.0 3304.1 3304.4 5786.6 5825.7 5834.3 5835.1 5846.6 5784.5 5818.0 5832.8 5852.0 5868.6 5275.2 5296.0 5297.6 5335.6 5348.4 5185.9 5189.4 5228.1 5246.0 5258.2 5308.4 5335.2 5343.8 5355.1 5362.5 5322.2 5325.1 5340.0 5347.4 5381.4 5010.1 5044.9 5138.7 5233.5 5299.3 5102.8 5608.2 5633.9 5697.8 5789.5 6175.5 6212.0 6214.5 6225.3 6243.9 6229.2 6246.7 6252.8 6255.3 6267.7 5585.0 5725.7 5729.1 5747.0 5839.5 6229.4 6259.7 6269.8 6285.8 6320.2 6031.0 6059.2 6100.5 6103.5 6112.8 6020.5 6113.0 6114.8 6118.6 6233.2 6134.9 6184.5 6186.5 6200.6 6200.9 6192.6 6213.3 6224.7 6227.7 6228.4 4545.8 4560.8 4565.4 4600.5 4648.2 4182.3 4184.6 4190.1 4193.2 4216.7 5910.6 5944.0 5947.7 5948.9 5956.5 6117.7 6127.2 6134.9 6199.2 6238.7 5951.0 5951.3 5952.3 5962.8 5984.2 5068.6 5169.9 5204.0 5216.4 5239.3 6242.7 6278.0 6302.8 6409.5 6410.8 6154.8 6179.6 6181.4 6189.4 6191.7 6280.1 6397.3 6399.1 6399.9 6400.9 6095.4 6110.0 6116.2 6174.9 6183.7 6290.0 6290.0 6296.1 6307.5 6314.6 5912.8 6085.1 6131.3 6135.4 6160.3 5959.1 5960.9 5988.2 6053.9 6067.6 5944.1 5950.5 5989.1 5990.7 5996.6 5939.3 6021.8 6054.0 6087.2 6102.8 5870.5 5886.7 5937.8 5938.8 5992.2 04:05:14 INFO - PROCESS | 18186 | 04:05:14 INFO - PROCESS | 18186 | [#1] ext.html Cycles:180 Average:70045.02 Median:44863.77 stddev:149457.52 (333.1%) stddev-sans-first:149785.80 04:05:14 INFO - PROCESS | 18186 | Values: 584.5 641.3 664.2 679.1 716.0 41175.6 46409.0 46584.3 46611.8 46620.3 46624.3 46652.3 46670.8 46724.0 46950.3 8868.2 9080.9 9084.1 9144.8 9174.6 9098.3 9217.1 9225.3 9232.8 9250.4 9204.5 9234.3 9239.7 9315.4 9327.8 9151.8 9152.7 9216.2 9257.8 9265.1 9150.5 9222.0 9235.4 9253.6 9256.2 43936.3 44186.8 44352.6 44442.8 44469.6 3847.5 3927.5 3929.6 3995.5 4512.2 35745.6 35867.9 36093.3 36234.6 36398.5 4687.6 4692.7 4712.9 4770.4 4871.5 362729.0 367181.0 368547.0 370784.0 371505.0 64456.4 64753.0 64777.4 64794.0 64851.7 39318.0 39994.4 40258.4 42442.6 69051.0 14825.9 14936.0 14971.3 15097.2 15103.9 11726.8 11737.9 11805.2 11827.8 11834.9 21139.2 21486.0 21507.0 21614.1 21624.2 7415.6 7472.7 7606.7 7651.0 7841.8 1007.9 1055.4 1135.7 1229.2 1232.3 33657.8 33716.5 33880.3 34486.8 34492.0 1146.3 1173.3 1185.5 1195.9 1217.8 18056.7 18143.7 18162.7 18285.0 18387.8 705388.0 711059.0 715293.0 715771.0 717222.0 64426.7 64584.0 64651.0 64744.4 64887.0 1364.3 1366.3 1371.8 1416.2 1428.6 32726.7 33980.3 34038.3 34059.5 34342.7 57901.4 58213.4 58232.7 58278.0 58482.4 538010.0 539553.0 541950.0 545196.0 548477.0 31134.2 31408.0 31650.4 31880.4 32016.7 53068.2 53094.5 53149.7 53261.2 54252.0 44498.3 45068.5 45488.8 45995.3 46151.0 44659.0 46434.3 46641.5 46674.3 46694.8 38775.2 43465.8 44190.6 44241.0 44398.6 37580.6 39011.6 39789.2 41217.4 42471.8 30561.8 30595.0 30725.1 30989.7 31094.2 04:05:14 INFO - PROCESS | 18186 | 04:05:14 INFO - PROCESS | 18186 | [#2] jquery.html Cycles:180 Average:31376.69 Median:11851.57 stddev:90672.54 (765.1%) stddev-sans-first:90897.08 04:05:14 INFO - PROCESS | 18186 | Values: 402.4 402.8 414.4 421.4 423.8 19161.5 20483.8 20867.2 21561.7 21609.0 20046.8 20256.3 20372.9 20640.3 20790.3 5726.6 5977.1 5983.5 5984.8 5993.6 5798.8 5822.9 5884.6 5913.9 5944.0 5726.7 5843.6 5856.0 5865.7 5890.9 5606.4 5811.7 5847.5 5884.9 5887.0 5704.9 5777.3 5779.3 5795.7 5880.5 14573.7 14761.6 14902.2 16336.4 25057.1 2413.0 2417.4 2427.9 2555.2 2741.2 10368.0 10755.7 11235.2 11985.5 15216.3 1931.2 1949.3 1967.2 2048.2 2067.3 84725.0 86915.0 87431.6 87471.6 87636.0 9846.0 10051.6 10391.1 10548.9 10635.4 13920.0 14044.4 14077.3 14174.1 14189.8 7504.4 7604.6 7663.7 7704.3 7722.0 7306.6 7382.2 7420.4 7469.0 7599.3 4287.8 4306.9 4374.0 4464.3 4490.5 2020.3 2103.2 2114.7 2123.8 2141.5 968.4 976.4 986.1 1030.1 1095.9 20331.4 20683.0 20983.6 20992.6 21069.7 993.9 1002.3 1005.8 1049.6 1049.8 10688.5 11119.9 11251.3 11360.8 11640.7 540621.0 550455.0 552883.0 553094.0 554481.0 96520.0 97175.0 98514.0 99038.5 100205.0 1003.2 1021.2 1029.5 1040.6 1041.9 16241.4 18135.5 18262.4 18408.4 18434.7 38692.6 44459.3 45028.3 45222.5 45578.5 60597.7 62348.4 62540.0 63360.4 64650.0 8382.2 8443.9 8538.6 8540.6 8648.3 9663.4 11895.0 13423.9 13714.7 14752.7 12316.2 12380.4 12763.5 12807.8 12938.2 12295.9 12296.4 12371.2 12680.9 12810.7 12384.6 12473.1 12943.6 13025.6 13170.5 8651.0 12596.3 13112.4 13616.7 13772.6 12478.8 12743.7 13049.2 13059.4 13087.0 04:05:14 INFO - PROCESS | 18186 | 04:05:14 INFO - PROCESS | 18186 | [#3] mootools.html Cycles:180 Average:6120.88 Median:4764.94 stddev:3512.27 (73.7%) stddev-sans-first:3505.33 04:05:14 INFO - PROCESS | 18186 | Values: 1549.9 1566.4 1770.5 1865.4 1884.1 8255.9 8853.7 8945.4 9548.5 9566.7 9013.8 9256.4 9318.8 9325.8 9353.1 2421.8 2442.3 2467.7 2469.1 2469.8 2381.1 2390.4 2437.7 2441.5 2449.4 2394.5 2406.7 2413.0 2414.7 2443.2 2325.7 2340.8 2344.4 2350.6 2354.6 2402.1 2402.5 2403.5 2403.7 2415.0 9406.0 9468.5 9484.2 9484.5 9487.5 5423.7 5763.6 5764.7 5767.4 5775.3 3338.2 3377.7 3406.1 3409.8 3419.0 1217.5 1219.1 1220.1 1258.8 1264.1 12821.6 12883.9 12923.4 12935.4 12977.8 4745.4 4784.5 4954.9 4975.7 5074.4 10952.7 10965.1 10967.3 11015.3 11018.7 5699.5 5727.5 5740.5 5746.8 5749.6 4551.6 5135.3 5229.7 5246.2 5278.9 4272.0 4319.4 4433.7 4445.7 4450.7 1349.5 1380.5 1389.3 1391.6 1409.7 886.7 1008.6 1029.9 1041.7 1077.2 6024.7 6036.0 6131.4 6150.2 6233.5 498.1 513.3 515.7 516.1 528.1 4286.8 4342.7 4374.0 4383.8 4483.4 11374.9 11640.6 11686.9 11770.2 11821.5 11233.0 11240.3 11456.5 11542.9 11623.5 8438.5 8534.0 8587.4 8587.4 8603.2 6235.3 6414.3 6452.3 6465.7 6554.5 10489.6 10575.5 10642.0 10755.7 10837.1 10774.4 10915.7 10916.1 10922.6 10944.3 7171.5 8129.8 8203.7 8292.5 8340.4 9189.4 9224.4 9278.2 9286.0 9299.7 7844.8 8075.8 8081.8 8321.5 8358.0 8169.5 8207.3 8244.3 8315.1 8478.8 7115.0 7208.9 7284.1 7354.0 7431.7 5247.4 5247.8 5258.8 5262.6 5387.3 5116.2 5168.5 5280.9 5290.5 5333.8 04:05:14 INFO - PROCESS | 18186 | 04:05:14 INFO - PROCESS | 18186 | [#4] prototype.html Cycles:180 Average:5115.48 Median:5733.78 stddev:1526.20 (26.6%) stddev-sans-first:1487.65 04:05:14 INFO - PROCESS | 18186 | Values: 331.8 333.6 333.7 350.8 352.2 5695.5 5803.1 5972.6 6040.6 6076.6 5760.9 5825.9 5836.7 5845.4 5872.7 4590.4 4605.3 4607.4 4612.3 4631.3 4454.2 4523.7 4545.1 4568.5 4621.6 4485.9 4487.4 4520.3 4522.9 4530.8 4522.2 4536.8 4549.8 4566.8 4588.1 3902.3 3978.4 4033.4 4037.2 4040.9 5676.3 5682.5 5709.9 5723.4 5744.1 5243.2 5247.6 5258.9 5259.6 5281.1 5922.2 6098.5 6122.1 6127.3 6134.3 4406.3 4424.9 4441.3 4451.8 4456.8 6199.1 6419.7 6426.2 6428.8 6465.0 4512.8 4518.2 4543.4 4547.5 4581.3 4596.9 4626.9 4627.6 4630.9 4633.0 5174.7 5216.3 5253.5 5256.4 5288.9 5934.5 6089.9 6102.7 6123.7 6148.5 1534.7 1548.9 1549.2 1553.0 1564.2 927.9 971.0 979.4 981.7 991.2 5242.3 5256.4 5265.4 5268.4 5281.9 5533.4 5538.5 5573.2 5615.5 5633.4 5092.1 5259.6 5326.1 5337.6 5367.8 2950.6 2958.6 3000.7 3014.2 3016.9 5681.7 5752.6 5753.6 5756.5 5759.3 6001.6 6468.9 6482.6 6494.5 6496.9 6554.9 6585.0 6631.8 6642.9 6685.7 6206.3 6291.6 6371.7 6387.0 6442.0 6282.2 6321.4 6321.8 6367.8 6370.0 6394.9 6561.5 6576.8 6666.9 6691.8 4469.6 4524.8 4533.2 4556.7 4568.2 6141.7 6287.2 6429.7 6459.0 6494.0 6170.8 6209.4 6233.2 6247.0 6263.2 6175.2 6222.6 6236.0 6318.7 6337.3 6126.9 6135.8 6155.3 6157.1 6196.9 6215.9 6256.5 6293.5 6311.6 6343.1 5915.8 6030.2 6093.9 6110.0 6175.5 04:05:14 INFO - PROCESS | 18186 | 04:05:14 INFO - PROCESS | 18186 | [#5] yui.html Cycles:180 Average:22537.72 Median:4779.30 stddev:33029.42 (691.1%) stddev-sans-first:33081.67 04:05:14 INFO - PROCESS | 18186 | Values: 778.8 819.6 831.4 910.3 938.9 15716.6 15719.0 17135.7 17687.2 18019.6 15422.2 15540.5 15548.4 15550.4 15563.3 738.5 867.6 871.6 875.7 892.0 876.6 879.3 880.9 881.8 884.2 904.3 913.1 913.7 920.9 921.1 915.4 916.3 920.3 921.4 924.6 667.3 668.2 669.5 676.4 677.9 16240.7 16314.5 16324.2 16357.8 16414.3 14161.9 14203.1 14718.5 14828.8 14854.3 13916.2 14269.7 14563.2 14864.3 14885.3 4734.2 4738.3 4809.4 4809.7 4928.8 93980.0 95505.0 96073.0 96465.0 97070.0 11274.9 11598.9 11737.8 11853.7 12017.6 20929.4 21279.7 21280.6 21627.0 21688.6 8511.8 8619.1 8854.4 8859.8 8948.4 4861.4 4876.5 4906.9 5013.7 5162.7 3753.3 3874.7 3875.0 3884.2 3885.1 652.9 661.6 666.3 677.3 679.3 638.0 678.0 682.7 705.4 725.3 9763.0 10031.2 10066.4 10072.4 10131.6 647.5 677.7 677.9 700.7 706.7 4695.4 4750.0 4808.7 4847.1 4857.7 74350.3 94565.5 129454.4 132978.3 135759.3 118572.4 118883.0 119836.3 121251.0 122743.0 77784.0 78317.6 78801.0 91633.1 96763.0 9459.2 9518.9 9550.0 9625.8 9629.2 54590.7 55675.7 55758.0 56795.7 56939.1 71441.6 78758.6 80897.6 81648.6 84486.6 13064.8 13076.5 13250.3 13299.9 13453.9 14934.5 14957.1 15987.1 16461.2 16498.8 14104.9 14653.0 14704.3 15148.8 15494.9 14272.2 15314.4 15323.2 15524.5 15545.0 14711.4 14726.0 14735.7 14883.8 14902.5 11046.7 11288.4 11337.5 11599.8 11700.3 11709.5 11831.0 11900.1 11999.4 12114.8 04:05:14 INFO - PROCESS | 18186 | -------- Summary: end -------- 04:05:14 INFO - PROCESS | 18186 | 04:05:15 INFO - TEST-INFO | 18186: exit 0 04:05:15 INFO - TEST-OK | dromaeo_css | took 1110387ms 04:05:15 INFO - TEST-START | kraken 04:05:15 INFO - operating with platform_type : linux_ 04:05:15 INFO - Initialising browser for kraken test... 04:05:15 INFO - TEST-INFO | started process 18449 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRo8HJL/profile http://localhost:51039/getInfo.html) 04:05:19 INFO - PROCESS | 18449 | __metrics Screen width/height:1600/1200 04:05:19 INFO - PROCESS | 18449 | colorDepth:24 04:05:19 INFO - PROCESS | 18449 | Browser inner width/height: 1024/697 04:05:19 INFO - PROCESS | 18449 | __metrics 04:05:20 ERROR - PROCESS | 18449 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 04:05:21 INFO - TEST-INFO | 18449: exit 0 04:05:21 INFO - Browser initialized. 04:05:21 INFO - Running cycle 1/1 for kraken test... 04:05:21 INFO - TEST-INFO | started process 18573 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRo8HJL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:05:32 INFO - PROCESS | 18573 | RSS: Main: 152576000 04:05:32 INFO - PROCESS | 18573 | 04:05:35 INFO - PROCESS | 18573 | Cycle 1(1): loaded http://localhost:51039/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51039/tests/kraken/driver.html?testName=audio-beat-detection) 04:05:36 INFO - PROCESS | 18573 | RSS: Main: 157609984 04:05:36 INFO - PROCESS | 18573 | 04:05:38 INFO - PROCESS | 18573 | Cycle 1(1): loaded http://localhost:51039/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51039/tests/kraken/driver.html?testName=audio-dft) 04:05:39 INFO - PROCESS | 18573 | RSS: Main: 156639232 04:05:39 INFO - PROCESS | 18573 | 04:05:42 INFO - PROCESS | 18573 | Cycle 1(1): loaded http://localhost:51039/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51039/tests/kraken/driver.html?testName=audio-fft) 04:05:42 INFO - PROCESS | 18573 | RSS: Main: 157032448 04:05:42 INFO - PROCESS | 18573 | 04:05:45 INFO - PROCESS | 18573 | Cycle 1(1): loaded http://localhost:51039/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51039/tests/kraken/driver.html?testName=audio-oscillator) 04:05:45 INFO - PROCESS | 18573 | RSS: Main: 156737536 04:05:45 INFO - PROCESS | 18573 | 04:05:47 INFO - PROCESS | 18573 | Cycle 1(1): loaded http://localhost:51039/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51039/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:05:48 INFO - PROCESS | 18573 | RSS: Main: 156643328 04:05:48 INFO - PROCESS | 18573 | 04:05:51 INFO - PROCESS | 18573 | Cycle 1(1): loaded http://localhost:51039/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51039/tests/kraken/driver.html?testName=imaging-darkroom) 04:05:52 INFO - PROCESS | 18573 | RSS: Main: 156205056 04:05:52 INFO - PROCESS | 18573 | 04:05:55 INFO - PROCESS | 18573 | Cycle 1(1): loaded http://localhost:51039/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51039/tests/kraken/driver.html?testName=imaging-desaturate) 04:05:56 INFO - PROCESS | 18573 | RSS: Main: 155119616 04:05:56 INFO - PROCESS | 18573 | 04:05:59 INFO - PROCESS | 18573 | Cycle 1(1): loaded http://localhost:51039/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51039/tests/kraken/driver.html?testName=json-parse-financial) 04:05:59 INFO - PROCESS | 18573 | RSS: Main: 156463104 04:05:59 INFO - PROCESS | 18573 | 04:06:01 INFO - PROCESS | 18573 | Cycle 1(1): loaded http://localhost:51039/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51039/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:06:01 INFO - PROCESS | 18573 | RSS: Main: 156610560 04:06:01 INFO - PROCESS | 18573 | 04:06:03 INFO - PROCESS | 18573 | Cycle 1(1): loaded http://localhost:51039/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51039/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:06:04 INFO - PROCESS | 18573 | RSS: Main: 157167616 04:06:04 INFO - PROCESS | 18573 | 04:06:06 INFO - PROCESS | 18573 | Cycle 1(1): loaded http://localhost:51039/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51039/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:06:06 INFO - PROCESS | 18573 | RSS: Main: 157270016 04:06:06 INFO - PROCESS | 18573 | 04:06:09 INFO - PROCESS | 18573 | Cycle 1(1): loaded http://localhost:51039/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51039/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:06:10 INFO - PROCESS | 18573 | RSS: Main: 157597696 04:06:10 INFO - PROCESS | 18573 | 04:06:12 INFO - PROCESS | 18573 | Cycle 1(1): loaded http://localhost:51039/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51039/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:06:13 INFO - PROCESS | 18573 | RSS: Main: 157495296 04:06:13 INFO - PROCESS | 18573 | 04:06:15 INFO - PROCESS | 18573 | Cycle 1(1): loaded http://localhost:51039/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51039/tests/kraken/driver.html?testName=ai-astar) 04:06:15 INFO - PROCESS | 18573 | RSS: Main: 158453760 04:06:15 INFO - PROCESS | 18573 | 04:06:15 INFO - PROCESS | 18573 | __start_tp_report 04:06:15 INFO - PROCESS | 18573 | _x_x_mozilla_page_load 04:06:15 INFO - PROCESS | 18573 | _x_x_mozilla_page_load_details 04:06:15 INFO - PROCESS | 18573 | |i|pagename|runs| 04:06:15 INFO - PROCESS | 18573 | |0;ai-astar;101;112;105;113;111;113;111;119;111;111 04:06:15 INFO - PROCESS | 18573 | |1;audio-beat-detection;146;117;144;173;116;152;143;118;174;120 04:06:15 INFO - PROCESS | 18573 | |2;audio-dft;163;161;164;163;162;163;164;163;163;163 04:06:15 INFO - PROCESS | 18573 | |3;audio-fft;76;76;76;174;75;76;76;75;177;76 04:06:15 INFO - PROCESS | 18573 | |4;audio-oscillator;84;84;146;83;84;84;141;84;84;142 04:06:15 INFO - PROCESS | 18573 | |5;imaging-gaussian-blur;118;117;117;117;117;117;118;118;118;122 04:06:15 INFO - PROCESS | 18573 | |6;imaging-darkroom;148;146;146;147;157;148;148;149;148;147 04:06:15 INFO - PROCESS | 18573 | |7;imaging-desaturate;96;95;97;95;95;95;95;96;95;94 04:06:15 INFO - PROCESS | 18573 | |8;json-parse-financial;51;51;50;50;61;53;51;51;51;54 04:06:15 INFO - PROCESS | 18573 | |9;json-stringify-tinderbox;69;61;61;60;61;61;60;60;61;62 04:06:15 INFO - PROCESS | 18573 | |10;stanford-crypto-aes;75;74;73;73;74;74;74;72;74;72 04:06:15 INFO - PROCESS | 18573 | |11;stanford-crypto-ccm;123;133;120;124;122;138;126;127;156;135 04:06:15 INFO - PROCESS | 18573 | |12;stanford-crypto-pbkdf2;154;155;155;157;150;155;153;150;151;151 04:06:15 INFO - PROCESS | 18573 | |13;stanford-crypto-sha256-iterative;65;64;64;61;64;62;64;62;63;61 04:06:15 INFO - PROCESS | 18573 | __end_tp_report 04:06:15 INFO - PROCESS | 18573 | __start_cc_report 04:06:15 INFO - PROCESS | 18573 | _x_x_mozilla_cycle_collect,817 04:06:15 INFO - PROCESS | 18573 | __end_cc_report 04:06:15 INFO - PROCESS | 18573 | __startTimestamp1472036775307__endTimestamp 04:06:15 INFO - PROCESS | 18573 | 04:06:15 INFO - PROCESS | 18573 | ------- Summary: start ------- 04:06:15 INFO - PROCESS | 18573 | Number of tests: 14 04:06:15 INFO - PROCESS | 18573 | 04:06:15 INFO - PROCESS | 18573 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.50 stddev:4.81 (4.3%) stddev-sans-first:3.60 04:06:15 INFO - PROCESS | 18573 | Values: 101.0 112.0 105.0 113.0 111.0 113.0 111.0 119.0 111.0 111.0 04:06:15 INFO - PROCESS | 18573 | 04:06:15 INFO - PROCESS | 18573 | [#1] audio-beat-detection Cycles:10 Average:140.30 Median:145.00 stddev:22.21 (15.3%) stddev-sans-first:23.46 04:06:15 INFO - PROCESS | 18573 | Values: 146.0 117.0 144.0 173.0 116.0 152.0 143.0 118.0 174.0 120.0 04:06:15 INFO - PROCESS | 18573 | 04:06:15 INFO - PROCESS | 18573 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 04:06:15 INFO - PROCESS | 18573 | Values: 163.0 161.0 164.0 163.0 162.0 163.0 164.0 163.0 163.0 163.0 04:06:15 INFO - PROCESS | 18573 | 04:06:15 INFO - PROCESS | 18573 | [#3] audio-fft Cycles:10 Average:95.70 Median:76.00 stddev:42.07 (55.4%) stddev-sans-first:44.01 04:06:15 INFO - PROCESS | 18573 | Values: 76.0 76.0 76.0 174.0 75.0 76.0 76.0 75.0 177.0 76.0 04:06:15 INFO - PROCESS | 18573 | 04:06:15 INFO - PROCESS | 18573 | [#4] audio-oscillator Cycles:10 Average:101.60 Median:84.00 stddev:28.60 (34.0%) stddev-sans-first:29.61 04:06:15 INFO - PROCESS | 18573 | Values: 84.0 84.0 146.0 83.0 84.0 84.0 141.0 84.0 84.0 142.0 04:06:15 INFO - PROCESS | 18573 | 04:06:15 INFO - PROCESS | 18573 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:1.52 (1.3%) stddev-sans-first:1.62 04:06:15 INFO - PROCESS | 18573 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 118.0 122.0 04:06:15 INFO - PROCESS | 18573 | 04:06:15 INFO - PROCESS | 18573 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.00 stddev:3.17 (2.1%) stddev-sans-first:3.36 04:06:15 INFO - PROCESS | 18573 | Values: 148.0 146.0 146.0 147.0 157.0 148.0 148.0 149.0 148.0 147.0 04:06:15 INFO - PROCESS | 18573 | 04:06:15 INFO - PROCESS | 18573 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.83 04:06:15 INFO - PROCESS | 18573 | Values: 96.0 95.0 97.0 95.0 95.0 95.0 95.0 96.0 95.0 94.0 04:06:15 INFO - PROCESS | 18573 | 04:06:15 INFO - PROCESS | 18573 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:51.00 stddev:3.30 (6.5%) stddev-sans-first:3.47 04:06:15 INFO - PROCESS | 18573 | Values: 51.0 51.0 50.0 50.0 61.0 53.0 51.0 51.0 51.0 54.0 04:06:15 INFO - PROCESS | 18573 | 04:06:15 INFO - PROCESS | 18573 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:61.00 stddev:2.67 (4.4%) stddev-sans-first:0.67 04:06:15 INFO - PROCESS | 18573 | Values: 69.0 61.0 61.0 60.0 61.0 61.0 60.0 60.0 61.0 62.0 04:06:15 INFO - PROCESS | 18573 | 04:06:15 INFO - PROCESS | 18573 | [#10] stanford-crypto-aes Cycles:10 Average:73.50 Median:74.00 stddev:0.97 (1.3%) stddev-sans-first:0.87 04:06:15 INFO - PROCESS | 18573 | Values: 75.0 74.0 73.0 73.0 74.0 74.0 74.0 72.0 74.0 72.0 04:06:15 INFO - PROCESS | 18573 | 04:06:15 INFO - PROCESS | 18573 | [#11] stanford-crypto-ccm Cycles:10 Average:130.40 Median:130.00 stddev:10.78 (8.3%) stddev-sans-first:11.10 04:06:15 INFO - PROCESS | 18573 | Values: 123.0 133.0 120.0 124.0 122.0 138.0 126.0 127.0 156.0 135.0 04:06:15 INFO - PROCESS | 18573 | 04:06:15 INFO - PROCESS | 18573 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.10 Median:154.50 stddev:2.47 (1.6%) stddev-sans-first:2.60 04:06:15 INFO - PROCESS | 18573 | Values: 154.0 155.0 155.0 157.0 150.0 155.0 153.0 150.0 151.0 151.0 04:06:15 INFO - PROCESS | 18573 | 04:06:15 INFO - PROCESS | 18573 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:64.00 stddev:1.41 (2.2%) stddev-sans-first:1.30 04:06:15 INFO - PROCESS | 18573 | Values: 65.0 64.0 64.0 61.0 64.0 62.0 64.0 62.0 63.0 61.0 04:06:15 INFO - PROCESS | 18573 | -------- Summary: end -------- 04:06:15 INFO - PROCESS | 18573 | 04:06:16 INFO - TEST-INFO | 18573: exit 0 04:06:16 INFO - TEST-OK | kraken | took 61019ms 04:06:16 INFO - SUITE-END | took 1171s 04:06:16 INFO - Completed test suite (00:19:31) 04:06:16 INFO - javascript benchmark 04:06:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7707.847564280452, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3254.788438751481, 3277.9016629501125, 3292.983535082324, 3304.09137487191, 3304.3721692878335, 5786.594938354312, 5825.65046097234, 5834.2998840139135, 5835.0663893777, 5846.561507886904, 5784.537237021039, 5817.970910145444, 5832.825015249549, 5852.0344143216425, 5868.559858010655, 5275.182346736253, 5296.046711591912, 5297.576193904479, 5335.599830012745, 5348.411674715778, 5185.896282074356, 5189.377274727038, 5228.137357336035, 5246.0, 5258.211268309746, 5308.442613525563, 5335.1730481775385, 5343.759530821103, 5355.0628639988045, 5362.51737343639, 5322.175062865262, 5325.094733895247, 5339.9733001335135, 5347.41178470368, 5381.381141168777, 5010.0981823271795, 5044.9495505045215, 5138.74306284688, 5233.528982391565, 5299.258103865462, 5102.795888164469, 5608.214849920973, 5633.943660563383, 5697.829065128053, 5789.478946894799, 6175.505959523227, 6211.968940155315, 6214.533909956771, 6225.346338634424, 6243.937560624381, 6229.221347331583, 6246.656433896179, 6252.843678908063, 6255.280642726054, 6267.749290028393, 5585.0, 5725.656460612377, 5729.054705973509, 5746.9712651436475, 5839.532837373, 6229.3770622937345, 6259.71831267594, 6269.780557680459, 6285.811425657146, 6320.241571011508, 6031.0, 6059.242594675666, 6100.450959413585, 6103.450689437883, 6112.847178820565, 6020.518358531307, 6112.99135642614, 6114.847128821726, 6118.619179173164, 6233.2208473940755, 6134.938650613526, 6184.536159788034, 6186.505079593621, 6200.627962322275, 6200.906986395207, 6192.566520343623, 6213.316535181127, 6224.657643829542, 6227.719752611143, 6228.377162283826, 4545.795439205178, 4560.771961401917, 4565.360849481075, 4600.5169457207185, 4648.233041548175, 4182.2890108681595, 4184.602462766033, 4190.141021090669, 4193.203291374629, 4216.683748718859, 5910.645361278337, 5943.970280148572, 5947.672877991666, 5948.940510594925, 5956.493698035715, 6117.663528505975, 6127.158986117706, 6134.944813464463, 6199.225096862892, 6238.719257633326, 5950.9702451487465, 5951.315598706205, 5952.255968003999, 5962.821115366546, 5984.192134061933, 5068.619853511002, 5169.948300517022, 5203.973980130151, 5216.40011398694, 5239.266502689627, 6242.687865606701, 6278.0, 6302.779402720975, 6409.487241020707, 6410.775622853178, 6154.753809847735, 6179.5983261086985, 6181.412765787243, 6189.3501182377, 6191.721372538336, 6280.0893870389455, 6397.296297407374, 6399.072134540559, 6399.93600064012, 6400.871982560416, 6095.420935011344, 6109.969450152721, 6116.174316467398, 6174.938250617616, 6183.659898705614, 6289.96855015722, 6290.0, 6296.087067375296, 6307.526935479949, 6314.62112273265, 5912.763489460545, 6085.087236914498, 6131.294901086432, 6135.386461353829, 6160.291566469734, 5959.106134079922, 5960.850978725566, 5988.161657367885, 6053.9091913622215, 6067.605605635619, 5944.078667806497, 5950.5239580834295, 5989.131575921554, 5990.6705131218205, 5996.640201587918, 5939.346671866005, 6021.7591296347655, 6054.031354983182, 6087.239095113111, 6102.816915492543, 5870.5010074144175, 5886.705664716833, 5937.762489500545, 5938.8218353449465, 5992.161097446274], "value": 5689.442976795, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.5060923519627, 641.3041849593191, 664.2394458345195, 679.1273213920114, 716.0047533927838, 41175.58824411755, 46409.0, 46584.30123548141, 46611.76694116533, 46620.3006954896, 46624.30063549041, 46652.30021549671, 46670.766646166805, 46724.0, 46950.29574556376, 8868.246199073086, 9080.909190908105, 9084.137006984325, 9144.817103657922, 9174.633014679404, 9098.31762617803, 9217.078292170763, 9225.261979041661, 9232.769180770467, 9250.398724082947, 9204.493752843591, 9234.261259099256, 9239.722808315728, 9315.441073535576, 9327.813443731122, 9151.771205719877, 9152.725418237464, 9216.216621587173, 9257.814843703089, 9265.073492650748, 9150.54247287633, 9221.953890230507, 9235.445873247627, 9253.6298548058, 9256.213221876149, 43936.3409548857, 44186.779066104464, 44352.556474435165, 44442.77778611086, 44469.55530444686, 3847.5190601174854, 3927.450156977997, 3929.5677475477673, 3995.5205375354853, 4512.165249428866, 35745.64254357449, 35867.92396228117, 36093.27813443716, 36234.63765362339, 36398.454023189675, 4687.5781179693995, 4692.741899195543, 4712.942985392931, 4770.427548694179, 4871.537203965618, 362729.0, 367181.0, 368547.0, 370784.0, 371505.0, 64456.35543644597, 64753.0, 64777.35222647808, 64794.0, 64851.67574162193, 39318.0, 39994.400083998764, 40258.39612405816, 42442.57557424448, 69051.0, 14825.851741482662, 14936.0, 14971.326290316962, 15097.245137743288, 15103.924480377527, 11726.824097638542, 11737.941310293394, 11805.17363784544, 11827.763444731228, 11834.881651183377, 21139.154433822783, 21486.0, 21507.0, 21614.135434582757, 21624.243151489623, 7415.555066696015, 7472.685580684313, 7606.657700403495, 7651.0, 7841.803954901059, 1007.9092881640687, 1055.4406164732704, 1135.7387800805861, 1229.225587879648, 1232.2994267910406, 33657.831710841776, 33716.49425258623, 33880.32239355249, 34486.82756586201, 34492.0, 1146.3293973025707, 1173.266708307308, 1185.5020891225706, 1195.9222650527688, 1217.7625363054296, 18056.72914906251, 18143.72784408235, 18162.727559086623, 18285.0, 18387.816121838878, 705388.0, 711059.0, 715293.0, 715771.0, 717222.0, 64426.677866610364, 64584.0, 64651.0, 64744.35255647383, 64887.0, 1364.3451143451, 1366.269046060353, 1371.8079468874366, 1416.199847086393, 1428.550006747871, 32726.672733273313, 33980.32039359248, 34038.319233615686, 34059.4891076639, 34342.65657343494, 57901.420985789606, 58213.4178658208, 58232.708836455546, 58278.0, 58482.415175847695, 538010.0, 539553.0, 541950.0, 545196.0, 548477.0, 31134.22164445907, 31408.0, 31650.366992659558, 31880.36239275248, 32016.67983320137, 53068.20397693961, 53094.469055310496, 53149.7342513285, 53261.201081983025, 54252.0, 44498.34423153982, 45068.54931450775, 45488.772556138334, 45995.3100703483, 46151.0, 44659.0, 46434.30348544707, 46641.53358466372, 46674.29988550243, 46694.76652616715, 38775.2244955105, 43465.78267108644, 44190.558094418644, 44241.0, 44398.556014440735, 37580.624193757714, 39011.6098839008, 39789.2042159161, 41217.38173927453, 42471.78764106283, 30561.847190763903, 30595.0, 30725.08321813353, 30989.69010309868, 31094.22264443407], "value": 21517.972687273195, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.42855145693113, 402.81671839313117, 414.4384359193293, 421.36794807788306, 423.7605752749696, 19161.52096197596, 20483.795162048376, 20867.165313387464, 21561.67657485139, 21609.02759375828, 20046.799532004676, 20256.291029813958, 20372.89813550934, 20640.277590284342, 20790.272340468087, 5726.62776919501, 5977.133315669225, 5983.521318294548, 5984.820455386323, 5993.610415323012, 5798.826035218929, 5822.912656310159, 5884.558658100638, 5913.881722365551, 5944.048952167654, 5726.656400615955, 5843.620164689303, 5855.970720146393, 5865.736041878125, 5890.941090589104, 5606.411326810667, 5811.6803575803315, 5847.502962248214, 5884.852878678024, 5886.970565147169, 5704.914426283609, 5777.335606405275, 5779.335376431723, 5795.681237531934, 5880.529557635379, 14573.708525829425, 14761.55715328542, 14902.180380079091, 16336.428225012067, 25057.12300069489, 2412.9517409651708, 2417.3835671903553, 2427.8664673442954, 2555.220657699401, 2741.232454912628, 10368.0, 10755.731106722316, 11235.21353505255, 11985.460654270491, 15216.315265813066, 1931.2082046361065, 1949.2690241159564, 1967.1836187982112, 2048.1602542957316, 2067.286786058807, 84725.0, 86915.0, 87431.56284218538, 87471.56264218701, 87636.0, 9846.0, 10051.64819231338, 10391.06480416751, 10548.894511054792, 10635.361878287173, 13920.0, 14044.36800343987, 14077.296135193199, 14174.07868488545, 14189.78715319271, 7504.399648028145, 7604.619769011527, 7663.6971714808615, 7704.305052888468, 7721.961390193013, 7306.634668266672, 7382.151052628909, 7420.406367490587, 7469.029026226556, 7599.278068583476, 4287.828486860553, 4306.870793876189, 4374.0, 4464.285714285764, 4490.50604433512, 2020.282799606148, 2103.2218079310446, 2114.669395701776, 2123.7982391673077, 2141.4646338415396, 968.4479846487435, 976.3604838830578, 986.146982859821, 1030.1141018723893, 1095.8684957805115, 20331.39005829798, 20683.0, 20983.580328393346, 20992.580148396948, 21069.683954740383, 993.9403635781877, 1002.2533212756543, 1005.7535903703639, 1049.611643691839, 1049.8477720730605, 10688.51901664427, 11119.888801112047, 11251.324920504796, 11360.829587556193, 11640.708982275512, 540621.0, 550455.0, 552883.0, 553094.0, 554481.0, 96520.0, 97175.0, 98514.0, 99038.5048074755, 100205.0, 1003.1924300937815, 1021.1881554164308, 1029.5109822834243, 1040.5837664934088, 1041.9426931518688, 16241.3503459865, 18135.45593632193, 18262.44587933927, 18408.35570755017, 18434.72347914809, 38692.6130738689, 44459.33311000273, 45028.32457513074, 45222.54777452315, 45578.54421455876, 60597.69701151466, 62348.37651623425, 62540.0, 63360.36639633729, 64650.030249547235, 8382.245597896219, 8443.873341899754, 8538.573071346284, 8540.572971351283, 8648.30813534903, 9663.420194788336, 11895.0, 13423.865761342653, 13714.657133571342, 14752.704945901236, 12316.199447035913, 12380.380980950737, 12763.489460421479, 12807.80788288195, 12938.159019663692, 12295.877041229473, 12296.385180741107, 12371.195872268274, 12680.873191268338, 12810.743785124432, 12384.62846114618, 12473.126881118234, 12943.611691649265, 13025.609231723063, 13170.539031133865, 8650.956745216234, 12596.307203103917, 13112.409941552844, 13616.727665446833, 13772.586822395344, 12478.812817807559, 12743.681407964876, 13049.151805132637, 13059.412326445523, 13087.0], "value": 9541.436338525098, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1549.8527639874212, 1566.3812793946393, 1770.5485101299175, 1865.384423140362, 1884.1238823946871, 8255.91744082559, 8853.734387968363, 8945.418547794388, 9548.474833884142, 9566.712998610044, 9013.819723605524, 9256.352055356128, 9318.813623727521, 9325.766855828608, 9353.111454411837, 2421.8425802322836, 2442.291735396742, 2467.716212635543, 2469.1358024691303, 2469.790067844235, 2381.1427885961125, 2390.438247011951, 2437.7196622388387, 2441.5361081394567, 2449.4121410861444, 2394.5450364430703, 2406.6871306730186, 2412.95174096518, 2414.6619473273754, 2443.1815341860497, 2325.686032385623, 2340.8361414700976, 2344.42561572415, 2350.612148995414, 2354.611489104313, 2402.1112188490197, 2402.519496100769, 2403.531311394279, 2403.663487111806, 2414.9517009659885, 9405.965343812244, 9468.526573671357, 9484.241260699197, 9484.478353690543, 9487.525623718855, 5423.728813559306, 5763.567732420085, 5764.682942438164, 5767.423257674241, 5775.335836378828, 3338.2322065924973, 3377.696007359325, 3406.097384193191, 3409.8295085245886, 3419.0, 1217.4704003758304, 1219.1283232488724, 1220.1215125109907, 1258.8174714666413, 1264.1467009768462, 12821.615351539469, 12883.871161288454, 12923.418446169944, 12935.417906194243, 12977.805332920014, 4745.366321691426, 4784.521547845187, 4954.876128096755, 4975.726335051534, 5074.416442109131, 10952.671419857417, 10965.067969222546, 10967.341959482297, 11015.284006539548, 11018.669439916815, 5699.544036477155, 5727.541796656257, 5740.483356497935, 5746.798862039892, 5749.568782341341, 4551.613112885376, 5135.281060651511, 5229.660072095302, 5246.186841039645, 5278.9208161877605, 4271.957280427218, 4319.416878721332, 4433.689641725113, 4445.711028783184, 4450.710703804242, 1349.466960550577, 1380.5030189131905, 1389.298404305819, 1391.6451304917182, 1409.7321508913274, 886.7206829848577, 1008.6268080810147, 1029.8609687692065, 1041.6927006533092, 1077.2297807067985, 6024.728887200086, 6036.0, 6131.356207598138, 6150.231221097363, 6233.532485063638, 498.14568015852984, 513.3352308760165, 515.6648178683811, 516.1277441124488, 528.0890463949656, 4286.77826819355, 4342.652587792969, 4373.978130109329, 4383.7588932609015, 4483.372327874035, 11374.943125284486, 11640.592579259684, 11686.883131168579, 11770.176087673952, 11821.468033938494, 11233.0, 11240.325580465198, 11456.4844581994, 11542.884571154182, 11623.476943537562, 8438.535880526508, 8534.0, 8587.355948303903, 8587.441816282048, 8603.225709686158, 6235.314115447207, 6414.294427613052, 6452.290248072614, 6465.741370345321, 6554.508411869034, 10489.632862850069, 10575.471226438493, 10642.04221620058, 10755.731106722082, 10837.078848297982, 10774.353538787698, 10915.672529824118, 10916.07213386871, 10922.56309747633, 10944.343339399662, 7171.533850299714, 8129.79675508117, 8203.671853125808, 8292.543910085004, 8340.374471914509, 9189.356745027784, 9224.354295199271, 9278.211352035152, 9286.0, 9299.67451139207, 7844.84310313802, 8075.798105047185, 8081.757547273592, 8321.542315172723, 8357.95821020891, 8169.5098294102545, 8207.261346478846, 8244.258016778518, 8315.085340612406, 8478.83042339162, 7115.039469671528, 7208.89186662211, 7284.053073100463, 7354.0, 7431.70273189088, 5247.370315562157, 5247.842564723064, 5258.842234732964, 5262.6316157870115, 5387.326584176978, 5116.2069879168785, 5168.508991645787, 5280.867978300574, 5290.470952904679, 5333.839984800462], "value": 4819.513121814138, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.82413320939895, 333.6113427856547, 333.65466741922114, 350.7860205274782, 352.1723948720507, 5695.45893140151, 5803.0694499277915, 5972.6117802342815, 6040.637561746298, 6076.605020673659, 5760.913586296209, 5825.912611310823, 5836.708164591774, 5845.357010728816, 5872.73572689229, 4590.42619672541, 4605.319058543624, 4607.424071991001, 4612.308153776943, 4631.305304204363, 4454.242778727608, 4523.728576285417, 4545.136424079431, 4568.45178578571, 4621.607163391116, 4485.900954266193, 4487.439070116236, 4520.344550040242, 4522.886927826798, 4530.821986283573, 4522.163399771053, 4536.77316134192, 4549.795259213327, 4566.840160594396, 4588.128255631419, 3902.2585708715255, 3978.403239514067, 4033.3546632538946, 4037.232925744129, 4040.939385909214, 5676.3188417389765, 5682.460166284196, 5709.943660422835, 5723.427657234285, 5744.138379243105, 5243.213517972296, 5247.580193584504, 5258.922725523397, 5259.605529585297, 5281.128613778722, 5922.200502932092, 6098.512119030467, 6122.142899994004, 6127.325994140641, 6134.294556126013, 4406.294992801137, 4424.933625995613, 4441.311596702516, 4451.844185453494, 4456.77716114193, 6199.125546533417, 6419.711112999927, 6426.164598602199, 6428.8071357859335, 6464.967675161641, 4512.842050528216, 4518.209313370147, 4543.409356783597, 4547.477040140427, 4581.289900065429, 4596.850787303174, 4626.930596041062, 4627.583517483443, 4630.930536041962, 4633.0, 5174.741262936838, 5216.321878155815, 5253.474652534716, 5256.369235691742, 5288.92066619001, 5934.525237980951, 6089.939100609025, 6102.69486525672, 6123.693815309217, 6148.4773794227995, 1534.6547026918854, 1548.914809685478, 1549.2253873063469, 1552.9844701553066, 1564.2022568489924, 927.9443233406017, 970.9951450242703, 979.3536266064364, 981.7153025622489, 991.1674193677345, 5242.322456813783, 5256.395514515803, 5265.420803711589, 5268.394134674485, 5281.947180528223, 5533.399302327899, 5538.504603757044, 5573.216570697419, 5615.466530679579, 5633.408492108351, 5092.096887998508, 5259.579913423354, 5326.147816349366, 5337.572994160458, 5367.75845086972, 2950.631171103612, 2958.5946675329046, 3000.7149320814488, 3014.1861697341596, 3016.9396612067635, 5681.715914204273, 5752.597318187771, 5753.568482363839, 5756.495924272955, 5759.337676167294, 6001.609895356788, 6468.870622587522, 6482.611043337321, 6494.480441564758, 6496.935030649727, 6554.901676474857, 6585.0, 6631.801045968628, 6642.933570664328, 6685.732570697215, 6206.255249370104, 6291.615844514199, 6371.713272902638, 6386.9680651596445, 6442.033694945608, 6282.246130464374, 6321.367863213642, 6321.810345689637, 6367.840803979938, 6370.0, 6394.90407643895, 6561.540692151694, 6576.76390027393, 6666.899996500153, 6691.832704182434, 4469.597736203757, 4524.751138687404, 4533.206688829376, 4556.6582506312825, 4568.223402021597, 6141.723622436912, 6287.182666253358, 6429.678516074271, 6458.967705161444, 6493.967530162319, 6170.81487555374, 6209.410106039919, 6233.158523599256, 6247.0, 6263.248410190807, 6175.166352542349, 6222.564420490703, 6236.0, 6318.652474113784, 6337.302896681454, 6126.908096378647, 6135.84660383494, 6155.2921414037955, 6157.138000679998, 6196.876062478816, 6215.875682486416, 6256.499480041494, 6293.496520278275, 6311.589746666452, 6343.11196432509, 5915.763369465173, 6030.160800955575, 6093.9390606093375, 6109.969450152721, 6175.505959523317], "value": 4616.505945089409, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [778.8481246157002, 819.606588837358, 831.4138532334705, 910.2808781062959, 938.8591711243317, 15716.607084822885, 15719.0, 17135.657286854257, 17687.204075816586, 18019.639607207882, 15422.228888555555, 15540.53378398647, 15548.37806487742, 15550.377984880592, 15563.299651515681, 738.4830618566998, 867.5575456517158, 871.5903525343078, 875.7066382761783, 892.0232345581578, 876.5704804645742, 879.2702057292464, 880.916312950272, 881.7971866470716, 884.2263019857625, 904.3398319226968, 913.0777914306532, 913.6528119314685, 920.8802855628759, 921.138735282513, 915.4324318922278, 916.3402350307801, 920.2729843423688, 921.4056933277998, 924.5977999570208, 667.3160010988776, 668.2281964331205, 669.5380187670492, 676.4182802789597, 677.864427114579, 16240.675186496323, 16314.510564683078, 16324.183790810412, 16357.83642163575, 16414.26135823891, 14161.929190354085, 14203.147811131365, 14718.484853030093, 14828.777568336483, 14854.257287135708, 13916.165030098227, 14269.714605707932, 14563.199024053672, 14864.331105100297, 14885.330160142712, 4734.218853889104, 4738.3129446230105, 4809.422869255712, 4809.735464549449, 4928.802847886081, 93980.0, 95505.0, 96073.0, 96465.0, 97070.0, 11274.943625281821, 11598.942005290088, 11737.823932641017, 11853.703657408634, 12017.63947081589, 20929.372118836458, 21279.680804787942, 21280.574388512145, 21627.0, 21688.56622867534, 8511.787205319917, 8619.051904290523, 8854.424462409923, 8859.778505537413, 8948.373613847098, 4861.368022157168, 4876.4879687633, 4906.852794416173, 5013.724245166478, 5162.74186290684, 3753.2681127180485, 3874.728768986144, 3874.9806250969127, 3884.1843212925037, 3885.0870045539277, 652.9020646903002, 661.5501459007921, 666.3469799596422, 677.3091446724313, 679.3342524326188, 637.9936200638027, 678.0, 682.6859644563457, 705.3827900586987, 725.2783480436893, 9762.974887636838, 10031.247656425798, 10066.396016239049, 10072.446015469219, 10131.581578579006, 647.5273050673035, 677.6882633988322, 677.8576498935279, 700.7302188657403, 706.7102487979904, 4695.366125573072, 4749.952500474951, 4808.656980139455, 4847.103285892122, 4857.732824694675, 74350.25649743542, 94565.5271723637, 129454.35272823575, 132978.33510832384, 135759.32120339334, 118572.40713796376, 118883.0, 119836.2764355738, 121251.0, 122743.0, 77784.0, 78317.60841195758, 78801.0, 91633.08366916378, 96763.03236967682, 9459.195968342492, 9518.857217141887, 9549.952250238704, 9625.807483850424, 9629.229661626912, 54590.72704636451, 55675.72162139163, 55758.0, 56795.71602141963, 56939.14591281217, 71441.6427917857, 78758.6062069686, 80897.59551202206, 81648.59175704083, 84486.57756711177, 13064.80402793978, 13076.476940922257, 13250.271235082164, 13299.933500332436, 13453.865461345262, 14934.477293294682, 14957.102573845605, 15987.120708361152, 16461.176941153135, 16498.75251871199, 14104.858951410355, 14653.0, 14704.338304776096, 15148.772768408704, 15494.922525387752, 14272.21502817355, 15314.387424502895, 15323.233838307817, 15524.456644017406, 15545.0, 14711.411543538139, 14726.0, 14735.705285894437, 14883.776743349075, 14902.478413255483, 11046.668599942015, 11288.435578220891, 11337.498507700227, 11599.826002610136, 11700.30892894656, 11709.531618735155, 11831.0, 11900.107491938312, 11999.443964532826, 12114.75770484603], "value": 8067.803400120842, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1506.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 105.0, 113.0, 111.0, 113.0, 111.0, 119.0, 111.0, 111.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 117.0, 144.0, 173.0, 116.0, 152.0, 143.0, 118.0, 174.0, 120.0], "value": 140.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 164.0, 163.0, 162.0, 163.0, 164.0, 163.0, 163.0, 163.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 174.0, 75.0, 76.0, 76.0, 75.0, 177.0, 76.0], "value": 95.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 146.0, 83.0, 84.0, 84.0, 141.0, 84.0, 84.0, 142.0], "value": 101.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 122.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 146.0, 147.0, 157.0, 148.0, 148.0, 149.0, 148.0, 147.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 97.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 94.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 50.0, 50.0, 61.0, 53.0, 51.0, 51.0, 51.0, 54.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 61.0, 61.0, 60.0, 61.0, 61.0, 60.0, 60.0, 61.0, 62.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 73.0, 73.0, 74.0, 74.0, 74.0, 72.0, 74.0, 72.0], "value": 73.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 133.0, 120.0, 124.0, 122.0, 138.0, 126.0, 127.0, 156.0, 135.0], "value": 130.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 155.0, 155.0, 157.0, 150.0, 155.0, 153.0, 150.0, 151.0, 151.0], "value": 153.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 61.0, 64.0, 62.0, 64.0, 62.0, 63.0, 61.0], "value": 63.0, "unit": "score"}]}]} 04:06:16 INFO - Return code: 0 04:06:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:06:16 ERROR - # TBPL SUCCESS # 04:06:16 INFO - Running post-action listener: _resource_record_post_action 04:06:16 INFO - [mozharness: 2016-08-24 11:06:16.616939Z] Finished run-tests step (success) 04:06:16 INFO - Running post-run listener: _resource_record_post_run 04:06:16 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 327233536; Read time: 8; Write time: 225980 04:06:16 INFO - TinderboxPrint: CPU usage
13.2% 04:06:16 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 04:06:16 INFO - TinderboxPrint: I/O write bytes / time
327,233,536 / 225,980 04:06:16 INFO - TinderboxPrint: CPU idle
8,222.0 (86.7%) 04:06:16 INFO - TinderboxPrint: CPU user
1,199.8 (12.7%) 04:06:16 INFO - TinderboxPrint: Swap in / out
0 / 0 04:06:16 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 78688256; Read time: 0; Write time: 51464 04:06:16 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 248008704; Read time: 8; Write time: 174516 04:06:17 INFO - Running post-run listener: _upload_blobber_files 04:06:17 INFO - Blob upload gear active. 04:06:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:06:17 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 04:06:17 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'] 04:06:17 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 04:06:17 INFO - (blobuploader) - INFO - Open directory for files ... 04:06:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:06:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:06:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:06:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:06:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:06:26 INFO - (blobuploader) - INFO - Done attempting. 04:06:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:06:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:06:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:06:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:06:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:06:27 INFO - (blobuploader) - INFO - Done attempting. 04:06:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:06:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:06:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:06:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:06:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:06:28 INFO - (blobuploader) - INFO - Done attempting. 04:06:28 INFO - (blobuploader) - INFO - Iteration through files over. 04:06:28 INFO - Return code: 0 04:06:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:06:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:06:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea975b4200b7bd859a339b1361ab47aa8cd2b813fefe0f8c11b554ed11f197805ec8c7035e1de3124195171d99dbea6824b2321cafa600baeba8711a52f9f21e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1418908e7ed8a7976a905583c87154c4738934c03e9c5097feda11715d6b7de01ab6cc15d8fb72bade8f4f39fe79c16906fff0e973c95fa7ac60d104b0e83400", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7caa1115f0df4fb81a2b80f6db900fe92d00fae5ed6532928ebeae673d7607253fed3c334695f656a2c4ae2ef2438b91f120747d34070c699a3df37e57d979e9"} 04:06:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:06:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:06:28 INFO - Contents: 04:06:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea975b4200b7bd859a339b1361ab47aa8cd2b813fefe0f8c11b554ed11f197805ec8c7035e1de3124195171d99dbea6824b2321cafa600baeba8711a52f9f21e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1418908e7ed8a7976a905583c87154c4738934c03e9c5097feda11715d6b7de01ab6cc15d8fb72bade8f4f39fe79c16906fff0e973c95fa7ac60d104b0e83400", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7caa1115f0df4fb81a2b80f6db900fe92d00fae5ed6532928ebeae673d7607253fed3c334695f656a2c4ae2ef2438b91f120747d34070c699a3df37e57d979e9"} 04:06:28 INFO - Running post-run listener: copy_logs_to_upload_dir 04:06:28 INFO - Copying logs to upload dir... 04:06:28 INFO - mkdir: /builds/slave/test/build/upload/logs 04:06:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1682.239941 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 2 secs) (at 2016-08-24 04:06:27.630079) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-24 04:06:27.633522) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1472030880.976961-587025349 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/ea975b4200b7bd859a339b1361ab47aa8cd2b813fefe0f8c11b554ed11f197805ec8c7035e1de3124195171d99dbea6824b2321cafa600baeba8711a52f9f21e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1418908e7ed8a7976a905583c87154c4738934c03e9c5097feda11715d6b7de01ab6cc15d8fb72bade8f4f39fe79c16906fff0e973c95fa7ac60d104b0e83400", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7caa1115f0df4fb81a2b80f6db900fe92d00fae5ed6532928ebeae673d7607253fed3c334695f656a2c4ae2ef2438b91f120747d34070c699a3df37e57d979e9"} build_url:https://queue.taskcluster.net/v1/task/M3_4sXe8SUikK_eYtJaosw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011239 build_url: 'https://queue.taskcluster.net/v1/task/M3_4sXe8SUikK_eYtJaosw/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/ea975b4200b7bd859a339b1361ab47aa8cd2b813fefe0f8c11b554ed11f197805ec8c7035e1de3124195171d99dbea6824b2321cafa600baeba8711a52f9f21e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1418908e7ed8a7976a905583c87154c4738934c03e9c5097feda11715d6b7de01ab6cc15d8fb72bade8f4f39fe79c16906fff0e973c95fa7ac60d104b0e83400", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7caa1115f0df4fb81a2b80f6db900fe92d00fae5ed6532928ebeae673d7607253fed3c334695f656a2c4ae2ef2438b91f120747d34070c699a3df37e57d979e9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-24 04:06:27.664553) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 04:06:27.665150) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1472030880.976961-587025349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004452 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 04:06:27.749105) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-24 04:06:27.749445) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-24 04:06:27.749755) ========= ========= Total master_lag: 0.17 =========