builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-014 starttime: 1471376784.64 results: success (0) buildid: 20160816110817 builduid: 0a54a8dbae9141aab7f59b91143711b1 revision: 1a4f61a218311b1724eee4fdc1684b1469206d92 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 12:46:24.643722) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 12:46:24.644182) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 12:46:24.644722) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 12:46:24.717812) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 12:46:24.718262) ========= 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=31acecf42b6a79ec49471d4a000001bb-1471375254.705344-598605893 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-16 12:46:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 61.3M=0s 2016-08-16 12:46:24 (61.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117713 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 12:46:24.856818) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 12:46:24.857105) ========= 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=31acecf42b6a79ec49471d4a000001bb-1471375254.705344-598605893 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018065 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 12:46:24.911429) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 12:46:24.911741) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 1a4f61a218311b1724eee4fdc1684b1469206d92 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 1a4f61a218311b1724eee4fdc1684b1469206d92 --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=31acecf42b6a79ec49471d4a000001bb-1471375254.705344-598605893 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-16 12:46:25,054 truncating revision to first 12 chars 2016-08-16 12:46:25,054 Setting DEBUG logging. 2016-08-16 12:46:25,055 attempt 1/10 2016-08-16 12:46:25,055 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/1a4f61a21831?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-16 12:46:25,379 unpacking tar archive at: mozilla-beta-1a4f61a21831/testing/mozharness/ program finished with exit code 0 elapsedTime=0.729321 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 12:46:25.659020) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 12:46:25.659372) ========= script_repo_revision: 1a4f61a218311b1724eee4fdc1684b1469206d92 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 12:46:25.659805) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 12:46:25.660121) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 12:46:25.669945) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 59 secs) (at 2016-08-16 12:46:25.670241) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1471375254.705344-598605893 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:46:25 INFO - MultiFileLogger online at 20160816 12:46:25 in /builds/slave/test 12:46:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 12:46:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:46:25 INFO - {'append_to_log': False, 12:46:25 INFO - 'base_work_dir': '/builds/slave/test', 12:46:25 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:46:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:46:25 INFO - 'branch': 'Mozilla-Beta', 12:46:25 INFO - 'buildbot_json_path': 'buildprops.json', 12:46:25 INFO - 'config_files': ('talos/linux_config.py',), 12:46:25 INFO - 'default_actions': ('clobber', 12:46:25 INFO - 'read-buildbot-config', 12:46:25 INFO - 'download-and-extract', 12:46:25 INFO - 'populate-webroot', 12:46:25 INFO - 'create-virtualenv', 12:46:25 INFO - 'install', 12:46:25 INFO - 'run-tests'), 12:46:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:46:25 INFO - 'download_minidump_stackwalk': True, 12:46:25 INFO - 'download_symbols': 'ondemand', 12:46:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:46:25 INFO - 'tooltool.py': '/tools/tooltool.py', 12:46:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:46:25 INFO - '/tools/misc-python/virtualenv.py')}, 12:46:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:46:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:46:25 INFO - 'installer_path': 'installer.exe', 12:46:25 INFO - 'log_level': 'info', 12:46:25 INFO - 'log_name': 'talos', 12:46:25 INFO - 'log_to_console': True, 12:46:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:46:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:46:25 INFO - 'opt_config_files': (), 12:46:25 INFO - 'pip_index': False, 12:46:25 INFO - 'sps_profile': False, 12:46:25 INFO - 'sps_profile_interval': 0, 12:46:25 INFO - 'suite': 'dromaeojs', 12:46:25 INFO - 'system_bits': '32', 12:46:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:46:25 INFO - 'title': 'talos-linux64-ix-014', 12:46:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:46:25 INFO - 'use_talos_json': True, 12:46:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:46:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:46:25 INFO - 'work_dir': 'build'} 12:46:25 INFO - ##### 12:46:25 INFO - ##### Running clobber step. 12:46:25 INFO - ##### 12:46:25 INFO - Running pre-action listener: _resource_record_pre_action 12:46:25 INFO - Running main action method: clobber 12:46:25 INFO - rmtree: /builds/slave/test/build 12:46:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:46:26 INFO - Running post-action listener: _resource_record_post_action 12:46:26 INFO - ##### 12:46:26 INFO - ##### Finished clobber step (success) 12:46:26 INFO - ##### 12:46:26 INFO - ##### 12:46:26 INFO - ##### Running read-buildbot-config step. 12:46:26 INFO - ##### 12:46:26 INFO - Running pre-action listener: _resource_record_pre_action 12:46:26 INFO - Running main action method: read_buildbot_config 12:46:26 INFO - Using buildbot properties: 12:46:26 INFO - { 12:46:26 INFO - "project": "", 12:46:26 INFO - "product": "firefox", 12:46:26 INFO - "script_repo_revision": "production", 12:46:26 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 12:46:26 INFO - "repository": "", 12:46:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 12:46:26 INFO - "buildid": "20160816110817", 12:46:26 INFO - "pgo_build": "True", 12:46:26 INFO - "basedir": "/builds/slave/test", 12:46:26 INFO - "buildnumber": 128, 12:46:26 INFO - "slavename": "talos-linux64-ix-014", 12:46:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:46:26 INFO - "platform": "ubuntu64_hw", 12:46:26 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 12:46:26 INFO - "branch": "mozilla-beta", 12:46:26 INFO - "repo_path": "releases/mozilla-beta", 12:46:26 INFO - "revision": "1a4f61a218311b1724eee4fdc1684b1469206d92", 12:46:26 INFO - "stage_platform": "linux64-pgo", 12:46:26 INFO - "builduid": "0a54a8dbae9141aab7f59b91143711b1", 12:46:26 INFO - "slavebuilddir": "test" 12:46:26 INFO - } 12:46:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2. 12:46:26 INFO - Running post-action listener: _resource_record_post_action 12:46:26 INFO - ##### 12:46:26 INFO - ##### Finished read-buildbot-config step (success) 12:46:26 INFO - ##### 12:46:26 INFO - ##### 12:46:26 INFO - ##### Running download-and-extract step. 12:46:26 INFO - ##### 12:46:26 INFO - Running pre-action listener: _resource_record_pre_action 12:46:26 INFO - Running main action method: download_and_extract 12:46:26 INFO - mkdir: /builds/slave/test/build/tests 12:46: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')]} 12:46:26 INFO - https://queue.taskcluster.net/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:46:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 12:46:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 12:46:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 12:46:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:46:26 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 12:46:26 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 12:46:26 INFO - retry: Failed, sleeping 30 seconds before retrying 12:46:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json'}, attempt #2 12:46:56 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 12:46:56 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 12:46:56 INFO - retry: Failed, sleeping 60 seconds before retrying 12:47:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json'}, attempt #3 12:47:56 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 12:47:56 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 12:47:56 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json! 12:47:56 INFO - Caught exception: HTTP Error 404: Not Found 12:47:56 INFO - Caught exception: HTTP Error 404: Not Found 12:47:56 INFO - Caught exception: HTTP Error 404: Not Found 12:47:56 INFO - trying https://queue.taskcluster.net/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 12:47:56 INFO - Downloading https://queue.taskcluster.net/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 12:47:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:47:57 INFO - Downloaded 1327 bytes. 12:47:57 INFO - Reading from file /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 12:47:57 INFO - Using the following test package requirements: 12:47:57 INFO - {u'common': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 12:47:57 INFO - u'cppunittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 12:47:57 INFO - u'firefox-49.0.en-US.linux-x86_64.cppunittest.tests.zip'], 12:47:57 INFO - u'gtest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 12:47:57 INFO - u'firefox-49.0.en-US.linux-x86_64.gtest.tests.zip'], 12:47:57 INFO - u'jittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 12:47:57 INFO - u'jsshell-linux-x86_64.zip'], 12:47:57 INFO - u'mochitest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 12:47:57 INFO - u'firefox-49.0.en-US.linux-x86_64.mochitest.tests.zip'], 12:47:57 INFO - u'mozbase': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 12:47:57 INFO - u'reftest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 12:47:57 INFO - u'firefox-49.0.en-US.linux-x86_64.reftest.tests.zip'], 12:47:57 INFO - u'talos': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 12:47:57 INFO - u'firefox-49.0.en-US.linux-x86_64.talos.tests.zip'], 12:47:57 INFO - u'web-platform': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 12:47:57 INFO - u'firefox-49.0.en-US.linux-x86_64.web-platform.tests.zip'], 12:47:57 INFO - u'xpcshell': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 12:47:57 INFO - u'firefox-49.0.en-US.linux-x86_64.xpcshell.tests.zip']} 12:47:57 INFO - Downloading packages: [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:47: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')]} 12:47:57 INFO - https://queue.taskcluster.net/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:47:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 12:47:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 12:47:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 12:47:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:47:57 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 12:47:57 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 12:47:57 INFO - retry: Failed, sleeping 30 seconds before retrying 12:48:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 12:48:27 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 12:48:27 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 12:48:27 INFO - retry: Failed, sleeping 60 seconds before retrying 12:49:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 12:49:27 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 12:49:27 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 12:49:27 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip! 12:49:27 INFO - Caught exception: HTTP Error 404: Not Found 12:49:27 INFO - Caught exception: HTTP Error 404: Not Found 12:49:27 INFO - Caught exception: HTTP Error 404: Not Found 12:49:27 INFO - trying https://queue.taskcluster.net/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 12:49:27 INFO - Downloading https://queue.taskcluster.net/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 12:49:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:49:27 INFO - Downloaded 21968930 bytes. 12:49:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:49:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:49:29 INFO - Return code: 0 12:49:29 INFO - Downloading packages: [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:49: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')]} 12:49:29 INFO - https://queue.taskcluster.net/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:49:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 12:49:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 12:49:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 12:49:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:49:29 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 12:49:29 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 12:49:29 INFO - retry: Failed, sleeping 30 seconds before retrying 12:49:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 12:49:59 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 12:49:59 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 12:49:59 INFO - retry: Failed, sleeping 60 seconds before retrying 12:50:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 12:50:59 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 12:50:59 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 12:50:59 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip! 12:50:59 INFO - Caught exception: HTTP Error 404: Not Found 12:50:59 INFO - Caught exception: HTTP Error 404: Not Found 12:50:59 INFO - Caught exception: HTTP Error 404: Not Found 12:50:59 INFO - trying https://queue.taskcluster.net/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 12:50:59 INFO - Downloading https://queue.taskcluster.net/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 12:50:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:51:00 INFO - Downloaded 21968930 bytes. 12:51:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:51:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:51:01 INFO - Return code: 0 12:51: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')]} 12:51:01 INFO - https://queue.taskcluster.net/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:51:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 12:51:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 12:51:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 12:51:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:51:01 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 12:51:01 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 12:51:01 INFO - retry: Failed, sleeping 30 seconds before retrying 12:51:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 12:51:31 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 12:51:31 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 12:51:31 INFO - retry: Failed, sleeping 60 seconds before retrying 12:52:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 12:52:31 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 12:52:31 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 12:52:31 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip! 12:52:31 INFO - Caught exception: HTTP Error 404: Not Found 12:52:31 INFO - Caught exception: HTTP Error 404: Not Found 12:52:31 INFO - Caught exception: HTTP Error 404: Not Found 12:52:31 INFO - trying https://queue.taskcluster.net/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 12:52:31 INFO - Downloading https://queue.taskcluster.net/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 12:52:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:52:32 INFO - Downloaded 10833369 bytes. 12:52:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:52:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 12:52:32 INFO - Return code: 0 12:52: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')]} 12:52:32 INFO - https://queue.taskcluster.net/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:52:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 12:52:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 12:52:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 12:52:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:52:32 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 12:52:32 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 12:52:32 INFO - retry: Failed, sleeping 30 seconds before retrying 12:53:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2'}, attempt #2 12:53:02 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 12:53:02 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 12:53:02 INFO - retry: Failed, sleeping 60 seconds before retrying 12:54:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2'}, attempt #3 12:54:02 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 12:54:02 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 12:54:02 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2! 12:54:02 INFO - Caught exception: HTTP Error 404: Not Found 12:54:02 INFO - Caught exception: HTTP Error 404: Not Found 12:54:02 INFO - Caught exception: HTTP Error 404: Not Found 12:54:02 INFO - trying https://queue.taskcluster.net/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 12:54:02 INFO - Downloading https://queue.taskcluster.net/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 12:54:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:54:03 INFO - Downloaded 55287559 bytes. 12:54:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 12:54:03 INFO - mkdir: /builds/slave/test/properties 12:54:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:54:03 INFO - Writing to file /builds/slave/test/properties/build_url 12:54:03 INFO - Contents: 12:54:03 INFO - build_url:https://queue.taskcluster.net/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 12:54:04 INFO - Running post-action listener: _resource_record_post_action 12:54:04 INFO - Running post-action listener: set_extra_try_arguments 12:54:04 INFO - ##### 12:54:04 INFO - ##### Finished download-and-extract step (success) 12:54:04 INFO - ##### 12:54:04 INFO - ##### 12:54:04 INFO - ##### Running populate-webroot step. 12:54:04 INFO - ##### 12:54:04 INFO - Running pre-action listener: _resource_record_pre_action 12:54:04 INFO - Running main action method: populate_webroot 12:54:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:54:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:54:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:54:04 INFO - '--tppagecycles', 12:54:04 INFO - '7'], 12:54:04 INFO - 'tests': ['tsvgm']}}, 12:54:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:54:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:54:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:54:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:54:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:54:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:54:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:04 INFO - 'talos_options': ['--disable-e10s'], 12:54:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:54:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:54:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:04 INFO - 'talos_options': ['--disable-e10s'], 12:54:04 INFO - 'tests': ['damp', 'tps']}, 12:54:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:04 INFO - 'tests': ['damp', 'tps']}, 12:54:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:54:04 INFO - 'tests': ['dromaeo_dom']}, 12:54:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:54:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:54:04 INFO - 'tests': ['a11yr', 12:54:04 INFO - 'ts_paint', 12:54:04 INFO - 'tpaint', 12:54:04 INFO - 'sessionrestore', 12:54:04 INFO - 'sessionrestore_no_auto_restore', 12:54:04 INFO - 'tabpaint']}, 12:54:04 INFO - 'other-e10s': {'tests': ['a11yr', 12:54:04 INFO - 'ts_paint', 12:54:04 INFO - 'tpaint', 12:54:04 INFO - 'sessionrestore', 12:54:04 INFO - 'sessionrestore_no_auto_restore', 12:54:04 INFO - 'tabpaint']}, 12:54:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:54:04 INFO - 'ts_paint', 12:54:04 INFO - 'tpaint', 12:54:04 INFO - 'sessionrestore', 12:54:04 INFO - 'sessionrestore_no_auto_restore', 12:54:04 INFO - 'tabpaint']}, 12:54:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:54:04 INFO - 'ts_paint', 12:54:04 INFO - 'tpaint', 12:54:04 INFO - 'sessionrestore', 12:54:04 INFO - 'sessionrestore_no_auto_restore', 12:54:04 INFO - 'tabpaint']}, 12:54:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:54:04 INFO - 'tests': ['a11yr', 12:54:04 INFO - 'ts_paint', 12:54:04 INFO - 'tpaint', 12:54:04 INFO - 'sessionrestore', 12:54:04 INFO - 'sessionrestore_no_auto_restore', 12:54:04 INFO - 'tabpaint']}, 12:54:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:54:04 INFO - 'tests': ['a11yr', 12:54:04 INFO - 'ts_paint', 12:54:04 INFO - 'tpaint', 12:54:04 INFO - 'sessionrestore', 12:54:04 INFO - 'sessionrestore_no_auto_restore', 12:54:04 INFO - 'tabpaint']}, 12:54:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:54:04 INFO - 'tests': ['tsvgx', 12:54:04 INFO - 'tsvgr_opacity', 12:54:04 INFO - 'tart', 12:54:04 INFO - 'tscrollx', 12:54:04 INFO - 'cart']}, 12:54:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:54:04 INFO - 'tsvgr_opacity', 12:54:04 INFO - 'tart', 12:54:04 INFO - 'tscrollx', 12:54:04 INFO - 'cart']}, 12:54:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:04 INFO - 'talos_options': ['--disable-e10s'], 12:54:04 INFO - 'tests': ['tp5o']}, 12:54:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:04 INFO - 'tests': ['tp5o']}, 12:54:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:04 INFO - 'talos_options': ['--disable-e10s', 12:54:04 INFO - '--xperf_path', 12:54:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:54:04 INFO - 'tests': ['tp5n']}, 12:54:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:04 INFO - 'talos_options': ['--xperf_path', 12:54:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:54:04 INFO - 'tests': ['tp5n']}}, 12:54:04 INFO - 'talos.zip': {'path': '', 12:54:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:54:04 INFO - Running post-action listener: _resource_record_post_action 12:54:04 INFO - ##### 12:54:04 INFO - ##### Finished populate-webroot step (success) 12:54:04 INFO - ##### 12:54:04 INFO - ##### 12:54:04 INFO - ##### Running create-virtualenv step. 12:54:04 INFO - ##### 12:54:04 INFO - Running pre-action listener: _resource_record_pre_action 12:54:04 INFO - Running main action method: create_virtualenv 12:54:04 INFO - Creating virtualenv /builds/slave/test/build/venv 12:54:04 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:54:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:54:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:54:04 INFO - Using real prefix '/usr' 12:54:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:54:05 INFO - Installing distribute.............................................................................................................................................................................................done. 12:54:07 INFO - Installing pip.................done. 12:54:07 INFO - Return code: 0 12:54:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83faf0cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27731c0>, '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 0x27740c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2774550>, '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': '31acecf42b6a79ec49471d4a000001bb-1471375254.705344-598605893', '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 12:54:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:54:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:54:07 INFO - Using env: {'DISPLAY': ':0', 12:54:07 INFO - 'HOME': '/home/cltbld', 12:54:07 INFO - 'LANG': 'en_US.UTF-8', 12:54:07 INFO - 'LANGUAGE': 'en_US:en', 12:54:07 INFO - 'LOGNAME': 'cltbld', 12:54:07 INFO - 'MAIL': '/var/mail/cltbld', 12:54:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:07 INFO - 'MOZ_NO_REMOTE': '1', 12:54:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:07 INFO - 'NO_EM_RESTART': '1', 12:54:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:07 INFO - 'PWD': '/builds/slave/test', 12:54:07 INFO - 'SHELL': '/bin/bash', 12:54:07 INFO - 'SHLVL': '1', 12:54:07 INFO - 'TERM': 'linux', 12:54:07 INFO - 'TMOUT': '86400', 12:54:07 INFO - 'USER': 'cltbld', 12:54:07 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1471375254.705344-598605893', 12:54:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:07 INFO - '_': '/tools/buildbot/bin/python'} 12:54:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:54:07 INFO - Cleaning up... 12:54:07 INFO - Return code: 0 12:54:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83faf0cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27731c0>, '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 0x27740c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2774550>, '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': '31acecf42b6a79ec49471d4a000001bb-1471375254.705344-598605893', '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 12:54:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:54:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:54:07 INFO - Using env: {'DISPLAY': ':0', 12:54:07 INFO - 'HOME': '/home/cltbld', 12:54:07 INFO - 'LANG': 'en_US.UTF-8', 12:54:07 INFO - 'LANGUAGE': 'en_US:en', 12:54:07 INFO - 'LOGNAME': 'cltbld', 12:54:07 INFO - 'MAIL': '/var/mail/cltbld', 12:54:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:07 INFO - 'MOZ_NO_REMOTE': '1', 12:54:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:07 INFO - 'NO_EM_RESTART': '1', 12:54:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:07 INFO - 'PWD': '/builds/slave/test', 12:54:07 INFO - 'SHELL': '/bin/bash', 12:54:07 INFO - 'SHLVL': '1', 12:54:07 INFO - 'TERM': 'linux', 12:54:07 INFO - 'TMOUT': '86400', 12:54:07 INFO - 'USER': 'cltbld', 12:54:07 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1471375254.705344-598605893', 12:54:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:07 INFO - '_': '/tools/buildbot/bin/python'} 12:54:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:07 INFO - Downloading/unpacking psutil>=3.1.1 12:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:54:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:54:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:54:09 INFO - Installing collected packages: psutil 12:54:09 INFO - Running setup.py install for psutil 12:54:09 INFO - building 'psutil._psutil_linux' extension 12:54:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:54:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:54:09 INFO - building 'psutil._psutil_posix' extension 12:54:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:54:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:54:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:54:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:54:10 INFO - Successfully installed psutil 12:54:10 INFO - Cleaning up... 12:54:10 INFO - Return code: 0 12:54:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:54:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83faf0cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27731c0>, '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 0x27740c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2774550>, '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': '31acecf42b6a79ec49471d4a000001bb-1471375254.705344-598605893', '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 12:54:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:54:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:54:10 INFO - Using env: {'DISPLAY': ':0', 12:54:10 INFO - 'HOME': '/home/cltbld', 12:54:10 INFO - 'LANG': 'en_US.UTF-8', 12:54:10 INFO - 'LANGUAGE': 'en_US:en', 12:54:10 INFO - 'LOGNAME': 'cltbld', 12:54:10 INFO - 'MAIL': '/var/mail/cltbld', 12:54:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:10 INFO - 'MOZ_NO_REMOTE': '1', 12:54:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:10 INFO - 'NO_EM_RESTART': '1', 12:54:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:10 INFO - 'PWD': '/builds/slave/test', 12:54:10 INFO - 'SHELL': '/bin/bash', 12:54:10 INFO - 'SHLVL': '1', 12:54:10 INFO - 'TERM': 'linux', 12:54:10 INFO - 'TMOUT': '86400', 12:54:10 INFO - 'USER': 'cltbld', 12:54:10 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1471375254.705344-598605893', 12:54:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:10 INFO - '_': '/tools/buildbot/bin/python'} 12:54:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:54:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:54:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:54:12 INFO - Installing collected packages: mozsystemmonitor 12:54:12 INFO - Running setup.py install for mozsystemmonitor 12:54:12 INFO - Successfully installed mozsystemmonitor 12:54:12 INFO - Cleaning up... 12:54:12 INFO - Return code: 0 12:54:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:54:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83faf0cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27731c0>, '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 0x27740c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2774550>, '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': '31acecf42b6a79ec49471d4a000001bb-1471375254.705344-598605893', '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 12:54:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:54:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:54:12 INFO - Using env: {'DISPLAY': ':0', 12:54:12 INFO - 'HOME': '/home/cltbld', 12:54:12 INFO - 'LANG': 'en_US.UTF-8', 12:54:12 INFO - 'LANGUAGE': 'en_US:en', 12:54:12 INFO - 'LOGNAME': 'cltbld', 12:54:12 INFO - 'MAIL': '/var/mail/cltbld', 12:54:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:12 INFO - 'MOZ_NO_REMOTE': '1', 12:54:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:12 INFO - 'NO_EM_RESTART': '1', 12:54:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:12 INFO - 'PWD': '/builds/slave/test', 12:54:12 INFO - 'SHELL': '/bin/bash', 12:54:12 INFO - 'SHLVL': '1', 12:54:12 INFO - 'TERM': 'linux', 12:54:12 INFO - 'TMOUT': '86400', 12:54:12 INFO - 'USER': 'cltbld', 12:54:12 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1471375254.705344-598605893', 12:54:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:12 INFO - '_': '/tools/buildbot/bin/python'} 12:54:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:12 INFO - Downloading/unpacking jsonschema==2.5.1 12:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:54:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:54: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 12:54: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 12:54: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 12:54: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 12:54: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 12:54: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 12:54:14 INFO - Downloading functools32-3.2.3-2.tar.gz 12:54:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:54:14 INFO - warning: no files found matching '*.txt' 12:54:14 INFO - no previously-included directories found matching 'build' 12:54:14 INFO - no previously-included directories found matching 'dist' 12:54:14 INFO - no previously-included directories found matching '.git*' 12:54:14 INFO - Installing collected packages: jsonschema, functools32 12:54:14 INFO - Running setup.py install for functools32 12:54:14 INFO - warning: no files found matching '*.txt' 12:54:14 INFO - no previously-included directories found matching 'build' 12:54:14 INFO - no previously-included directories found matching 'dist' 12:54:14 INFO - no previously-included directories found matching '.git*' 12:54:14 INFO - Successfully installed jsonschema functools32 12:54:14 INFO - Cleaning up... 12:54:15 INFO - Return code: 0 12:54:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:54:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83faf0cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27731c0>, '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 0x27740c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2774550>, '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': '31acecf42b6a79ec49471d4a000001bb-1471375254.705344-598605893', '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 12:54:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:54:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:54:15 INFO - Using env: {'DISPLAY': ':0', 12:54:15 INFO - 'HOME': '/home/cltbld', 12:54:15 INFO - 'LANG': 'en_US.UTF-8', 12:54:15 INFO - 'LANGUAGE': 'en_US:en', 12:54:15 INFO - 'LOGNAME': 'cltbld', 12:54:15 INFO - 'MAIL': '/var/mail/cltbld', 12:54:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:15 INFO - 'MOZ_NO_REMOTE': '1', 12:54:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:15 INFO - 'NO_EM_RESTART': '1', 12:54:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:15 INFO - 'PWD': '/builds/slave/test', 12:54:15 INFO - 'SHELL': '/bin/bash', 12:54:15 INFO - 'SHLVL': '1', 12:54:15 INFO - 'TERM': 'linux', 12:54:15 INFO - 'TMOUT': '86400', 12:54:15 INFO - 'USER': 'cltbld', 12:54:15 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1471375254.705344-598605893', 12:54:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:15 INFO - '_': '/tools/buildbot/bin/python'} 12:54:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:15 INFO - Downloading/unpacking blobuploader==1.2.4 12:54: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 12:54: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 12:54: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 12:54: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 12:54: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 12:54: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 12:54:17 INFO - Downloading blobuploader-1.2.4.tar.gz 12:54:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:54:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:54:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:17 INFO - Downloading docopt-0.6.1.tar.gz 12:54:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:54:17 INFO - Installing collected packages: blobuploader, requests, docopt 12:54:17 INFO - Running setup.py install for blobuploader 12:54:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:54:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:54:17 INFO - Running setup.py install for requests 12:54:18 INFO - Running setup.py install for docopt 12:54:18 INFO - Successfully installed blobuploader requests docopt 12:54:18 INFO - Cleaning up... 12:54:18 INFO - Return code: 0 12:54:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:54:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83faf0cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27731c0>, '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 0x27740c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2774550>, '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': '31acecf42b6a79ec49471d4a000001bb-1471375254.705344-598605893', '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 12:54:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:54:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:54:18 INFO - Using env: {'DISPLAY': ':0', 12:54:18 INFO - 'HOME': '/home/cltbld', 12:54:18 INFO - 'LANG': 'en_US.UTF-8', 12:54:18 INFO - 'LANGUAGE': 'en_US:en', 12:54:18 INFO - 'LOGNAME': 'cltbld', 12:54:18 INFO - 'MAIL': '/var/mail/cltbld', 12:54:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:18 INFO - 'MOZ_NO_REMOTE': '1', 12:54:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:18 INFO - 'NO_EM_RESTART': '1', 12:54:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:18 INFO - 'PWD': '/builds/slave/test', 12:54:18 INFO - 'SHELL': '/bin/bash', 12:54:18 INFO - 'SHLVL': '1', 12:54:18 INFO - 'TERM': 'linux', 12:54:18 INFO - 'TMOUT': '86400', 12:54:18 INFO - 'USER': 'cltbld', 12:54:18 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1471375254.705344-598605893', 12:54:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:18 INFO - '_': '/tools/buildbot/bin/python'} 12:54:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:54:18 INFO - Running setup.py (path:/tmp/pip-UR0L6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:54:18 INFO - Running setup.py (path:/tmp/pip-z7Jbvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:54:18 INFO - Running setup.py (path:/tmp/pip-rukuty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:54:18 INFO - Running setup.py (path:/tmp/pip-5L_Nxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:54:18 INFO - Running setup.py (path:/tmp/pip-Y43rG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:54:19 INFO - Running setup.py (path:/tmp/pip-fPuITJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:54:19 INFO - Running setup.py (path:/tmp/pip-aZtQuz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:54:19 INFO - Running setup.py (path:/tmp/pip-iUjMBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:54:19 INFO - Running setup.py (path:/tmp/pip-7xUjzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:54:19 INFO - Running setup.py (path:/tmp/pip-pjUXn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:54:19 INFO - Running setup.py (path:/tmp/pip-wGLLp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:54:19 INFO - Running setup.py (path:/tmp/pip-04q9Jm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:54:19 INFO - Running setup.py (path:/tmp/pip-51HYMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:54:19 INFO - Running setup.py (path:/tmp/pip-mllaAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:19 INFO - Running setup.py (path:/tmp/pip-EMbTTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:54:19 INFO - Running setup.py (path:/tmp/pip-yTWXJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:54:19 INFO - Running setup.py (path:/tmp/pip-L86HNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:54:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:54:19 INFO - Running setup.py install for manifestparser 12:54:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:54:19 INFO - Running setup.py install for mozcrash 12:54:20 INFO - Running setup.py install for mozdebug 12:54:20 INFO - Running setup.py install for mozdevice 12:54:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:54:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:54:20 INFO - Running setup.py install for mozfile 12:54:20 INFO - Running setup.py install for mozhttpd 12:54:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:54:20 INFO - Running setup.py install for mozinfo 12:54:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:54:20 INFO - Running setup.py install for mozInstall 12:54:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:54:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:54:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:54:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:54:20 INFO - Running setup.py install for mozleak 12:54:20 INFO - Running setup.py install for mozlog 12:54:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:54:20 INFO - Running setup.py install for moznetwork 12:54:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:54:21 INFO - Running setup.py install for mozprocess 12:54:21 INFO - Running setup.py install for mozprofile 12:54:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:54:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:54:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:54:21 INFO - Running setup.py install for mozrunner 12:54:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:54:21 INFO - Running setup.py install for mozscreenshot 12:54:21 INFO - Running setup.py install for moztest 12:54:21 INFO - Running setup.py install for mozversion 12:54:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:54:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:54:21 INFO - Cleaning up... 12:54:21 INFO - Return code: 0 12:54:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:54:21 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')]} 12:54:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:21 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')]} 12:54:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:21 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 0x7f83faf0cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27731c0>, '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 0x27740c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2774550>, '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': '31acecf42b6a79ec49471d4a000001bb-1471375254.705344-598605893', '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 12:54:21 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 12:54:21 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 12:54:21 INFO - Using env: {'DISPLAY': ':0', 12:54:21 INFO - 'HOME': '/home/cltbld', 12:54:21 INFO - 'LANG': 'en_US.UTF-8', 12:54:21 INFO - 'LANGUAGE': 'en_US:en', 12:54:21 INFO - 'LOGNAME': 'cltbld', 12:54:21 INFO - 'MAIL': '/var/mail/cltbld', 12:54:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:21 INFO - 'MOZ_NO_REMOTE': '1', 12:54:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:21 INFO - 'NO_EM_RESTART': '1', 12:54:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:21 INFO - 'PWD': '/builds/slave/test', 12:54:21 INFO - 'SHELL': '/bin/bash', 12:54:21 INFO - 'SHLVL': '1', 12:54:21 INFO - 'TERM': 'linux', 12:54:21 INFO - 'TMOUT': '86400', 12:54:21 INFO - 'USER': 'cltbld', 12:54:21 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1471375254.705344-598605893', 12:54:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:21 INFO - '_': '/tools/buildbot/bin/python'} 12:54:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:54:21 INFO - Running setup.py (path:/tmp/pip-mThFqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:54:21 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)) 12:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:54:21 INFO - Running setup.py (path:/tmp/pip-3nX3wg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:54:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:54:22 INFO - Running setup.py (path:/tmp/pip-vych5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:54:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:54:22 INFO - Running setup.py (path:/tmp/pip-ErnkHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:54:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:54:22 INFO - Running setup.py (path:/tmp/pip-pkFOcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:54:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:54:22 INFO - Running setup.py (path:/tmp/pip-Jflxlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:54:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:54:22 INFO - Running setup.py (path:/tmp/pip-f8cOQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:54:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:54:22 INFO - Running setup.py (path:/tmp/pip-8EzNtR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:54:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:54:22 INFO - Running setup.py (path:/tmp/pip-6s6sn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:54:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:54:22 INFO - Running setup.py (path:/tmp/pip-IdHwDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:54:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 12:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:54:22 INFO - Running setup.py (path:/tmp/pip-HghrVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:54:22 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)) 12:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:54:22 INFO - Running setup.py (path:/tmp/pip-yOlTK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:54:22 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)) 12:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:54:22 INFO - Running setup.py (path:/tmp/pip-rcuGpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:54:22 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)) 12:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:54:22 INFO - Running setup.py (path:/tmp/pip-MZNzbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:54:22 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)) 12:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:22 INFO - Running setup.py (path:/tmp/pip-4juJRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:22 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)) 12:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:54:23 INFO - Running setup.py (path:/tmp/pip-hWgwsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:54:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:54:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:54:23 INFO - Running setup.py (path:/tmp/pip-zXqYWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:54:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:54:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:54:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:54:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:54:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:54:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:54:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:54:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:25 INFO - Downloading blessings-1.6.tar.gz 12:54:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:54:25 INFO - Installing collected packages: blessings 12:54:25 INFO - Running setup.py install for blessings 12:54:25 INFO - Successfully installed blessings 12:54:25 INFO - Cleaning up... 12:54:25 INFO - Return code: 0 12:54:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:54:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:54:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:54:25 INFO - Reading from file tmpfile_stdout 12:54:25 INFO - Current package versions: 12:54:25 INFO - argparse == 1.2.1 12:54:25 INFO - blessings == 1.6 12:54:25 INFO - blobuploader == 1.2.4 12:54:25 INFO - docopt == 0.6.1 12:54:25 INFO - functools32 == 3.2.3-2 12:54:25 INFO - jsonschema == 2.5.1 12:54:25 INFO - manifestparser == 1.1 12:54:25 INFO - mozInstall == 1.12 12:54:25 INFO - mozcrash == 0.17 12:54:25 INFO - mozdebug == 0.1 12:54:25 INFO - mozdevice == 0.48 12:54:25 INFO - mozfile == 1.2 12:54:25 INFO - mozhttpd == 0.7 12:54:25 INFO - mozinfo == 0.9 12:54:25 INFO - mozleak == 0.1 12:54:25 INFO - mozlog == 3.2 12:54:25 INFO - moznetwork == 0.27 12:54:25 INFO - mozprocess == 0.23 12:54:25 INFO - mozprofile == 0.28 12:54:25 INFO - mozrunner == 6.12 12:54:25 INFO - mozscreenshot == 0.1 12:54:25 INFO - mozsystemmonitor == 0.3 12:54:25 INFO - moztest == 0.7 12:54:25 INFO - mozversion == 1.4 12:54:25 INFO - psutil == 3.1.1 12:54:25 INFO - requests == 1.2.3 12:54:25 INFO - wsgiref == 0.1.2 12:54:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:54:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83faf0cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27731c0>, '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 0x27740c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2774550>, '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': '31acecf42b6a79ec49471d4a000001bb-1471375254.705344-598605893', '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 12:54:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:54:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:54:25 INFO - Using env: {'DISPLAY': ':0', 12:54:25 INFO - 'HOME': '/home/cltbld', 12:54:25 INFO - 'LANG': 'en_US.UTF-8', 12:54:25 INFO - 'LANGUAGE': 'en_US:en', 12:54:25 INFO - 'LOGNAME': 'cltbld', 12:54:25 INFO - 'MAIL': '/var/mail/cltbld', 12:54:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:25 INFO - 'MOZ_NO_REMOTE': '1', 12:54:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:25 INFO - 'NO_EM_RESTART': '1', 12:54:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:25 INFO - 'PWD': '/builds/slave/test', 12:54:25 INFO - 'SHELL': '/bin/bash', 12:54:25 INFO - 'SHLVL': '1', 12:54:25 INFO - 'TERM': 'linux', 12:54:25 INFO - 'TMOUT': '86400', 12:54:25 INFO - 'USER': 'cltbld', 12:54:25 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1471375254.705344-598605893', 12:54:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:25 INFO - '_': '/tools/buildbot/bin/python'} 12:54:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:25 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)) 12:54:25 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)) 12:54:25 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)) 12:54:25 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)) 12:54:25 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)) 12:54:25 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)) 12:54:25 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)) 12:54:25 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)) 12:54:25 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)) 12:54:25 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)) 12:54:25 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)) 12:54:25 INFO - Cleaning up... 12:54:25 INFO - Return code: 0 12:54:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:54:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:25 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 0x7f83faf0cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27731c0>, '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 0x27740c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2774550>, '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': '31acecf42b6a79ec49471d4a000001bb-1471375254.705344-598605893', '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 12:54:25 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 12:54:25 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 12:54:25 INFO - Using env: {'DISPLAY': ':0', 12:54:25 INFO - 'HOME': '/home/cltbld', 12:54:25 INFO - 'LANG': 'en_US.UTF-8', 12:54:25 INFO - 'LANGUAGE': 'en_US:en', 12:54:25 INFO - 'LOGNAME': 'cltbld', 12:54:25 INFO - 'MAIL': '/var/mail/cltbld', 12:54:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:25 INFO - 'MOZ_NO_REMOTE': '1', 12:54:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:25 INFO - 'NO_EM_RESTART': '1', 12:54:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:25 INFO - 'PWD': '/builds/slave/test', 12:54:25 INFO - 'SHELL': '/bin/bash', 12:54:25 INFO - 'SHLVL': '1', 12:54:25 INFO - 'TERM': 'linux', 12:54:25 INFO - 'TMOUT': '86400', 12:54:25 INFO - 'USER': 'cltbld', 12:54:25 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1471375254.705344-598605893', 12:54:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:25 INFO - '_': '/tools/buildbot/bin/python'} 12:54:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:54:25 INFO - Cleaning up... 12:54:25 INFO - Return code: 0 12:54:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:54:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:25 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83faf0cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27731c0>, '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 0x27740c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2774550>, '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': '31acecf42b6a79ec49471d4a000001bb-1471375254.705344-598605893', '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 12:54:25 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', 'flake8'] in /builds/slave/test/build 12:54:25 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 flake8 12:54:25 INFO - Using env: {'DISPLAY': ':0', 12:54:25 INFO - 'HOME': '/home/cltbld', 12:54:25 INFO - 'LANG': 'en_US.UTF-8', 12:54:25 INFO - 'LANGUAGE': 'en_US:en', 12:54:25 INFO - 'LOGNAME': 'cltbld', 12:54:25 INFO - 'MAIL': '/var/mail/cltbld', 12:54:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:25 INFO - 'MOZ_NO_REMOTE': '1', 12:54:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:25 INFO - 'NO_EM_RESTART': '1', 12:54:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:25 INFO - 'PWD': '/builds/slave/test', 12:54:25 INFO - 'SHELL': '/bin/bash', 12:54:25 INFO - 'SHLVL': '1', 12:54:25 INFO - 'TERM': 'linux', 12:54:25 INFO - 'TMOUT': '86400', 12:54:25 INFO - 'USER': 'cltbld', 12:54:25 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1471375254.705344-598605893', 12:54:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:25 INFO - '_': '/tools/buildbot/bin/python'} 12:54:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:26 INFO - Downloading/unpacking flake8 12:54:26 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 12:54:26 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 12:54:26 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 12:54:26 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 12:54:26 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 12:54:26 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 12:54:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:54:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:54:28 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 12:54:28 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 12:54:28 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 12:54:28 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 12:54:28 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 12:54:28 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 12:54:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:54:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:54:28 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 12:54:28 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 12:54:28 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 12:54:28 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 12:54:28 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 12:54:28 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 12:54:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:54:28 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 12:54:28 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 12:54:28 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 12:54:28 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 12:54:28 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 12:54:28 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 12:54:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:54:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:54:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:54:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:54:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:54:28 INFO - no previously-included directories found matching 'docs/_build' 12:54:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:54:28 INFO - Running setup.py install for pep8 12:54:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:54:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:54:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:54:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:54:28 INFO - no previously-included directories found matching 'docs/_build' 12:54:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:54:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:54:28 INFO - Cleaning up... 12:54:29 INFO - Return code: 0 12:54:29 INFO - Running post-action listener: _resource_record_post_action 12:54:29 INFO - Running post-action listener: _start_resource_monitoring 12:54:29 INFO - Starting resource monitoring. 12:54:29 INFO - ##### 12:54:29 INFO - ##### Finished create-virtualenv step (success) 12:54:29 INFO - ##### 12:54:29 INFO - ##### 12:54:29 INFO - ##### Running install step. 12:54:29 INFO - ##### 12:54:29 INFO - Running pre-action listener: _resource_record_pre_action 12:54:29 INFO - Running main action method: install 12:54:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:54:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:54:29 INFO - Reading from file tmpfile_stdout 12:54:29 INFO - Detecting whether we're running mozinstall >=1.0... 12:54:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:54:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:54:29 INFO - Reading from file tmpfile_stdout 12:54:29 INFO - Output received: 12:54:29 INFO - Usage: mozinstall [options] installer 12:54:29 INFO - Options: 12:54:29 INFO - -h, --help show this help message and exit 12:54:29 INFO - -d DEST, --destination=DEST 12:54:29 INFO - Directory to install application into. [default: 12:54:29 INFO - "/builds/slave/test"] 12:54:29 INFO - --app=APP Application being installed. [default: firefox] 12:54:29 INFO - mkdir: /builds/slave/test/build/application 12:54:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:54:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:54:43 INFO - Reading from file tmpfile_stdout 12:54:43 INFO - Output received: 12:54:43 INFO - /builds/slave/test/build/application/firefox/firefox 12:54:43 INFO - Running post-action listener: _resource_record_post_action 12:54:43 INFO - ##### 12:54:43 INFO - ##### Finished install step (success) 12:54:43 INFO - ##### 12:54:43 INFO - ##### 12:54:43 INFO - ##### Running run-tests step. 12:54:43 INFO - ##### 12:54:43 INFO - Running pre-action listener: _resource_record_pre_action 12:54:43 INFO - Running main action method: run_tests 12:54:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:54:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:54:43 INFO - Python 2.7.3 12:54:43 INFO - Return code: 0 12:54:43 INFO - grabbing minidump binary from tooltool 12:54:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:43 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27731c0>, '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 0x27740c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2774550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:54:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:54:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:54:43 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 12:54:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:54:43 INFO - Return code: 0 12:54:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:54:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:54:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:54:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:54:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:54:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:54:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:54:44 INFO - Return code: 0 12:54:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:54:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:54:44 INFO - Using env: {'DISPLAY': ':0', 12:54:44 INFO - 'HOME': '/home/cltbld', 12:54:44 INFO - 'LANG': 'en_US.UTF-8', 12:54:44 INFO - 'LANGUAGE': 'en_US:en', 12:54:44 INFO - 'LOGNAME': 'cltbld', 12:54:44 INFO - 'MAIL': '/var/mail/cltbld', 12:54:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:54:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:54:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:44 INFO - 'MOZ_NO_REMOTE': '1', 12:54:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:54:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:44 INFO - 'NO_EM_RESTART': '1', 12:54:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:44 INFO - 'PWD': '/builds/slave/test', 12:54:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:54:44 INFO - 'SHELL': '/bin/bash', 12:54:44 INFO - 'SHLVL': '1', 12:54:44 INFO - 'TERM': 'linux', 12:54:44 INFO - 'TMOUT': '86400', 12:54:44 INFO - 'USER': 'cltbld', 12:54:44 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1471375254.705344-598605893', 12:54:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:44 INFO - '_': '/tools/buildbot/bin/python'} 12:54:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:54:44 INFO - mozversion application_buildid: 20160816110817 12:54:44 INFO - mozversion application_changeset: 1a4f61a218311b1724eee4fdc1684b1469206d92 12:54:44 INFO - mozversion application_display_name: Firefox 12:54:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:54:44 INFO - mozversion application_name: Firefox 12:54:44 INFO - mozversion application_remotingname: firefox 12:54:44 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:54:44 INFO - mozversion application_vendor: Mozilla 12:54:44 INFO - mozversion application_version: 49.0 12:54:44 INFO - mozversion platform_buildid: 20160816110817 12:54:44 INFO - mozversion platform_changeset: 1a4f61a218311b1724eee4fdc1684b1469206d92 12:54:44 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:54:44 INFO - mozversion platform_version: 49.0 12:54:44 INFO - using testdate: 1471377284 12:54:44 INFO - actual date: 1471377284 12:54:44 INFO - starting webserver on 'localhost:53624' 12:54:44 INFO - SUITE-START | Running 2 tests 12:54:44 INFO - TEST-START | dromaeo_css 12:54:44 INFO - operating with platform_type : linux_ 12:54:44 INFO - Initialising browser for dromaeo_css test... 12:54:44 INFO - TEST-INFO | started process 3355 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2SY6__/profile http://localhost:53624/getInfo.html) 12:54:48 INFO - PROCESS | 3355 | __metrics Screen width/height:1600/1200 12:54:48 INFO - PROCESS | 3355 | colorDepth:24 12:54:48 INFO - PROCESS | 3355 | Browser inner width/height: 1024/697 12:54:48 INFO - PROCESS | 3355 | __metrics 12:54:49 INFO - PROCESS | 3355 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:54:49 ERROR - PROCESS | 3355 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:54:50 INFO - TEST-INFO | 3355: exit 0 12:54:50 INFO - Browser initialized. 12:54:50 INFO - Running cycle 1/1 for dromaeo_css test... 12:54:50 INFO - TEST-INFO | started process 3446 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2SY6__/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:55:02 INFO - PROCESS | 3446 | RSS: Main: 140877824 12:55:02 INFO - PROCESS | 3446 | 12:55:52 INFO - PROCESS | 3446 | 1471377352680 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] 12:58:00 INFO - PROCESS | 3446 | Cycle 1(1): loaded http://localhost:53624/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53624/tests/dromaeo/cssquery-ext.html) 12:58:01 INFO - PROCESS | 3446 | RSS: Main: 268992512 12:58:01 INFO - PROCESS | 3446 | 13:01:04 INFO - PROCESS | 3446 | Cycle 1(1): loaded http://localhost:53624/tests/dromaeo/cssquery-ext.html (next: http://localhost:53624/tests/dromaeo/cssquery-jquery.html) 13:01:04 INFO - PROCESS | 3446 | RSS: Main: 226041856 13:01:04 INFO - PROCESS | 3446 | 13:04:06 INFO - PROCESS | 3446 | Cycle 1(1): loaded http://localhost:53624/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53624/tests/dromaeo/cssquery-mootools.html) 13:04:07 INFO - PROCESS | 3446 | RSS: Main: 223326208 13:04:07 INFO - PROCESS | 3446 | 13:07:09 INFO - PROCESS | 3446 | Cycle 1(1): loaded http://localhost:53624/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53624/tests/dromaeo/cssquery-prototype.html) 13:07:09 INFO - PROCESS | 3446 | RSS: Main: 220012544 13:07:09 INFO - PROCESS | 3446 | 13:10:12 INFO - PROCESS | 3446 | Cycle 1(1): loaded http://localhost:53624/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53624/tests/dromaeo/cssquery-yui.html) 13:10:13 INFO - PROCESS | 3446 | RSS: Main: 214724608 13:10:13 INFO - PROCESS | 3446 | 13:13:15 INFO - PROCESS | 3446 | Cycle 1(1): loaded http://localhost:53624/tests/dromaeo/cssquery-yui.html (next: http://localhost:53624/tests/dromaeo/cssquery-dojo.html) 13:13:15 INFO - PROCESS | 3446 | RSS: Main: 258785280 13:13:15 INFO - PROCESS | 3446 | 13:13:15 INFO - PROCESS | 3446 | __start_tp_report 13:13:15 INFO - PROCESS | 3446 | _x_x_mozilla_page_load 13:13:15 INFO - PROCESS | 3446 | _x_x_mozilla_page_load_details 13:13:15 INFO - PROCESS | 3446 | |i|pagename|runs| 13:13:15 INFO - PROCESS | 3446 | |0;dojo.html;3317.369699757046;3342.699157075864;3350.765446418751;3360.831958402079;3385.5768028996376;5396.7031813250305;5502.862428439286;5507.173923911405;5522.668639881605;5523.585731070166;5435.456454354563;5487.368952570456;5513.759404134078;5535.944640553594;5569.526590239824;4901.142300097468;4942.308076869242;4988.3515143031445;5009.248612708105;5053.79784808609;4930.53159949806;4965.180745177042;4985.202367621181;5002.474740152286;5074.086664400406;5025.949740502603;5037.596992240612;5047.924281135786;5088.669236499634;5137.049645815536;5100.668456550349;5100.923486147711;5103.489651034867;5106.489351064901;5128.205128205115;4643.814247430132;4852.951470485285;4869.220924652074;5012.072766538202;5021.347224860781;5332.093544097513;5355.812546560852;5380.650257733235;5435.83692489226;5439.156930675712;5845.473907348317;5871.706414679249;5888.882222355529;5894.263217097863;5899.675517846516;5746.971265143689;5773.307203135609;5854.531637468992;5861.032929566616;5934.258217722785;5557.638753481092;5560.666360018412;5567.387587365427;5577.163425486169;5580.469855363734;6030.427109424598;6035.034394496859;6051.848703782441;6054.545909056838;6057.030875059969;5579.6652200868075;5643.887122257532;5724.8282551523525;5727.77088916447;5826.82519524415;5826;5851.561132915049;5888.852778680567;5894.4400281974;5898.026825573818;5819.476247137778;5860.501857342174;5871.324797648325;5872;5889.263842019747;5559.805406810823;5696.401877802854;5757.827265182052;5787;5878.764849405976;4535.9773201133785;4545.499995000548;4547.386102876136;4550.067236216568;4562;4033.657139143147;4055.513338399411;4059.188162367538;4066.4510291110914;4073.89815254621;5383.67697938125;5445.50990410865;5471.917921231185;5499.945000549943;5539.224508568804;5865.237519122572;5867.237259156283;5868.2077919480325;5872.882542349129;5918.23063001807;5203.115470370046;5562.833115006556;5605.383407825136;5620.297462817148;5628.831135065954;4960.677555958851;5009.348784658044;5016.648834581617;5018.1218286800395;5026.974865125651;5998.070299103646;6001.609895356788;6010.879782404328;6011.48902343297;6013.128096425994;5657.4908258256955;5755.7697692093525;5805.303363596396;5805.651660900444;5821;6029.366916473882;6123.008104567321;6126.8230438726505;6133.273457575459;6134.319937288865;5760.711964401847;5805.883882322245;5810.477057064884;5820;5823.621464604787;5642.605017648725;5709.9714501427225;5732.742026608896;5882.382349853204;5892.204552385373;5596.776128954959;5599.32808063035;5606.551475882001;5609.579281553818;5619.915701264403;5536.4186760389575;5580.497755202051;5596.300462442195;5602.243697101002;5602.411746766531;5406.567474601944;5490.6431081979545;5507.476789704971;5614.438556144353;5620.4098569649595;5765;5773.826785196451;5795.797147099831;5807.593468457337;5808.593398462067;5611.971940140274;5662.320521537442;5664.575156863334;5665.603407761417;5677.460641239076 13:13:15 INFO - PROCESS | 3446 | |1;ext.html;595.9284885813703;639.5267502048484;654.5712558274332;661.1372159332071;668.134765478705;33472.66527334726;46048;46682;46738.76630616842;46775;48866.755666221616;49469.25796113052;49494;49506.50493495064;49534.75232623832;8210;8424.410291279613;8708.782280442976;8856.911430885673;10858.511366988465;10532.315399499008;10834.187435942296;10841.186910981669;10841.186910981707;10864.891351086468;10961.780764384708;10980.066694330992;10997.945010274938;10998.615048473304;11002.229843910929;10815.297005694643;10867.510962006729;10868.510917008754;10875.238733288674;10884.07485363741;10790.190735694854;10868.510917008674;10869.076128529005;10903.618373356894;10919.39943303126;44677.10645787066;45042.09915801699;45049.77475112636;45122.548774512165;45312.54687453116;3528.68241858234;3618.5295911531593;3683.318586061587;3705.8517659293598;4572.862814115582;35128.64871351279;36314.8184259077;36323;36480;36803;4698.08387364464;4724.976375118137;4757.976210118962;4848.418681051475;4886.267059941002;366899;371640;373303;374625;374670;69520;69784.3021569788;70334.64832675803;70338.99999999898;70397.64801175961;40361.192776144315;41055.589444105775;41085.58914410818;42969;43072.3539146913;16697.332106715596;16835.74746378805;16842.578935526464;16848.57878553046;16869.15654217284;14110.50613228532;14444.494442694455;14460.638484037983;14718.116912985255;14726.33731482086;22514.437139071655;22537;22551.43621409445;22559;22620.54758904813;7527.19876462383;7732;7787.571683557346;7980.45114284852;8064.637091330904;963.3160456076264;1044.5143008501084;1145.4444594371723;1176.200183874956;1181.2262967756133;33723.15692107717;34149.82925085359;34223;34247.4862877057;34279;1155.6417510571582;1161.8431511745976;1162.3200427749862;1166.854143232096;1253.6489782860813;17636.38272660451;17697.646047078986;17814.287428502714;17943;17994.37019704304;613275;619296;619347;619365;620319;62606;63212;63751;64090.359096409375;64219.67890160519;1338.1502745756516;1410.2314238739707;1422.0472283570032;1422.1583049950339;1458.5843034735262;33033;34239.82880085584;34895;35055.64944350524;35460.29079418449;52442.475575243756;52761.7361913188;52894.735526322125;53093.20360194678;53109.46890531045;422598;424078;424947;425496;527721;30002.84998574993;30734.077977660705;30897.69102309038;32367.35265294728;32425.675743242267;53241.73379133079;54001;54488.45511544992;54925.45074549363;55373;43065.354019690356;43921.560784391746;44250.778746106065;45107.77446112748;45332.32001520046;43678;43798.78100609477;44080;44088.33867491926;45581.544184559054;43139.78430107955;43918.560814392724;44049.779751101036;44236.55763442325;44350;38685.41971870368;39268.2146357077;39716.602833971294;39918.201635966536;40472.595274046886;29231.70768292375;29643.703562964958;29726.702732972393;29815;29941.401171976002 13:13:15 INFO - PROCESS | 3446 | |2;jquery.html;422.8393210579977;422.86891063770224;433.5491089267162;433.59458905922946;442.217275422502;18677.252909883588;19072.42782716517;19792.30726924556;19861.801381986177;19871.801281987176;18234.179461924214;18830;19207.32774352898;19253.807461925375;19297.90351048246;4870.634702397326;5093.057784309896;5113.667611605234;5241;5245.344331958505;5133.974330128344;5143.485651434845;5240.737963101848;5356.330458692663;5356.35723713153;5330.466953304677;5354.063038968185;5359.222912677679;5368.114261146906;5372.194170874381;5335.279737235482;5363.731813409314;5379.784808607651;5628.746706398222;5653.321601407857;5355.143177091685;5619.6066275360745;5630.943690563083;5660.150977353389;5725.971370143165;14102.083364581269;14171.433142674281;14186.71626567463;14299.714005719932;22362;2241.663750437431;2321.442853715113;2339.3215967369442;2358.5400846834873;2531.8354306970173;9969.65106221286;10367.63713270032;10613.469326533643;13346.399412026482;13419.46322147113;1948.7758907725652;1999.1703443071108;2043.8875861827594;2103.63186442372;2129;49389.50610493885;51200.74399627978;51241;60467.69766151141;83569.58215208945;9771.316007879523;11400.543978240778;11419.543218271343;11444.256123351955;11510.251833630788;14038.929805350908;14793.408263669333;14821.333040013225;14847.925760371345;14908.180050097131;8299;8351.540665263346;8540.658373664985;8579.957100214584;8601.82796344082;8373.455725377831;8384.077751447336;8391.412601117863;8438.240558349778;8470.195331443503;4728.905421891543;4839.830605928775;4886.65793394459;4917.0903382874285;4968.428630707443;1825.95007870475;1889.6409682160345;1904.5905130396754;1929.6237233739287;1935.767707875064;978.8972157923458;1009.28340877976;1030.896910308963;1055.672741450153;1112.0547534595692;18301.450956471326;18439.72340414895;19202.903985479985;19209.711854322195;19593.902030489757;1017.8524114003576;1019.7399663085865;1025.0825511167614;1043.5564884923876;1093.3931667924378;10069.446180460145;10455.790884182274;10786;10808.567657293777;10868.945655271673;413434;421308;424013;548315;556019;94258.5287073574;100673.49663251637;101060;101662.49168754109;106241;1083.3175099687146;1095.0801326885455;1115.074488174813;1121.1311233793874;1122.67442441691;17104.315827366765;17320.08887206205;17406.216720247365;17517.948923064658;17750.822491775434;29745.851270743507;38301;41181;41308.58691413168;42674.57325426706;56018.43981560295;56374.436255636916;59584;60096;60481.39518604758;8419.95790021046;8825;8940.73177804667;8943.910560894568;9023.639054437748;9242.260619150586;11956.10329225329;12327.69180770488;12472.688182795502;12485;10867.836982445428;10959.12327013821;11006.504707288032;11067.335959842436;11227.214095013598;10753;11075;11087.279326843729;11207.551697931991;11292.717682058013;10955.397453140155;11158.832617510907;11312.886871131182;11351.14866385008;11383.886161138615;8877.955610221907;8912.86630700553;9049.140331668481;10752.838707419238;11966;10687.679369618923;10784.514696838503;11383.715407114889;11513.88486115128;11716.70708232301 13:13:15 INFO - PROCESS | 3446 | |3;mootools.html;1394.6652803327192;1573.520076376705;1600.9759853602195;1784.6252287019724;1872.9250829966802;9021.233195178409;9389.201917836992;9433.622655093804;9660.855087173699;9680.419174849514;9449.716508504738;9641.13229809317;9665.903340966588;9668.274879384056;9672.80654386912;2461.3108329667634;2496.7253602103756;2500.2874180858457;2509.1970569417795;2509.924702258926;2387.224152150558;2484.167803785725;2506.9247922562263;2508.8620125893067;2513.0199222303318;2442.8778561071963;2452.141750387368;2500.3124140861228;2502.049221295905;2506.348349429152;2439.597466418039;2450.387403149213;2478.7273399926084;2479;2479.2810085075307;2391.0435825669697;2401.435662619283;2423.7333893271725;2430.902763889442;2445.09531473356;9148.817023659556;9424.481653509054;9425.858612120825;9485.620575176985;9491;5518.255035570187;5658.91511627326;5665.036943719578;5666.291713535808;5668.149777533362;3686.870959516431;3692.48305237267;3735.8879233623034;3763.3790424580184;3807.9619203807883;1208.9093318001096;1239.876012398762;1260.3635164242091;1305.3212329588562;1314.8093526438613;13750.106243094267;13878.097923635032;13923.164610123426;13923.373448194856;13944.51194208208;4821.325014497973;4874.317595536628;4922.163232250455;4940.283658869444;4949.604031677457;10697.358158510515;10759.623413180501;10788.56845726178;10793.29843560166;10798.73003174927;5576.637518561281;5578.888422231614;5580.358258800209;5583.078791999355;5584.63699859516;4445.355423463579;4929.679570827885;5059.215821547666;5069.417017043013;5110.7955681773055;3942.802859857053;3961.425593288957;3985.940210896839;4080.0819815541267;4091.427200191916;1154.6593754842343;1220.1824777399163;1229.6188181663713;1237.1340061956666;1244.9626511204679;951.9333646644668;963.9807203855884;965.1072757699101;969.6606187834343;988.7775250568708;5881.647101173943;6310.905336419957;6311.211098612674;6338;6355.428011478896;987.8666380038746;1030.7165529479303;1034.9586016559404;1036.228010132441;1070.989290107089;4339.804708788112;4441.200583894865;4441.489228738672;4447.533009034069;4490.708103973231;11782.823257651142;12255.264684118982;12257.938710306391;12282.14025018258;12288.508459661693;11922.403879805976;12110.75778484443;12168.634940951786;12325.876741232652;12403.6278911631;8803;8878.378513504122;8979.371443998987;9050.728478145666;9051.59267832949;6499.935000650122;6542.574732642363;6576.572522786004;6599.96700016516;6604.669766511752;10638.52126654287;11021.283616564897;11080.944595276973;11162.44187790591;11174.66476005721;11143.609973650884;11262.099032077578;11266.324020558794;11344.149188811038;11352.602658906899;7090.184628767552;7766.572838493711;7967;7984.520928744294;8176.83646327082;9511.381760185566;9527.714168574954;9570.856437153587;9575.425474471554;9586;8442.577871106298;8619.353548483763;8621.525816080175;8711.041785403473;8769.473831570127;8260.628271727666;8297.170282971654;8420.4947703138;8421.15788421153;8571.742847714579;7197.388222001188;7288.380487658608;7292.525985810906;7293.781186564412;7306.7077316906725;5190.117679994485;5215.13950198213;5361.892762144813;5376.112941364631;5381.811636592701;5406.945930540644;5485.670859748428;5501.339839219319;5511.889762204653;5539.279893613965 13:13:15 INFO - PROCESS | 3446 | |4;prototype.html;341.118209428627;348.0654442821026;351.778379620839;353.4292118229061;358.2476798722682;5431.565474762019;5466.863328416792;5493.340799104103;5495.80764673236;5499.175123731437;5379.139337705968;5391.973040134803;5423.810166644168;5456.7544460499275;5479.698616576086;3877.670398016172;4082.3876418537307;4224.408582798411;4229.97885010576;4231.265181275678;4157.833686652531;4227;4240.257954857903;4240.872773816791;4243.639290660298;4096.713230073896;4232.391691157356;4253.2131555662145;4253.383259427381;4257.595528424795;4111.52717437494;4230.598093181143;4247.723897946624;4251.787410629456;4257.723247988902;3753.635209817797;3789.412641040643;3789.7157713171346;3799.6010418905894;3803.7717736935874;5193.63644544882;5218.530332270076;5219.5041471060185;5238.397584277819;5274.525292723673;4922.621665933509;4934;4939.431965323998;4940.90118197634;4961.404631444214;5453.590980676426;5460.590455715837;5654.9717251413895;5665.603407761459;5732.051102625086;4068.5524592294823;4141.503019637633;4154.189932963073;4175.352820312856;4186.769727664977;5808.680522571257;5829.766809327622;5836.941630583682;5847.473727364558;5887.6173048752125;3956.802159891994;4198.160367926427;4200.537940826568;4202.3696445533415;4214.4099826024385;4217.915641687149;4221.873343799691;4234.237837189336;4235.618794308527;4255.5744425557195;4851.199552073939;4856.708597484162;4874.4150701916;4885.706857588556;4900.387451568554;5537.363203231599;5704.771809127588;5728.1407788831175;5731.197632331477;5745.597808153389;1446.1539999100435;1452.961132790039;1464.4654701034046;1472.8821694264648;1476.8849518613592;888.5424006636588;906.931980101495;922.686286662538;929.6235024814961;931.3015238571072;4846.224604063333;4914.754262286943;4933.87665308363;4963.404391473046;4963.875903102379;5173.430922598511;5178.559822415137;5186.377634683787;5205.427402985669;5207.385710429779;4761.6904901181315;4930.457649658535;4961.231009193581;4978.726170060681;5001.724905130252;2744.931376715598;2756.572731226663;2779.5691667791525;2799.80401371902;2809.9859500702364;5318.22885681574;5418.566514678895;5457.508824205841;5502.504774570308;5519.157633818587;5110.054639891632;5184.429712731597;5211.348581427322;5318;5320.654157479751;5390.703511306916;5770.509506691894;5930.8813823723285;6067.302260240041;6073.089036644538;5829.883402332014;5831.446012628793;5835.7373918174635;5836;5852.092925596539;5561.555075593862;5764.07774756037;5786.4213578643485;5800.796972105956;5804.854878628068;5966.49284810796;6072.570971611391;6073.897925742398;6097.237845269341;6119;4135.627793498599;4159.604837540429;4184.393262976912;4192.4759405074365;4252.363534608562;5513.862153446196;5863.325717542367;5869.00226961409;5883.79382226634;5884.764199517978;5721.485066344049;5727;5728.770849165987;5744.310682717934;5744.396838332083;5564.638298510584;5697.202391665253;5698.971505142447;5711.8857622848145;5741.698523349008;5582.33012038558;5586.245856809279;5614.69119198448;5617.8033768817895;5618.438156184512;5710.714464276853;5738.655680659173;5746.391010517062;5748.568857335633;5772.884542309046;5459.716966512946;5602.4957753802355;5617.943820561905;5636.2954630671165;5652.2086907833755 13:13:15 INFO - PROCESS | 3446 | |5;yui.html;845.5434065604572;845.7040035987405;873.2315562305171;893.6782758207048;903.3225081189104;14968.925155374234;16824.07467589282;17247.82752172478;17292.13539323035;17331.91334043331;15797.842021579781;16164.515064548053;16197.514074577752;16215.83784162158;16236.594085147877;737.1964558631091;856.3320609924269;872.7250915961467;889.2574700125404;890.7862113092843;883.2492381475759;886.4193952960821;892.6384814150247;892.7009451833643;893.2541327991136;926.5221970956314;932.1983094538691;932.8460803967371;933.2673851026946;933.7945651956559;766.4481573267238;907.3920473282916;928.0672923711694;928.2620316848088;929.3123088914223;683.6445048574762;683.7914436096988;683.931606839312;684.1243208692881;684.3088480634545;15705.371785128582;15721.685566288725;15768.526944191693;15772.132532710697;15783.842161578466;14441.855581444157;15179.392824287015;15242.542723718307;15418.768718469231;15613.68772624541;13771.793423098661;13808;13867.306634668226;13998.230097344642;14033.649158771112;4611.538846115395;4655.324977878188;4675.275332323496;4708.293755936603;4814.06125805468;76918;78550.60724696398;78912;79647;79767;12132.818007729891;12144.574939877062;12247.142700010914;12288.569900053455;12532.310722910328;22035.118595256332;22085.668714969288;22088.226912058002;22090.11639534433;22139.33581992543;7883.802904927308;8008.27925486709;8035.276825085771;8232.8353432931;8364;4820.3492528508905;4932.540692712016;4948.628852836052;4954.504549545089;5011.523905228997;3616;3728.3102626014274;3753.3806921857586;3763.6989040876665;3765.4540091686554;577.206341280739;654.7773756922669;663.2074670768385;664.1731044849193;676.0535250649033;737.9188289288174;775.8836174573859;782.1708988472237;802.6107337941094;823.9670413183405;9864.556094975744;10005.44970026641;10186.337888037255;10238.18094552434;10327.277090603586;753.0711493276409;778.7663700889824;788.2826627768703;791.1850793682516;801.3989507869098;4714.858554243378;4784.928226076611;5054.444011158769;5194.027765999333;5490.368607610096;121244;123308.38345808393;125118;137432.31283843517;142760.28619857042;107895;109029.45485272682;110423.44788276168;111026.44486777515;112176;96281;97699;98647;99159.50420247996;100620.45967012121;9815.938662870329;9857.689684866571;9877.703668889944;9891.802163956825;10132.696019119438;41596.792016039726;44665;56444.15333770079;57141.142882857624;57153;79965;82784;82966;83154.16845831464;83298.5835070845;14382;14731.263436827901;15251.771223431879;15352.539423817303;15499.457518986781;15088.622784430478;15177.544673659808;15343.693126137638;15998.680026399174;16822.66354672924;12982.545610903573;13508.459661613426;14001.22993235382;14759.631009224855;15049.54851354461;13508;14136.08115472491;14590.051646642934;14662;14850.331735072165;13804.861951380759;13838.16970981704;13963.860361396257;14027.228502432465;14923;10537.789244215226;10864.402457864893;10884.346939183675;10956.123510119012;11049.116070714485;11596.420178991186;11738.41307934617;11785;11838.526458941546;11981.580644677395 13:13:15 INFO - PROCESS | 3446 | __end_tp_report 13:13:15 INFO - PROCESS | 3446 | __start_cc_report 13:13:15 INFO - PROCESS | 3446 | _x_x_mozilla_cycle_collect,841 13:13:15 INFO - PROCESS | 3446 | __end_cc_report 13:13:15 INFO - PROCESS | 3446 | __startTimestamp1471378395952__endTimestamp 13:13:15 INFO - PROCESS | 3446 | 13:13:15 INFO - PROCESS | 3446 | ------- Summary: start ------- 13:13:15 INFO - PROCESS | 3446 | Number of tests: 6 13:13:15 INFO - PROCESS | 3446 | 13:13:15 INFO - PROCESS | 3446 | [#0] dojo.html Cycles:165 Average:5435.55 Median:5602.24 stddev:583.08 (10.4%) stddev-sans-first:560.69 13:13:15 INFO - PROCESS | 3446 | Values: 3317.4 3342.7 3350.8 3360.8 3385.6 5396.7 5502.9 5507.2 5522.7 5523.6 5435.5 5487.4 5513.8 5535.9 5569.5 4901.1 4942.3 4988.4 5009.2 5053.8 4930.5 4965.2 4985.2 5002.5 5074.1 5025.9 5037.6 5047.9 5088.7 5137.0 5100.7 5100.9 5103.5 5106.5 5128.2 4643.8 4853.0 4869.2 5012.1 5021.3 5332.1 5355.8 5380.7 5435.8 5439.2 5845.5 5871.7 5888.9 5894.3 5899.7 5747.0 5773.3 5854.5 5861.0 5934.3 5557.6 5560.7 5567.4 5577.2 5580.5 6030.4 6035.0 6051.8 6054.5 6057.0 5579.7 5643.9 5724.8 5727.8 5826.8 5826.0 5851.6 5888.9 5894.4 5898.0 5819.5 5860.5 5871.3 5872.0 5889.3 5559.8 5696.4 5757.8 5787.0 5878.8 4536.0 4545.5 4547.4 4550.1 4562.0 4033.7 4055.5 4059.2 4066.5 4073.9 5383.7 5445.5 5471.9 5499.9 5539.2 5865.2 5867.2 5868.2 5872.9 5918.2 5203.1 5562.8 5605.4 5620.3 5628.8 4960.7 5009.3 5016.6 5018.1 5027.0 5998.1 6001.6 6010.9 6011.5 6013.1 5657.5 5755.8 5805.3 5805.7 5821.0 6029.4 6123.0 6126.8 6133.3 6134.3 5760.7 5805.9 5810.5 5820.0 5823.6 5642.6 5710.0 5732.7 5882.4 5892.2 5596.8 5599.3 5606.6 5609.6 5619.9 5536.4 5580.5 5596.3 5602.2 5602.4 5406.6 5490.6 5507.5 5614.4 5620.4 5765.0 5773.8 5795.8 5807.6 5808.6 5612.0 5662.3 5664.6 5665.6 5677.5 13:13:15 INFO - PROCESS | 3446 | 13:13:15 INFO - PROCESS | 3446 | [#1] ext.html Cycles:180 Average:64983.87 Median:38976.82 stddev:130145.98 (333.9%) stddev-sans-first:130421.29 13:13:15 INFO - PROCESS | 3446 | Values: 595.9 639.5 654.6 661.1 668.1 33472.7 46048.0 46682.0 46738.8 46775.0 48866.8 49469.3 49494.0 49506.5 49534.8 8210.0 8424.4 8708.8 8856.9 10858.5 10532.3 10834.2 10841.2 10841.2 10864.9 10961.8 10980.1 10997.9 10998.6 11002.2 10815.3 10867.5 10868.5 10875.2 10884.1 10790.2 10868.5 10869.1 10903.6 10919.4 44677.1 45042.1 45049.8 45122.5 45312.5 3528.7 3618.5 3683.3 3705.9 4572.9 35128.6 36314.8 36323.0 36480.0 36803.0 4698.1 4725.0 4758.0 4848.4 4886.3 366899.0 371640.0 373303.0 374625.0 374670.0 69520.0 69784.3 70334.6 70339.0 70397.6 40361.2 41055.6 41085.6 42969.0 43072.4 16697.3 16835.7 16842.6 16848.6 16869.2 14110.5 14444.5 14460.6 14718.1 14726.3 22514.4 22537.0 22551.4 22559.0 22620.5 7527.2 7732.0 7787.6 7980.5 8064.6 963.3 1044.5 1145.4 1176.2 1181.2 33723.2 34149.8 34223.0 34247.5 34279.0 1155.6 1161.8 1162.3 1166.9 1253.6 17636.4 17697.6 17814.3 17943.0 17994.4 613275.0 619296.0 619347.0 619365.0 620319.0 62606.0 63212.0 63751.0 64090.4 64219.7 1338.2 1410.2 1422.0 1422.2 1458.6 33033.0 34239.8 34895.0 35055.6 35460.3 52442.5 52761.7 52894.7 53093.2 53109.5 422598.0 424078.0 424947.0 425496.0 527721.0 30002.8 30734.1 30897.7 32367.4 32425.7 53241.7 54001.0 54488.5 54925.5 55373.0 43065.4 43921.6 44250.8 45107.8 45332.3 43678.0 43798.8 44080.0 44088.3 45581.5 43139.8 43918.6 44049.8 44236.6 44350.0 38685.4 39268.2 39716.6 39918.2 40472.6 29231.7 29643.7 29726.7 29815.0 29941.4 13:13:15 INFO - PROCESS | 3446 | 13:13:15 INFO - PROCESS | 3446 | [#2] jquery.html Cycles:180 Average:27825.66 Median:19866.80 stddev:78729.26 (396.3%) stddev-sans-first:78923.23 13:13:15 INFO - PROCESS | 3446 | Values: 422.8 422.9 433.5 433.6 442.2 18677.3 19072.4 19792.3 19861.8 19871.8 18234.2 18830.0 19207.3 19253.8 19297.9 4870.6 5093.1 5113.7 5241.0 5245.3 5134.0 5143.5 5240.7 5356.3 5356.4 5330.5 5354.1 5359.2 5368.1 5372.2 5335.3 5363.7 5379.8 5628.7 5653.3 5355.1 5619.6 5630.9 5660.2 5726.0 14102.1 14171.4 14186.7 14299.7 22362.0 2241.7 2321.4 2339.3 2358.5 2531.8 9969.7 10367.6 10613.5 13346.4 13419.5 1948.8 1999.2 2043.9 2103.6 2129.0 49389.5 51200.7 51241.0 60467.7 83569.6 9771.3 11400.5 11419.5 11444.3 11510.3 14038.9 14793.4 14821.3 14847.9 14908.2 8299.0 8351.5 8540.7 8580.0 8601.8 8373.5 8384.1 8391.4 8438.2 8470.2 4728.9 4839.8 4886.7 4917.1 4968.4 1826.0 1889.6 1904.6 1929.6 1935.8 978.9 1009.3 1030.9 1055.7 1112.1 18301.5 18439.7 19202.9 19209.7 19593.9 1017.9 1019.7 1025.1 1043.6 1093.4 10069.4 10455.8 10786.0 10808.6 10868.9 413434.0 421308.0 424013.0 548315.0 556019.0 94258.5 100673.5 101060.0 101662.5 106241.0 1083.3 1095.1 1115.1 1121.1 1122.7 17104.3 17320.1 17406.2 17517.9 17750.8 29745.9 38301.0 41181.0 41308.6 42674.6 56018.4 56374.4 59584.0 60096.0 60481.4 8420.0 8825.0 8940.7 8943.9 9023.6 9242.3 11956.1 12327.7 12472.7 12485.0 10867.8 10959.1 11006.5 11067.3 11227.2 10753.0 11075.0 11087.3 11207.6 11292.7 10955.4 11158.8 11312.9 11351.1 11383.9 8878.0 8912.9 9049.1 10752.8 11966.0 10687.7 10784.5 11383.7 11513.9 11716.7 13:13:15 INFO - PROCESS | 3446 | 13:13:15 INFO - PROCESS | 3446 | [#3] mootools.html Cycles:180 Average:6268.00 Median:4847.82 stddev:3659.54 (75.5%) stddev-sans-first:3651.48 13:13:15 INFO - PROCESS | 3446 | Values: 1394.7 1573.5 1601.0 1784.6 1872.9 9021.2 9389.2 9433.6 9660.9 9680.4 9449.7 9641.1 9665.9 9668.3 9672.8 2461.3 2496.7 2500.3 2509.2 2509.9 2387.2 2484.2 2506.9 2508.9 2513.0 2442.9 2452.1 2500.3 2502.0 2506.3 2439.6 2450.4 2478.7 2479.0 2479.3 2391.0 2401.4 2423.7 2430.9 2445.1 9148.8 9424.5 9425.9 9485.6 9491.0 5518.3 5658.9 5665.0 5666.3 5668.1 3686.9 3692.5 3735.9 3763.4 3808.0 1208.9 1239.9 1260.4 1305.3 1314.8 13750.1 13878.1 13923.2 13923.4 13944.5 4821.3 4874.3 4922.2 4940.3 4949.6 10697.4 10759.6 10788.6 10793.3 10798.7 5576.6 5578.9 5580.4 5583.1 5584.6 4445.4 4929.7 5059.2 5069.4 5110.8 3942.8 3961.4 3985.9 4080.1 4091.4 1154.7 1220.2 1229.6 1237.1 1245.0 951.9 964.0 965.1 969.7 988.8 5881.6 6310.9 6311.2 6338.0 6355.4 987.9 1030.7 1035.0 1036.2 1071.0 4339.8 4441.2 4441.5 4447.5 4490.7 11782.8 12255.3 12257.9 12282.1 12288.5 11922.4 12110.8 12168.6 12325.9 12403.6 8803.0 8878.4 8979.4 9050.7 9051.6 6499.9 6542.6 6576.6 6600.0 6604.7 10638.5 11021.3 11080.9 11162.4 11174.7 11143.6 11262.1 11266.3 11344.1 11352.6 7090.2 7766.6 7967.0 7984.5 8176.8 9511.4 9527.7 9570.9 9575.4 9586.0 8442.6 8619.4 8621.5 8711.0 8769.5 8260.6 8297.2 8420.5 8421.2 8571.7 7197.4 7288.4 7292.5 7293.8 7306.7 5190.1 5215.1 5361.9 5376.1 5381.8 5406.9 5485.7 5501.3 5511.9 5539.3 13:13:15 INFO - PROCESS | 3446 | 13:13:15 INFO - PROCESS | 3446 | [#4] prototype.html Cycles:180 Average:4701.08 Median:5228.95 stddev:1376.30 (26.3%) stddev-sans-first:1340.69 13:13:15 INFO - PROCESS | 3446 | Values: 341.1 348.1 351.8 353.4 358.2 5431.6 5466.9 5493.3 5495.8 5499.2 5379.1 5392.0 5423.8 5456.8 5479.7 3877.7 4082.4 4224.4 4230.0 4231.3 4157.8 4227.0 4240.3 4240.9 4243.6 4096.7 4232.4 4253.2 4253.4 4257.6 4111.5 4230.6 4247.7 4251.8 4257.7 3753.6 3789.4 3789.7 3799.6 3803.8 5193.6 5218.5 5219.5 5238.4 5274.5 4922.6 4934.0 4939.4 4940.9 4961.4 5453.6 5460.6 5655.0 5665.6 5732.1 4068.6 4141.5 4154.2 4175.4 4186.8 5808.7 5829.8 5836.9 5847.5 5887.6 3956.8 4198.2 4200.5 4202.4 4214.4 4217.9 4221.9 4234.2 4235.6 4255.6 4851.2 4856.7 4874.4 4885.7 4900.4 5537.4 5704.8 5728.1 5731.2 5745.6 1446.2 1453.0 1464.5 1472.9 1476.9 888.5 906.9 922.7 929.6 931.3 4846.2 4914.8 4933.9 4963.4 4963.9 5173.4 5178.6 5186.4 5205.4 5207.4 4761.7 4930.5 4961.2 4978.7 5001.7 2744.9 2756.6 2779.6 2799.8 2810.0 5318.2 5418.6 5457.5 5502.5 5519.2 5110.1 5184.4 5211.3 5318.0 5320.7 5390.7 5770.5 5930.9 6067.3 6073.1 5829.9 5831.4 5835.7 5836.0 5852.1 5561.6 5764.1 5786.4 5800.8 5804.9 5966.5 6072.6 6073.9 6097.2 6119.0 4135.6 4159.6 4184.4 4192.5 4252.4 5513.9 5863.3 5869.0 5883.8 5884.8 5721.5 5727.0 5728.8 5744.3 5744.4 5564.6 5697.2 5699.0 5711.9 5741.7 5582.3 5586.2 5614.7 5617.8 5618.4 5710.7 5738.7 5746.4 5748.6 5772.9 5459.7 5602.5 5617.9 5636.3 5652.2 13:13:15 INFO - PROCESS | 3446 | 13:13:15 INFO - PROCESS | 3446 | [#5] yui.html Cycles:180 Average:22582.44 Median:22681.12 stddev:33286.59 (146.8%) stddev-sans-first:33339.95 13:13:15 INFO - PROCESS | 3446 | Values: 845.5 845.7 873.2 893.7 903.3 14968.9 16824.1 17247.8 17292.1 17331.9 15797.8 16164.5 16197.5 16215.8 16236.6 737.2 856.3 872.7 889.3 890.8 883.2 886.4 892.6 892.7 893.3 926.5 932.2 932.8 933.3 933.8 766.4 907.4 928.1 928.3 929.3 683.6 683.8 683.9 684.1 684.3 15705.4 15721.7 15768.5 15772.1 15783.8 14441.9 15179.4 15242.5 15418.8 15613.7 13771.8 13808.0 13867.3 13998.2 14033.6 4611.5 4655.3 4675.3 4708.3 4814.1 76918.0 78550.6 78912.0 79647.0 79767.0 12132.8 12144.6 12247.1 12288.6 12532.3 22035.1 22085.7 22088.2 22090.1 22139.3 7883.8 8008.3 8035.3 8232.8 8364.0 4820.3 4932.5 4948.6 4954.5 5011.5 3616.0 3728.3 3753.4 3763.7 3765.5 577.2 654.8 663.2 664.2 676.1 737.9 775.9 782.2 802.6 824.0 9864.6 10005.4 10186.3 10238.2 10327.3 753.1 778.8 788.3 791.2 801.4 4714.9 4784.9 5054.4 5194.0 5490.4 121244.0 123308.4 125118.0 137432.3 142760.3 107895.0 109029.5 110423.4 111026.4 112176.0 96281.0 97699.0 98647.0 99159.5 100620.5 9815.9 9857.7 9877.7 9891.8 10132.7 41596.8 44665.0 56444.2 57141.1 57153.0 79965.0 82784.0 82966.0 83154.2 83298.6 14382.0 14731.3 15251.8 15352.5 15499.5 15088.6 15177.5 15343.7 15998.7 16822.7 12982.5 13508.5 14001.2 14759.6 15049.5 13508.0 14136.1 14590.1 14662.0 14850.3 13804.9 13838.2 13963.9 14027.2 14923.0 10537.8 10864.4 10884.3 10956.1 11049.1 11596.4 11738.4 11785.0 11838.5 11981.6 13:13:15 INFO - PROCESS | 3446 | -------- Summary: end -------- 13:13:15 INFO - PROCESS | 3446 | 13:13:16 INFO - TEST-INFO | 3446: exit 0 13:13:16 INFO - TEST-OK | dromaeo_css | took 1112329ms 13:13:16 INFO - TEST-START | kraken 13:13:16 INFO - operating with platform_type : linux_ 13:13:16 INFO - Initialising browser for kraken test... 13:13:16 INFO - TEST-INFO | started process 3640 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwlCEdn/profile http://localhost:53624/getInfo.html) 13:13:20 INFO - PROCESS | 3640 | __metrics Screen width/height:1600/1200 13:13:20 INFO - PROCESS | 3640 | colorDepth:24 13:13:20 INFO - PROCESS | 3640 | Browser inner width/height: 1024/697 13:13:20 INFO - PROCESS | 3640 | __metrics 13:13:21 INFO - PROCESS | 3640 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:13:21 ERROR - PROCESS | 3640 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:13:22 INFO - TEST-INFO | 3640: exit 0 13:13:22 INFO - Browser initialized. 13:13:22 INFO - Running cycle 1/1 for kraken test... 13:13:22 INFO - TEST-INFO | started process 3732 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwlCEdn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:13:33 INFO - PROCESS | 3732 | RSS: Main: 141062144 13:13:33 INFO - PROCESS | 3732 | 13:13:36 INFO - PROCESS | 3732 | Cycle 1(1): loaded http://localhost:53624/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53624/tests/kraken/driver.html?testName=audio-beat-detection) 13:13:37 INFO - PROCESS | 3732 | RSS: Main: 191856640 13:13:37 INFO - PROCESS | 3732 | 13:13:39 INFO - PROCESS | 3732 | Cycle 1(1): loaded http://localhost:53624/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53624/tests/kraken/driver.html?testName=audio-dft) 13:13:40 INFO - PROCESS | 3732 | RSS: Main: 189644800 13:13:40 INFO - PROCESS | 3732 | 13:13:43 INFO - PROCESS | 3732 | Cycle 1(1): loaded http://localhost:53624/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53624/tests/kraken/driver.html?testName=audio-fft) 13:13:43 INFO - PROCESS | 3732 | RSS: Main: 275501056 13:13:43 INFO - PROCESS | 3732 | 13:13:45 INFO - PROCESS | 3732 | Cycle 1(1): loaded http://localhost:53624/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53624/tests/kraken/driver.html?testName=audio-oscillator) 13:13:46 INFO - PROCESS | 3732 | RSS: Main: 184492032 13:13:46 INFO - PROCESS | 3732 | 13:13:48 INFO - PROCESS | 3732 | Cycle 1(1): loaded http://localhost:53624/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53624/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:13:49 INFO - PROCESS | 3732 | RSS: Main: 185122816 13:13:49 INFO - PROCESS | 3732 | 13:13:52 INFO - PROCESS | 3732 | Cycle 1(1): loaded http://localhost:53624/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53624/tests/kraken/driver.html?testName=imaging-darkroom) 13:13:52 INFO - PROCESS | 3732 | RSS: Main: 219697152 13:13:52 INFO - PROCESS | 3732 | 13:13:56 INFO - PROCESS | 3732 | Cycle 1(1): loaded http://localhost:53624/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53624/tests/kraken/driver.html?testName=imaging-desaturate) 13:13:56 INFO - PROCESS | 3732 | RSS: Main: 219381760 13:13:56 INFO - PROCESS | 3732 | 13:13:59 INFO - PROCESS | 3732 | Cycle 1(1): loaded http://localhost:53624/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53624/tests/kraken/driver.html?testName=json-parse-financial) 13:14:00 INFO - PROCESS | 3732 | RSS: Main: 219369472 13:14:00 INFO - PROCESS | 3732 | 13:14:01 INFO - PROCESS | 3732 | Cycle 1(1): loaded http://localhost:53624/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53624/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:14:02 INFO - PROCESS | 3732 | RSS: Main: 199233536 13:14:02 INFO - PROCESS | 3732 | 13:14:04 INFO - PROCESS | 3732 | Cycle 1(1): loaded http://localhost:53624/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53624/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:14:04 INFO - PROCESS | 3732 | RSS: Main: 199557120 13:14:04 INFO - PROCESS | 3732 | 13:14:06 INFO - PROCESS | 3732 | Cycle 1(1): loaded http://localhost:53624/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53624/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:14:07 INFO - PROCESS | 3732 | RSS: Main: 206417920 13:14:07 INFO - PROCESS | 3732 | 13:14:09 INFO - PROCESS | 3732 | Cycle 1(1): loaded http://localhost:53624/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53624/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:14:10 INFO - PROCESS | 3732 | RSS: Main: 212983808 13:14:10 INFO - PROCESS | 3732 | 13:14:13 INFO - PROCESS | 3732 | Cycle 1(1): loaded http://localhost:53624/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53624/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:14:13 INFO - PROCESS | 3732 | RSS: Main: 213716992 13:14:13 INFO - PROCESS | 3732 | 13:14:15 INFO - PROCESS | 3732 | Cycle 1(1): loaded http://localhost:53624/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53624/tests/kraken/driver.html?testName=ai-astar) 13:14:15 INFO - PROCESS | 3732 | RSS: Main: 256360448 13:14:15 INFO - PROCESS | 3732 | 13:14:15 INFO - PROCESS | 3732 | __start_tp_report 13:14:15 INFO - PROCESS | 3732 | _x_x_mozilla_page_load 13:14:15 INFO - PROCESS | 3732 | _x_x_mozilla_page_load_details 13:14:15 INFO - PROCESS | 3732 | |i|pagename|runs| 13:14:15 INFO - PROCESS | 3732 | |0;ai-astar;111;103;109;110;110;111;111;112;110;110 13:14:15 INFO - PROCESS | 3732 | |1;audio-beat-detection;148;131;124;172;128;126;154;130;162;133 13:14:15 INFO - PROCESS | 3732 | |2;audio-dft;161;160;162;161;161;161;161;163;161;161 13:14:15 INFO - PROCESS | 3732 | |3;audio-fft;74;74;75;124;74;76;74;75;98;74 13:14:15 INFO - PROCESS | 3732 | |4;audio-oscillator;84;84;111;84;85;85;114;84;84;133 13:14:15 INFO - PROCESS | 3732 | |5;imaging-gaussian-blur;117;116;117;117;117;116;117;116;117;117 13:14:15 INFO - PROCESS | 3732 | |6;imaging-darkroom;146;145;146;146;146;146;146;146;146;146 13:14:15 INFO - PROCESS | 3732 | |7;imaging-desaturate;95;96;95;95;95;94;95;95;95;94 13:14:15 INFO - PROCESS | 3732 | |8;json-parse-financial;52;52;53;52;51;54;52;52;53;52 13:14:15 INFO - PROCESS | 3732 | |9;json-stringify-tinderbox;62;61;61;60;60;60;61;62;61;63 13:14:15 INFO - PROCESS | 3732 | |10;stanford-crypto-aes;76;75;81;76;75;77;85;83;110;82 13:14:15 INFO - PROCESS | 3732 | |11;stanford-crypto-ccm;124;120;117;125;120;118;118;119;140;129 13:14:15 INFO - PROCESS | 3732 | |12;stanford-crypto-pbkdf2;154;156;156;159;159;157;157;157;156;153 13:14:15 INFO - PROCESS | 3732 | |13;stanford-crypto-sha256-iterative;63;61;63;61;65;61;65;60;59;60 13:14:15 INFO - PROCESS | 3732 | __end_tp_report 13:14:15 INFO - PROCESS | 3732 | __start_cc_report 13:14:15 INFO - PROCESS | 3732 | _x_x_mozilla_cycle_collect,1530 13:14:15 INFO - PROCESS | 3732 | __end_cc_report 13:14:15 INFO - PROCESS | 3732 | __startTimestamp1471378455546__endTimestamp 13:14:15 INFO - PROCESS | 3732 | 13:14:15 INFO - PROCESS | 3732 | ------- Summary: start ------- 13:14:15 INFO - PROCESS | 3732 | Number of tests: 14 13:14:15 INFO - PROCESS | 3732 | 13:14:15 INFO - PROCESS | 3732 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.50 stddev:2.50 (2.3%) stddev-sans-first:2.60 13:14:15 INFO - PROCESS | 3732 | Values: 111.0 103.0 109.0 110.0 110.0 111.0 111.0 112.0 110.0 110.0 13:14:15 INFO - PROCESS | 3732 | 13:14:15 INFO - PROCESS | 3732 | [#1] audio-beat-detection Cycles:10 Average:140.80 Median:140.50 stddev:16.96 (12.1%) stddev-sans-first:17.78 13:14:15 INFO - PROCESS | 3732 | Values: 148.0 131.0 124.0 172.0 128.0 126.0 154.0 130.0 162.0 133.0 13:14:15 INFO - PROCESS | 3732 | 13:14:15 INFO - PROCESS | 3732 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 13:14:15 INFO - PROCESS | 3732 | Values: 161.0 160.0 162.0 161.0 161.0 161.0 161.0 163.0 161.0 161.0 13:14:15 INFO - PROCESS | 3732 | 13:14:15 INFO - PROCESS | 3732 | [#3] audio-fft Cycles:10 Average:81.80 Median:74.50 stddev:16.58 (22.3%) stddev-sans-first:17.34 13:14:15 INFO - PROCESS | 3732 | Values: 74.0 74.0 75.0 124.0 74.0 76.0 74.0 75.0 98.0 74.0 13:14:15 INFO - PROCESS | 3732 | 13:14:15 INFO - PROCESS | 3732 | [#4] audio-oscillator Cycles:10 Average:94.80 Median:84.00 stddev:17.84 (21.2%) stddev-sans-first:18.49 13:14:15 INFO - PROCESS | 3732 | Values: 84.0 84.0 111.0 84.0 85.0 85.0 114.0 84.0 84.0 133.0 13:14:15 INFO - PROCESS | 3732 | 13:14:15 INFO - PROCESS | 3732 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 13:14:15 INFO - PROCESS | 3732 | Values: 117.0 116.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 13:14:15 INFO - PROCESS | 3732 | 13:14:15 INFO - PROCESS | 3732 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 13:14:15 INFO - PROCESS | 3732 | Values: 146.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 13:14:15 INFO - PROCESS | 3732 | 13:14:15 INFO - PROCESS | 3732 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 13:14:15 INFO - PROCESS | 3732 | Values: 95.0 96.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 94.0 13:14:15 INFO - PROCESS | 3732 | 13:14:15 INFO - PROCESS | 3732 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.00 stddev:0.82 (1.6%) stddev-sans-first:0.87 13:14:15 INFO - PROCESS | 3732 | Values: 52.0 52.0 53.0 52.0 51.0 54.0 52.0 52.0 53.0 52.0 13:14:15 INFO - PROCESS | 3732 | 13:14:15 INFO - PROCESS | 3732 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:0.99 (1.6%) stddev-sans-first:1.00 13:14:15 INFO - PROCESS | 3732 | Values: 62.0 61.0 61.0 60.0 60.0 60.0 61.0 62.0 61.0 63.0 13:14:15 INFO - PROCESS | 3732 | 13:14:15 INFO - PROCESS | 3732 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:79.00 stddev:10.49 (13.3%) stddev-sans-first:10.90 13:14:15 INFO - PROCESS | 3732 | Values: 76.0 75.0 81.0 76.0 75.0 77.0 85.0 83.0 110.0 82.0 13:14:15 INFO - PROCESS | 3732 | 13:14:15 INFO - PROCESS | 3732 | [#11] stanford-crypto-ccm Cycles:10 Average:123.00 Median:122.00 stddev:7.07 (5.8%) stddev-sans-first:7.49 13:14:15 INFO - PROCESS | 3732 | Values: 124.0 120.0 117.0 125.0 120.0 118.0 118.0 119.0 140.0 129.0 13:14:15 INFO - PROCESS | 3732 | 13:14:15 INFO - PROCESS | 3732 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.40 Median:157.00 stddev:1.90 (1.2%) stddev-sans-first:1.80 13:14:15 INFO - PROCESS | 3732 | Values: 154.0 156.0 156.0 159.0 159.0 157.0 157.0 157.0 156.0 153.0 13:14:15 INFO - PROCESS | 3732 | 13:14:15 INFO - PROCESS | 3732 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.80 Median:62.00 stddev:2.10 (3.4%) stddev-sans-first:2.18 13:14:15 INFO - PROCESS | 3732 | Values: 63.0 61.0 63.0 61.0 65.0 61.0 65.0 60.0 59.0 60.0 13:14:15 INFO - PROCESS | 3732 | -------- Summary: end -------- 13:14:15 INFO - PROCESS | 3732 | 13:14:16 INFO - TEST-INFO | 3732: exit 0 13:14:16 INFO - TEST-OK | kraken | took 59805ms 13:14:16 INFO - SUITE-END | took 1172s 13:14:16 INFO - Completed test suite (00:19:32) 13:14:16 INFO - javascript benchmark 13:14:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3317.369699757046, 3342.699157075864, 3350.765446418751, 3360.831958402079, 3385.5768028996376, 5396.7031813250305, 5502.862428439286, 5507.173923911405, 5522.668639881605, 5523.585731070166, 5435.456454354563, 5487.368952570456, 5513.759404134078, 5535.944640553594, 5569.526590239824, 4901.142300097468, 4942.308076869242, 4988.3515143031445, 5009.248612708105, 5053.79784808609, 4930.53159949806, 4965.180745177042, 4985.202367621181, 5002.474740152286, 5074.086664400406, 5025.949740502603, 5037.596992240612, 5047.924281135786, 5088.669236499634, 5137.049645815536, 5100.668456550349, 5100.923486147711, 5103.489651034867, 5106.489351064901, 5128.205128205115, 4643.814247430132, 4852.951470485285, 4869.220924652074, 5012.072766538202, 5021.347224860781, 5332.093544097513, 5355.812546560852, 5380.650257733235, 5435.83692489226, 5439.156930675712, 5845.473907348317, 5871.706414679249, 5888.882222355529, 5894.263217097863, 5899.675517846516, 5746.971265143689, 5773.307203135609, 5854.531637468992, 5861.032929566616, 5934.258217722785, 5557.638753481092, 5560.666360018412, 5567.387587365427, 5577.163425486169, 5580.469855363734, 6030.427109424598, 6035.034394496859, 6051.848703782441, 6054.545909056838, 6057.030875059969, 5579.6652200868075, 5643.887122257532, 5724.8282551523525, 5727.77088916447, 5826.82519524415, 5826.0, 5851.561132915049, 5888.852778680567, 5894.4400281974, 5898.026825573818, 5819.476247137778, 5860.501857342174, 5871.324797648325, 5872.0, 5889.263842019747, 5559.805406810823, 5696.401877802854, 5757.827265182052, 5787.0, 5878.764849405976, 4535.9773201133785, 4545.499995000548, 4547.386102876136, 4550.067236216568, 4562.0, 4033.657139143147, 4055.513338399411, 4059.188162367538, 4066.4510291110914, 4073.89815254621, 5383.67697938125, 5445.50990410865, 5471.917921231185, 5499.945000549943, 5539.224508568804, 5865.237519122572, 5867.237259156283, 5868.2077919480325, 5872.882542349129, 5918.23063001807, 5203.115470370046, 5562.833115006556, 5605.383407825136, 5620.297462817148, 5628.831135065954, 4960.677555958851, 5009.348784658044, 5016.648834581617, 5018.1218286800395, 5026.974865125651, 5998.070299103646, 6001.609895356788, 6010.879782404328, 6011.48902343297, 6013.128096425994, 5657.4908258256955, 5755.7697692093525, 5805.303363596396, 5805.651660900444, 5821.0, 6029.366916473882, 6123.008104567321, 6126.8230438726505, 6133.273457575459, 6134.319937288865, 5760.711964401847, 5805.883882322245, 5810.477057064884, 5820.0, 5823.621464604787, 5642.605017648725, 5709.9714501427225, 5732.742026608896, 5882.382349853204, 5892.204552385373, 5596.776128954959, 5599.32808063035, 5606.551475882001, 5609.579281553818, 5619.915701264403, 5536.4186760389575, 5580.497755202051, 5596.300462442195, 5602.243697101002, 5602.411746766531, 5406.567474601944, 5490.6431081979545, 5507.476789704971, 5614.438556144353, 5620.4098569649595, 5765.0, 5773.826785196451, 5795.797147099831, 5807.593468457337, 5808.593398462067, 5611.971940140274, 5662.320521537442, 5664.575156863334, 5665.603407761417, 5677.460641239076], "value": 5399.374350304817, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.9284885813703, 639.5267502048484, 654.5712558274332, 661.1372159332071, 668.134765478705, 33472.66527334726, 46048.0, 46682.0, 46738.76630616842, 46775.0, 48866.755666221616, 49469.25796113052, 49494.0, 49506.50493495064, 49534.75232623832, 8210.0, 8424.410291279613, 8708.782280442976, 8856.911430885673, 10858.511366988465, 10532.315399499008, 10834.187435942296, 10841.186910981669, 10841.186910981707, 10864.891351086468, 10961.780764384708, 10980.066694330992, 10997.945010274938, 10998.615048473304, 11002.229843910929, 10815.297005694643, 10867.510962006729, 10868.510917008754, 10875.238733288674, 10884.07485363741, 10790.190735694854, 10868.510917008674, 10869.076128529005, 10903.618373356894, 10919.39943303126, 44677.10645787066, 45042.09915801699, 45049.77475112636, 45122.548774512165, 45312.54687453116, 3528.68241858234, 3618.5295911531593, 3683.318586061587, 3705.8517659293598, 4572.862814115582, 35128.64871351279, 36314.8184259077, 36323.0, 36480.0, 36803.0, 4698.08387364464, 4724.976375118137, 4757.976210118962, 4848.418681051475, 4886.267059941002, 366899.0, 371640.0, 373303.0, 374625.0, 374670.0, 69520.0, 69784.3021569788, 70334.64832675803, 70338.99999999898, 70397.64801175961, 40361.192776144315, 41055.589444105775, 41085.58914410818, 42969.0, 43072.3539146913, 16697.332106715596, 16835.74746378805, 16842.578935526464, 16848.57878553046, 16869.15654217284, 14110.50613228532, 14444.494442694455, 14460.638484037983, 14718.116912985255, 14726.33731482086, 22514.437139071655, 22537.0, 22551.43621409445, 22559.0, 22620.54758904813, 7527.19876462383, 7732.0, 7787.571683557346, 7980.45114284852, 8064.637091330904, 963.3160456076264, 1044.5143008501084, 1145.4444594371723, 1176.200183874956, 1181.2262967756133, 33723.15692107717, 34149.82925085359, 34223.0, 34247.4862877057, 34279.0, 1155.6417510571582, 1161.8431511745976, 1162.3200427749862, 1166.854143232096, 1253.6489782860813, 17636.38272660451, 17697.646047078986, 17814.287428502714, 17943.0, 17994.37019704304, 613275.0, 619296.0, 619347.0, 619365.0, 620319.0, 62606.0, 63212.0, 63751.0, 64090.359096409375, 64219.67890160519, 1338.1502745756516, 1410.2314238739707, 1422.0472283570032, 1422.1583049950339, 1458.5843034735262, 33033.0, 34239.82880085584, 34895.0, 35055.64944350524, 35460.29079418449, 52442.475575243756, 52761.7361913188, 52894.735526322125, 53093.20360194678, 53109.46890531045, 422598.0, 424078.0, 424947.0, 425496.0, 527721.0, 30002.84998574993, 30734.077977660705, 30897.69102309038, 32367.35265294728, 32425.675743242267, 53241.73379133079, 54001.0, 54488.45511544992, 54925.45074549363, 55373.0, 43065.354019690356, 43921.560784391746, 44250.778746106065, 45107.77446112748, 45332.32001520046, 43678.0, 43798.78100609477, 44080.0, 44088.33867491926, 45581.544184559054, 43139.78430107955, 43918.560814392724, 44049.779751101036, 44236.55763442325, 44350.0, 38685.41971870368, 39268.2146357077, 39716.602833971294, 39918.201635966536, 40472.595274046886, 29231.70768292375, 29643.703562964958, 29726.702732972393, 29815.0, 29941.401171976002], "value": 21793.96943685976, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.8393210579977, 422.86891063770224, 433.5491089267162, 433.59458905922946, 442.217275422502, 18677.252909883588, 19072.42782716517, 19792.30726924556, 19861.801381986177, 19871.801281987176, 18234.179461924214, 18830.0, 19207.32774352898, 19253.807461925375, 19297.90351048246, 4870.634702397326, 5093.057784309896, 5113.667611605234, 5241.0, 5245.344331958505, 5133.974330128344, 5143.485651434845, 5240.737963101848, 5356.330458692663, 5356.35723713153, 5330.466953304677, 5354.063038968185, 5359.222912677679, 5368.114261146906, 5372.194170874381, 5335.279737235482, 5363.731813409314, 5379.784808607651, 5628.746706398222, 5653.321601407857, 5355.143177091685, 5619.6066275360745, 5630.943690563083, 5660.150977353389, 5725.971370143165, 14102.083364581269, 14171.433142674281, 14186.71626567463, 14299.714005719932, 22362.0, 2241.663750437431, 2321.442853715113, 2339.3215967369442, 2358.5400846834873, 2531.8354306970173, 9969.65106221286, 10367.63713270032, 10613.469326533643, 13346.399412026482, 13419.46322147113, 1948.7758907725652, 1999.1703443071108, 2043.8875861827594, 2103.63186442372, 2129.0, 49389.50610493885, 51200.74399627978, 51241.0, 60467.69766151141, 83569.58215208945, 9771.316007879523, 11400.543978240778, 11419.543218271343, 11444.256123351955, 11510.251833630788, 14038.929805350908, 14793.408263669333, 14821.333040013225, 14847.925760371345, 14908.180050097131, 8299.0, 8351.540665263346, 8540.658373664985, 8579.957100214584, 8601.82796344082, 8373.455725377831, 8384.077751447336, 8391.412601117863, 8438.240558349778, 8470.195331443503, 4728.905421891543, 4839.830605928775, 4886.65793394459, 4917.0903382874285, 4968.428630707443, 1825.95007870475, 1889.6409682160345, 1904.5905130396754, 1929.6237233739287, 1935.767707875064, 978.8972157923458, 1009.28340877976, 1030.896910308963, 1055.672741450153, 1112.0547534595692, 18301.450956471326, 18439.72340414895, 19202.903985479985, 19209.711854322195, 19593.902030489757, 1017.8524114003576, 1019.7399663085865, 1025.0825511167614, 1043.5564884923876, 1093.3931667924378, 10069.446180460145, 10455.790884182274, 10786.0, 10808.567657293777, 10868.945655271673, 413434.0, 421308.0, 424013.0, 548315.0, 556019.0, 94258.5287073574, 100673.49663251637, 101060.0, 101662.49168754109, 106241.0, 1083.3175099687146, 1095.0801326885455, 1115.074488174813, 1121.1311233793874, 1122.67442441691, 17104.315827366765, 17320.08887206205, 17406.216720247365, 17517.948923064658, 17750.822491775434, 29745.851270743507, 38301.0, 41181.0, 41308.58691413168, 42674.57325426706, 56018.43981560295, 56374.436255636916, 59584.0, 60096.0, 60481.39518604758, 8419.95790021046, 8825.0, 8940.73177804667, 8943.910560894568, 9023.639054437748, 9242.260619150586, 11956.10329225329, 12327.69180770488, 12472.688182795502, 12485.0, 10867.836982445428, 10959.12327013821, 11006.504707288032, 11067.335959842436, 11227.214095013598, 10753.0, 11075.0, 11087.279326843729, 11207.551697931991, 11292.717682058013, 10955.397453140155, 11158.832617510907, 11312.886871131182, 11351.14866385008, 11383.886161138615, 8877.955610221907, 8912.86630700553, 9049.140331668481, 10752.838707419238, 11966.0, 10687.679369618923, 10784.514696838503, 11383.715407114889, 11513.88486115128, 11716.70708232301], "value": 9054.05963377621, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1394.6652803327192, 1573.520076376705, 1600.9759853602195, 1784.6252287019724, 1872.9250829966802, 9021.233195178409, 9389.201917836992, 9433.622655093804, 9660.855087173699, 9680.419174849514, 9449.716508504738, 9641.13229809317, 9665.903340966588, 9668.274879384056, 9672.80654386912, 2461.3108329667634, 2496.7253602103756, 2500.2874180858457, 2509.1970569417795, 2509.924702258926, 2387.224152150558, 2484.167803785725, 2506.9247922562263, 2508.8620125893067, 2513.0199222303318, 2442.8778561071963, 2452.141750387368, 2500.3124140861228, 2502.049221295905, 2506.348349429152, 2439.597466418039, 2450.387403149213, 2478.7273399926084, 2479.0, 2479.2810085075307, 2391.0435825669697, 2401.435662619283, 2423.7333893271725, 2430.902763889442, 2445.09531473356, 9148.817023659556, 9424.481653509054, 9425.858612120825, 9485.620575176985, 9491.0, 5518.255035570187, 5658.91511627326, 5665.036943719578, 5666.291713535808, 5668.149777533362, 3686.870959516431, 3692.48305237267, 3735.8879233623034, 3763.3790424580184, 3807.9619203807883, 1208.9093318001096, 1239.876012398762, 1260.3635164242091, 1305.3212329588562, 1314.8093526438613, 13750.106243094267, 13878.097923635032, 13923.164610123426, 13923.373448194856, 13944.51194208208, 4821.325014497973, 4874.317595536628, 4922.163232250455, 4940.283658869444, 4949.604031677457, 10697.358158510515, 10759.623413180501, 10788.56845726178, 10793.29843560166, 10798.73003174927, 5576.637518561281, 5578.888422231614, 5580.358258800209, 5583.078791999355, 5584.63699859516, 4445.355423463579, 4929.679570827885, 5059.215821547666, 5069.417017043013, 5110.7955681773055, 3942.802859857053, 3961.425593288957, 3985.940210896839, 4080.0819815541267, 4091.427200191916, 1154.6593754842343, 1220.1824777399163, 1229.6188181663713, 1237.1340061956666, 1244.9626511204679, 951.9333646644668, 963.9807203855884, 965.1072757699101, 969.6606187834343, 988.7775250568708, 5881.647101173943, 6310.905336419957, 6311.211098612674, 6338.0, 6355.428011478896, 987.8666380038746, 1030.7165529479303, 1034.9586016559404, 1036.228010132441, 1070.989290107089, 4339.804708788112, 4441.200583894865, 4441.489228738672, 4447.533009034069, 4490.708103973231, 11782.823257651142, 12255.264684118982, 12257.938710306391, 12282.14025018258, 12288.508459661693, 11922.403879805976, 12110.75778484443, 12168.634940951786, 12325.876741232652, 12403.6278911631, 8803.0, 8878.378513504122, 8979.371443998987, 9050.728478145666, 9051.59267832949, 6499.935000650122, 6542.574732642363, 6576.572522786004, 6599.96700016516, 6604.669766511752, 10638.52126654287, 11021.283616564897, 11080.944595276973, 11162.44187790591, 11174.66476005721, 11143.609973650884, 11262.099032077578, 11266.324020558794, 11344.149188811038, 11352.602658906899, 7090.184628767552, 7766.572838493711, 7967.0, 7984.520928744294, 8176.83646327082, 9511.381760185566, 9527.714168574954, 9570.856437153587, 9575.425474471554, 9586.0, 8442.577871106298, 8619.353548483763, 8621.525816080175, 8711.041785403473, 8769.473831570127, 8260.628271727666, 8297.170282971654, 8420.4947703138, 8421.15788421153, 8571.742847714579, 7197.388222001188, 7288.380487658608, 7292.525985810906, 7293.781186564412, 7306.7077316906725, 5190.117679994485, 5215.13950198213, 5361.892762144813, 5376.112941364631, 5381.811636592701, 5406.945930540644, 5485.670859748428, 5501.339839219319, 5511.889762204653, 5539.279893613965], "value": 4968.039639228626, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.118209428627, 348.0654442821026, 351.778379620839, 353.4292118229061, 358.2476798722682, 5431.565474762019, 5466.863328416792, 5493.340799104103, 5495.80764673236, 5499.175123731437, 5379.139337705968, 5391.973040134803, 5423.810166644168, 5456.7544460499275, 5479.698616576086, 3877.670398016172, 4082.3876418537307, 4224.408582798411, 4229.97885010576, 4231.265181275678, 4157.833686652531, 4227.0, 4240.257954857903, 4240.872773816791, 4243.639290660298, 4096.713230073896, 4232.391691157356, 4253.2131555662145, 4253.383259427381, 4257.595528424795, 4111.52717437494, 4230.598093181143, 4247.723897946624, 4251.787410629456, 4257.723247988902, 3753.635209817797, 3789.412641040643, 3789.7157713171346, 3799.6010418905894, 3803.7717736935874, 5193.63644544882, 5218.530332270076, 5219.5041471060185, 5238.397584277819, 5274.525292723673, 4922.621665933509, 4934.0, 4939.431965323998, 4940.90118197634, 4961.404631444214, 5453.590980676426, 5460.590455715837, 5654.9717251413895, 5665.603407761459, 5732.051102625086, 4068.5524592294823, 4141.503019637633, 4154.189932963073, 4175.352820312856, 4186.769727664977, 5808.680522571257, 5829.766809327622, 5836.941630583682, 5847.473727364558, 5887.6173048752125, 3956.802159891994, 4198.160367926427, 4200.537940826568, 4202.3696445533415, 4214.4099826024385, 4217.915641687149, 4221.873343799691, 4234.237837189336, 4235.618794308527, 4255.5744425557195, 4851.199552073939, 4856.708597484162, 4874.4150701916, 4885.706857588556, 4900.387451568554, 5537.363203231599, 5704.771809127588, 5728.1407788831175, 5731.197632331477, 5745.597808153389, 1446.1539999100435, 1452.961132790039, 1464.4654701034046, 1472.8821694264648, 1476.8849518613592, 888.5424006636588, 906.931980101495, 922.686286662538, 929.6235024814961, 931.3015238571072, 4846.224604063333, 4914.754262286943, 4933.87665308363, 4963.404391473046, 4963.875903102379, 5173.430922598511, 5178.559822415137, 5186.377634683787, 5205.427402985669, 5207.385710429779, 4761.6904901181315, 4930.457649658535, 4961.231009193581, 4978.726170060681, 5001.724905130252, 2744.931376715598, 2756.572731226663, 2779.5691667791525, 2799.80401371902, 2809.9859500702364, 5318.22885681574, 5418.566514678895, 5457.508824205841, 5502.504774570308, 5519.157633818587, 5110.054639891632, 5184.429712731597, 5211.348581427322, 5318.0, 5320.654157479751, 5390.703511306916, 5770.509506691894, 5930.8813823723285, 6067.302260240041, 6073.089036644538, 5829.883402332014, 5831.446012628793, 5835.7373918174635, 5836.0, 5852.092925596539, 5561.555075593862, 5764.07774756037, 5786.4213578643485, 5800.796972105956, 5804.854878628068, 5966.49284810796, 6072.570971611391, 6073.897925742398, 6097.237845269341, 6119.0, 4135.627793498599, 4159.604837540429, 4184.393262976912, 4192.4759405074365, 4252.363534608562, 5513.862153446196, 5863.325717542367, 5869.00226961409, 5883.79382226634, 5884.764199517978, 5721.485066344049, 5727.0, 5728.770849165987, 5744.310682717934, 5744.396838332083, 5564.638298510584, 5697.202391665253, 5698.971505142447, 5711.8857622848145, 5741.698523349008, 5582.33012038558, 5586.245856809279, 5614.69119198448, 5617.8033768817895, 5618.438156184512, 5710.714464276853, 5738.655680659173, 5746.391010517062, 5748.568857335633, 5772.884542309046, 5459.716966512946, 5602.4957753802355, 5617.943820561905, 5636.2954630671165, 5652.2086907833755], "value": 4264.465858022618, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [845.5434065604572, 845.7040035987405, 873.2315562305171, 893.6782758207048, 903.3225081189104, 14968.925155374234, 16824.07467589282, 17247.82752172478, 17292.13539323035, 17331.91334043331, 15797.842021579781, 16164.515064548053, 16197.514074577752, 16215.83784162158, 16236.594085147877, 737.1964558631091, 856.3320609924269, 872.7250915961467, 889.2574700125404, 890.7862113092843, 883.2492381475759, 886.4193952960821, 892.6384814150247, 892.7009451833643, 893.2541327991136, 926.5221970956314, 932.1983094538691, 932.8460803967371, 933.2673851026946, 933.7945651956559, 766.4481573267238, 907.3920473282916, 928.0672923711694, 928.2620316848088, 929.3123088914223, 683.6445048574762, 683.7914436096988, 683.931606839312, 684.1243208692881, 684.3088480634545, 15705.371785128582, 15721.685566288725, 15768.526944191693, 15772.132532710697, 15783.842161578466, 14441.855581444157, 15179.392824287015, 15242.542723718307, 15418.768718469231, 15613.68772624541, 13771.793423098661, 13808.0, 13867.306634668226, 13998.230097344642, 14033.649158771112, 4611.538846115395, 4655.324977878188, 4675.275332323496, 4708.293755936603, 4814.06125805468, 76918.0, 78550.60724696398, 78912.0, 79647.0, 79767.0, 12132.818007729891, 12144.574939877062, 12247.142700010914, 12288.569900053455, 12532.310722910328, 22035.118595256332, 22085.668714969288, 22088.226912058002, 22090.11639534433, 22139.33581992543, 7883.802904927308, 8008.27925486709, 8035.276825085771, 8232.8353432931, 8364.0, 4820.3492528508905, 4932.540692712016, 4948.628852836052, 4954.504549545089, 5011.523905228997, 3616.0, 3728.3102626014274, 3753.3806921857586, 3763.6989040876665, 3765.4540091686554, 577.206341280739, 654.7773756922669, 663.2074670768385, 664.1731044849193, 676.0535250649033, 737.9188289288174, 775.8836174573859, 782.1708988472237, 802.6107337941094, 823.9670413183405, 9864.556094975744, 10005.44970026641, 10186.337888037255, 10238.18094552434, 10327.277090603586, 753.0711493276409, 778.7663700889824, 788.2826627768703, 791.1850793682516, 801.3989507869098, 4714.858554243378, 4784.928226076611, 5054.444011158769, 5194.027765999333, 5490.368607610096, 121244.0, 123308.38345808393, 125118.0, 137432.31283843517, 142760.28619857042, 107895.0, 109029.45485272682, 110423.44788276168, 111026.44486777515, 112176.0, 96281.0, 97699.0, 98647.0, 99159.50420247996, 100620.45967012121, 9815.938662870329, 9857.689684866571, 9877.703668889944, 9891.802163956825, 10132.696019119438, 41596.792016039726, 44665.0, 56444.15333770079, 57141.142882857624, 57153.0, 79965.0, 82784.0, 82966.0, 83154.16845831464, 83298.5835070845, 14382.0, 14731.263436827901, 15251.771223431879, 15352.539423817303, 15499.457518986781, 15088.622784430478, 15177.544673659808, 15343.693126137638, 15998.680026399174, 16822.66354672924, 12982.545610903573, 13508.459661613426, 14001.22993235382, 14759.631009224855, 15049.54851354461, 13508.0, 14136.08115472491, 14590.051646642934, 14662.0, 14850.331735072165, 13804.861951380759, 13838.16970981704, 13963.860361396257, 14027.228502432465, 14923.0, 10537.789244215226, 10864.402457864893, 10884.346939183675, 10956.123510119012, 11049.116070714485, 11596.420178991186, 11738.41307934617, 11785.0, 11838.526458941546, 11981.580644677395], "value": 8106.530486626514, "unit": "score"}], "name": "dromaeo_css", "value": 7534.865891278377, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 103.0, 109.0, 110.0, 110.0, 111.0, 111.0, 112.0, 110.0, 110.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 131.0, 124.0, 172.0, 128.0, 126.0, 154.0, 130.0, 162.0, 133.0], "value": 140.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 161.0, 161.0, 161.0, 161.0, 163.0, 161.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 124.0, 74.0, 76.0, 74.0, 75.0, 98.0, 74.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 111.0, 84.0, 85.0, 85.0, 114.0, 84.0, 84.0, 133.0], "value": 94.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 53.0, 52.0, 51.0, 54.0, 52.0, 52.0, 53.0, 52.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 60.0, 60.0, 60.0, 61.0, 62.0, 61.0, 63.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 81.0, 76.0, 75.0, 77.0, 85.0, 83.0, 110.0, 82.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 120.0, 117.0, 125.0, 120.0, 118.0, 118.0, 119.0, 140.0, 129.0], "value": 123.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 156.0, 156.0, 159.0, 159.0, 157.0, 157.0, 157.0, 156.0, 153.0], "value": 156.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 63.0, 61.0, 65.0, 61.0, 65.0, 60.0, 59.0, 60.0], "value": 61.8, "unit": "score"}], "name": "kraken", "value": 1482.3999999999999, "alertThreshold": 2.0}]} 13:14:16 INFO - Return code: 0 13:14:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:14:16 ERROR - # TBPL SUCCESS # 13:14:16 INFO - Running post-action listener: _resource_record_post_action 13:14:16 INFO - ##### 13:14:16 INFO - ##### Finished run-tests step (success) 13:14:16 INFO - ##### 13:14:16 INFO - Running post-run listener: _resource_record_post_run 13:14:16 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 28672; Write bytes: 287920128; Read time: 16; Write time: 196428 13:14:16 INFO - TinderboxPrint: CPU usage
13.1% 13:14:16 INFO - TinderboxPrint: I/O read bytes / time
28,672 / 16 13:14:16 INFO - TinderboxPrint: I/O write bytes / time
287,920,128 / 196,428 13:14:16 INFO - TinderboxPrint: CPU idle
8,235.4 (86.9%) 13:14:16 INFO - TinderboxPrint: CPU user
1,197.8 (12.6%) 13:14:16 INFO - TinderboxPrint: Swap in / out
0 / 0 13:14:16 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 70275072; Read time: 0; Write time: 47660 13:14:16 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 217030656; Read time: 8; Write time: 148768 13:14:17 INFO - Running post-run listener: _upload_blobber_files 13:14:17 INFO - Blob upload gear active. 13:14:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:14: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 13:14: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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:14: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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:14:17 INFO - (blobuploader) - INFO - Open directory for files ... 13:14:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:14:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:14:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:14:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:14:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:14:18 INFO - (blobuploader) - INFO - Done attempting. 13:14:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:14:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:14:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:14:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:14:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:14:23 INFO - (blobuploader) - INFO - Done attempting. 13:14:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:14:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:14:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:14:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:14:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:14:24 INFO - (blobuploader) - INFO - Done attempting. 13:14:24 INFO - (blobuploader) - INFO - Iteration through files over. 13:14:24 INFO - Return code: 0 13:14:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:14:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:14:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c48d2c04b5f7436d4e67d8d7a51700015380593e9df0050ccd089833af101c95c203a6182d80d69aa05d793adef034e37427afac3151eccc5e298ec9ae1ea26e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/925bb5808091b5c60c2755b9e0d92108d0d70983513979ac53782b9fd933bdfcb221cc1ee250599a74b98fd3e27fabcd097e359dfdab532e2429128936c17e8d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a247024da31a6d118f09aca99f1720b38f37020772a689cdd0c7c2d5fdcfc6ad85f2ffa26c451f411032ce69e868ba25137e434a6b91493f933bfcc49c85eb40"} 13:14:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:14:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:14:24 INFO - Contents: 13:14:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c48d2c04b5f7436d4e67d8d7a51700015380593e9df0050ccd089833af101c95c203a6182d80d69aa05d793adef034e37427afac3151eccc5e298ec9ae1ea26e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/925bb5808091b5c60c2755b9e0d92108d0d70983513979ac53782b9fd933bdfcb221cc1ee250599a74b98fd3e27fabcd097e359dfdab532e2429128936c17e8d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a247024da31a6d118f09aca99f1720b38f37020772a689cdd0c7c2d5fdcfc6ad85f2ffa26c451f411032ce69e868ba25137e434a6b91493f933bfcc49c85eb40"} 13:14:24 INFO - Running post-run listener: copy_logs_to_upload_dir 13:14:24 INFO - Copying logs to upload dir... 13:14:24 INFO - mkdir: /builds/slave/test/build/upload/logs 13:14:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1679.075217 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 59 secs) (at 2016-08-16 13:14:24.776330) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 13:14:24.781689) ========= 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=31acecf42b6a79ec49471d4a000001bb-1471375254.705344-598605893 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c48d2c04b5f7436d4e67d8d7a51700015380593e9df0050ccd089833af101c95c203a6182d80d69aa05d793adef034e37427afac3151eccc5e298ec9ae1ea26e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/925bb5808091b5c60c2755b9e0d92108d0d70983513979ac53782b9fd933bdfcb221cc1ee250599a74b98fd3e27fabcd097e359dfdab532e2429128936c17e8d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a247024da31a6d118f09aca99f1720b38f37020772a689cdd0c7c2d5fdcfc6ad85f2ffa26c451f411032ce69e868ba25137e434a6b91493f933bfcc49c85eb40"} build_url:https://queue.taskcluster.net/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011349 build_url: 'https://queue.taskcluster.net/v1/task/NS2HmPlUR9eTo5wbLdijew/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c48d2c04b5f7436d4e67d8d7a51700015380593e9df0050ccd089833af101c95c203a6182d80d69aa05d793adef034e37427afac3151eccc5e298ec9ae1ea26e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/925bb5808091b5c60c2755b9e0d92108d0d70983513979ac53782b9fd933bdfcb221cc1ee250599a74b98fd3e27fabcd097e359dfdab532e2429128936c17e8d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a247024da31a6d118f09aca99f1720b38f37020772a689cdd0c7c2d5fdcfc6ad85f2ffa26c451f411032ce69e868ba25137e434a6b91493f933bfcc49c85eb40"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 13:14:24.812034) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 13:14:24.812800) ========= 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=31acecf42b6a79ec49471d4a000001bb-1471375254.705344-598605893 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 13:14:24.895115) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 13:14:24.895801) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 13:14:24.896484) ========= ========= Total master_lag: 0.20 =========