builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-010 starttime: 1457332624.3 results: success (0) buildid: 20160306214810 builduid: efcd936d7ceb448da377a3f2d67dc3c4 revision: fd095cbb65ad0d4e20c10f7a1c1c3e7dcf3abdab ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-06 22:37:04.305530) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-06 22:37:04.306594) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-06 22:37:04.307323) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=eca2ab57546de7b41f256b19000001ef-1457329280.958662-1898847378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006537 basedir: '/builds/slave/test' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-06 22:37:04.379898) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-06 22:37:04.380232) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-06 22:37:04.511133) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 22:37:04.511526) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=eca2ab57546de7b41f256b19000001ef-1457329280.958662-1898847378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004599 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 22:37:04.586258) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-06 22:37:04.586564) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-06 22:37:04.586968) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 22:37:04.587302) ========= 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=eca2ab57546de7b41f256b19000001ef-1457329280.958662-1898847378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-06 22:37:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 87.5M=0s 2016-03-06 22:37:05 (87.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.172628 ========= master_lag: 0.75 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 22:37:05.505204) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 22:37:05.505561) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=eca2ab57546de7b41f256b19000001ef-1457329280.958662-1898847378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013990 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 22:37:05.567228) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-06 22:37:05.567647) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fd095cbb65ad0d4e20c10f7a1c1c3e7dcf3abdab --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev fd095cbb65ad0d4e20c10f7a1c1c3e7dcf3abdab --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=eca2ab57546de7b41f256b19000001ef-1457329280.958662-1898847378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-06 22:37:06,320 truncating revision to first 12 chars 2016-03-06 22:37:06,320 Setting DEBUG logging. 2016-03-06 22:37:06,320 attempt 1/10 2016-03-06 22:37:06,320 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fd095cbb65ad?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-06 22:37:07,494 unpacking tar archive at: fx-team-fd095cbb65ad/testing/mozharness/ program finished with exit code 0 elapsedTime=1.478603 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-06 22:37:07.127292) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-06 22:37:07.127654) ========= echo fd095cbb65ad0d4e20c10f7a1c1c3e7dcf3abdab in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'fd095cbb65ad0d4e20c10f7a1c1c3e7dcf3abdab'] 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=eca2ab57546de7b41f256b19000001ef-1457329280.958662-1898847378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False fd095cbb65ad0d4e20c10f7a1c1c3e7dcf3abdab program finished with exit code 0 elapsedTime=0.004650 script_repo_revision: 'fd095cbb65ad0d4e20c10f7a1c1c3e7dcf3abdab' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-06 22:37:07.186790) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-06 22:37:07.187145) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-06 22:37:07.204756) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-03-06 22:37:07.205381) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=eca2ab57546de7b41f256b19000001ef-1457329280.958662-1898847378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:37:07 INFO - MultiFileLogger online at 20160306 22:37:07 in /builds/slave/test 22:37:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 22:37:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:37:07 INFO - {'append_to_log': False, 22:37:07 INFO - 'base_work_dir': '/builds/slave/test', 22:37:07 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:37:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:37:07 INFO - 'branch': 'Fx-Team-Non-PGO', 22:37:07 INFO - 'buildbot_json_path': 'buildprops.json', 22:37:07 INFO - 'config_files': ('talos/linux_config.py',), 22:37:07 INFO - 'default_actions': ('clobber', 22:37:07 INFO - 'read-buildbot-config', 22:37:07 INFO - 'download-and-extract', 22:37:07 INFO - 'populate-webroot', 22:37:07 INFO - 'create-virtualenv', 22:37:07 INFO - 'install', 22:37:07 INFO - 'run-tests'), 22:37:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:37:08 INFO - 'download_minidump_stackwalk': True, 22:37:08 INFO - 'download_symbols': 'ondemand', 22:37:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:37:08 INFO - 'tooltool.py': '/tools/tooltool.py', 22:37:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:37:08 INFO - '/tools/misc-python/virtualenv.py')}, 22:37:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:37:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:37:08 INFO - 'installer_path': 'installer.exe', 22:37:08 INFO - 'log_level': 'info', 22:37:08 INFO - 'log_name': 'talos', 22:37:08 INFO - 'log_to_console': True, 22:37:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:37:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:37:08 INFO - 'opt_config_files': (), 22:37:08 INFO - 'pip_index': False, 22:37:08 INFO - 'sps_profile': False, 22:37:08 INFO - 'sps_profile_interval': 0, 22:37:08 INFO - 'suite': 'dromaeojs', 22:37:08 INFO - 'system_bits': '32', 22:37:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:37:08 INFO - 'title': 'talos-linux64-ix-010', 22:37:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:37:08 INFO - 'use_talos_json': True, 22:37:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:37:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:37:08 INFO - 'work_dir': 'build'} 22:37:08 INFO - ##### 22:37:08 INFO - ##### Running clobber step. 22:37:08 INFO - ##### 22:37:08 INFO - Running pre-action listener: _resource_record_pre_action 22:37:08 INFO - Running main action method: clobber 22:37:08 INFO - rmtree: /builds/slave/test/build 22:37:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:37:08 INFO - Running post-action listener: _resource_record_post_action 22:37:08 INFO - ##### 22:37:08 INFO - ##### Running read-buildbot-config step. 22:37:08 INFO - ##### 22:37:08 INFO - Running pre-action listener: _resource_record_pre_action 22:37:08 INFO - Running main action method: read_buildbot_config 22:37:08 INFO - Using buildbot properties: 22:37:08 INFO - { 22:37:08 INFO - "project": "", 22:37:08 INFO - "product": "firefox", 22:37:08 INFO - "script_repo_revision": "production", 22:37:08 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:37:08 INFO - "repository": "", 22:37:08 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 22:37:08 INFO - "buildid": "20160306214810", 22:37:08 INFO - "pgo_build": "False", 22:37:08 INFO - "basedir": "/builds/slave/test", 22:37:08 INFO - "buildnumber": 1510, 22:37:08 INFO - "slavename": "talos-linux64-ix-010", 22:37:08 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:37:08 INFO - "platform": "ubuntu64_hw", 22:37:08 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:37:08 INFO - "branch": "fx-team", 22:37:08 INFO - "repo_path": "integration/fx-team", 22:37:08 INFO - "revision": "fd095cbb65ad0d4e20c10f7a1c1c3e7dcf3abdab", 22:37:08 INFO - "stage_platform": "linux64", 22:37:08 INFO - "builduid": "efcd936d7ceb448da377a3f2d67dc3c4", 22:37:08 INFO - "slavebuilddir": "test" 22:37:08 INFO - } 22:37:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/K--FhUhsTCmoemtg8APFhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 22:37:08 INFO - Running post-action listener: _resource_record_post_action 22:37:08 INFO - ##### 22:37:08 INFO - ##### Running download-and-extract step. 22:37:08 INFO - ##### 22:37:08 INFO - Running pre-action listener: _resource_record_pre_action 22:37:08 INFO - Running main action method: download_and_extract 22:37:08 INFO - mkdir: /builds/slave/test/build/tests 22:37:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:37:08 INFO - https://queue.taskcluster.net/v1/task/K--FhUhsTCmoemtg8APFhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:37:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K--FhUhsTCmoemtg8APFhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 22:37:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K--FhUhsTCmoemtg8APFhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 22:37:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K--FhUhsTCmoemtg8APFhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 22:37:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K--FhUhsTCmoemtg8APFhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:37:13 INFO - Downloaded 1448 bytes. 22:37:13 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 22:37:13 INFO - Using the following test package requirements: 22:37:13 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:37:13 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:37:13 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:37:13 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:37:13 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:37:13 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:37:13 INFO - u'jsshell-linux-x86_64.zip'], 22:37:13 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:37:13 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:37:13 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:37:13 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:37:13 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:37:13 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:37:13 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:37:13 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:37:13 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:37:13 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:37:13 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:37:13 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:37:13 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:37:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:37:13 INFO - https://queue.taskcluster.net/v1/task/K--FhUhsTCmoemtg8APFhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:37:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K--FhUhsTCmoemtg8APFhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:37:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K--FhUhsTCmoemtg8APFhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:37:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K--FhUhsTCmoemtg8APFhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:37:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K--FhUhsTCmoemtg8APFhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:37:14 INFO - Downloaded 22091821 bytes. 22:37:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:37:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:37:15 INFO - Return code: 0 22:37:15 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:37: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')]} 22:37:15 INFO - https://queue.taskcluster.net/v1/task/K--FhUhsTCmoemtg8APFhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:37:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K--FhUhsTCmoemtg8APFhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:37:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K--FhUhsTCmoemtg8APFhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:37:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K--FhUhsTCmoemtg8APFhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:37:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K--FhUhsTCmoemtg8APFhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:37:28 INFO - Downloaded 22091821 bytes. 22:37:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:37:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:37:29 INFO - Return code: 0 22:37: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')]} 22:37:29 INFO - https://queue.taskcluster.net/v1/task/K--FhUhsTCmoemtg8APFhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:37:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K--FhUhsTCmoemtg8APFhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:37:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K--FhUhsTCmoemtg8APFhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:37:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K--FhUhsTCmoemtg8APFhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:37:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K--FhUhsTCmoemtg8APFhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:37:30 INFO - Downloaded 10845161 bytes. 22:37:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:37:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:37:31 INFO - Return code: 0 22:37:31 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')]} 22:37:31 INFO - https://queue.taskcluster.net/v1/task/K--FhUhsTCmoemtg8APFhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:37:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K--FhUhsTCmoemtg8APFhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:37:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K--FhUhsTCmoemtg8APFhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:37:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K--FhUhsTCmoemtg8APFhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:37:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K--FhUhsTCmoemtg8APFhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:37:32 INFO - Downloaded 54410756 bytes. 22:37:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K--FhUhsTCmoemtg8APFhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:37:32 INFO - mkdir: /builds/slave/test/properties 22:37:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:37:32 INFO - Writing to file /builds/slave/test/properties/build_url 22:37:32 INFO - Contents: 22:37:32 INFO - build_url:https://queue.taskcluster.net/v1/task/K--FhUhsTCmoemtg8APFhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:37:33 INFO - Running post-action listener: _resource_record_post_action 22:37:33 INFO - Running post-action listener: set_extra_try_arguments 22:37:33 INFO - ##### 22:37:33 INFO - ##### Running populate-webroot step. 22:37:33 INFO - ##### 22:37:33 INFO - Running pre-action listener: _resource_record_pre_action 22:37:33 INFO - Running main action method: populate_webroot 22:37:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:37:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:37:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:37:33 INFO - '--tppagecycles', 22:37:33 INFO - '7'], 22:37:33 INFO - 'tests': ['tsvgm']}}, 22:37:33 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:37:33 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:37:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:37:33 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:37:33 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:37:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:37:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:37:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:37:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:37:33 INFO - 'talos_options': ['--e10s'], 22:37:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:37:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:37:33 INFO - 'tests': ['damp', 'tps']}, 22:37:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:37:33 INFO - 'talos_options': ['--e10s'], 22:37:33 INFO - 'tests': ['damp', 'tps']}, 22:37:33 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:37:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:37:33 INFO - 'other': {'tests': ['a11yr', 22:37:33 INFO - 'ts_paint', 22:37:33 INFO - 'tpaint', 22:37:33 INFO - 'sessionrestore', 22:37:33 INFO - 'sessionrestore_no_auto_restore', 22:37:33 INFO - 'tabpaint']}, 22:37:33 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:37:33 INFO - 'tests': ['a11yr', 22:37:33 INFO - 'ts_paint', 22:37:33 INFO - 'tpaint', 22:37:33 INFO - 'sessionrestore', 22:37:33 INFO - 'sessionrestore_no_auto_restore', 22:37:33 INFO - 'tabpaint']}, 22:37:33 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:37:33 INFO - 'tests': ['a11yr', 22:37:33 INFO - 'ts_paint', 22:37:33 INFO - 'tpaint', 22:37:33 INFO - 'sessionrestore', 22:37:33 INFO - 'sessionrestore_no_auto_restore', 22:37:33 INFO - 'tabpaint']}, 22:37:33 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:37:33 INFO - 'tests': ['a11yr', 22:37:33 INFO - 'ts_paint', 22:37:33 INFO - 'tpaint', 22:37:33 INFO - 'sessionrestore', 22:37:33 INFO - 'sessionrestore_no_auto_restore', 22:37:33 INFO - 'tabpaint']}, 22:37:33 INFO - 'other_l64': {'tests': ['a11yr', 22:37:33 INFO - 'ts_paint', 22:37:33 INFO - 'tpaint', 22:37:33 INFO - 'sessionrestore', 22:37:33 INFO - 'sessionrestore_no_auto_restore', 22:37:33 INFO - 'tabpaint']}, 22:37:33 INFO - 'other_nol64': {'tests': ['a11yr', 22:37:33 INFO - 'ts_paint', 22:37:33 INFO - 'tpaint', 22:37:33 INFO - 'sessionrestore', 22:37:33 INFO - 'sessionrestore_no_auto_restore', 22:37:33 INFO - 'tabpaint']}, 22:37:33 INFO - 'svgr': {'tests': ['tsvgx', 22:37:33 INFO - 'tsvgr_opacity', 22:37:33 INFO - 'tart', 22:37:33 INFO - 'tscrollx', 22:37:33 INFO - 'cart']}, 22:37:33 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:37:33 INFO - 'tests': ['tsvgx', 22:37:33 INFO - 'tsvgr_opacity', 22:37:33 INFO - 'tart', 22:37:33 INFO - 'tscrollx', 22:37:33 INFO - 'cart']}, 22:37:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:37:33 INFO - 'tests': ['tp5o']}, 22:37:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:37:33 INFO - 'talos_options': ['--e10s'], 22:37:33 INFO - 'tests': ['tp5o']}, 22:37:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:37:33 INFO - 'talos_options': ['--xperf_path', 22:37:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:37:33 INFO - 'tests': ['tp5n']}, 22:37:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:37:33 INFO - 'talos_options': ['--e10s', 22:37:33 INFO - '--xperf_path', 22:37:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:37:33 INFO - 'tests': ['tp5n']}}, 22:37:33 INFO - 'talos.zip': {'path': '', 22:37:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:37:33 INFO - Running post-action listener: _resource_record_post_action 22:37:33 INFO - ##### 22:37:33 INFO - ##### Running create-virtualenv step. 22:37:33 INFO - ##### 22:37:33 INFO - Running pre-action listener: _resource_record_pre_action 22:37:33 INFO - Running main action method: create_virtualenv 22:37:33 INFO - Creating virtualenv /builds/slave/test/build/venv 22:37:33 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 22:37:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:37:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:37:33 INFO - Using real prefix '/usr' 22:37:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:37:33 INFO - Installing distribute.............................................................................................................................................................................................done. 22:37:35 INFO - Installing pip.................done. 22:37:35 INFO - Return code: 0 22:37:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:37:35 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')]} 22:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:35 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')]} 22:37:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:35 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 0x7f9eb914df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d9160>, '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 0x22da060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22da4f0>, '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': 'eca2ab57546de7b41f256b19000001ef-1457329280.958662-1898847378', '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 22:37:35 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 22:37:35 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 22:37:35 INFO - Using env: {'DISPLAY': ':0', 22:37:35 INFO - 'HOME': '/home/cltbld', 22:37:35 INFO - 'LANG': 'en_US.UTF-8', 22:37:35 INFO - 'LANGUAGE': 'en_US:en', 22:37:35 INFO - 'LOGNAME': 'cltbld', 22:37:35 INFO - 'MAIL': '/var/mail/cltbld', 22:37:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:35 INFO - 'MOZ_NO_REMOTE': '1', 22:37:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:37:35 INFO - 'NO_EM_RESTART': '1', 22:37:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:37:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:35 INFO - 'PWD': '/builds/slave/test', 22:37:35 INFO - 'SHELL': '/bin/bash', 22:37:35 INFO - 'SHLVL': '1', 22:37:35 INFO - 'TERM': 'linux', 22:37:35 INFO - 'TMOUT': '86400', 22:37:35 INFO - 'USER': 'cltbld', 22:37:35 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1457329280.958662-1898847378', 22:37:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:35 INFO - '_': '/tools/buildbot/bin/python'} 22:37:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:37:36 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 22:37:36 INFO - Cleaning up... 22:37:36 INFO - Return code: 0 22:37:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:37:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9eb914df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d9160>, '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 0x22da060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22da4f0>, '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': 'eca2ab57546de7b41f256b19000001ef-1457329280.958662-1898847378', '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 22:37:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 22:37:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:37:36 INFO - Using env: {'DISPLAY': ':0', 22:37:36 INFO - 'HOME': '/home/cltbld', 22:37:36 INFO - 'LANG': 'en_US.UTF-8', 22:37:36 INFO - 'LANGUAGE': 'en_US:en', 22:37:36 INFO - 'LOGNAME': 'cltbld', 22:37:36 INFO - 'MAIL': '/var/mail/cltbld', 22:37:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:36 INFO - 'MOZ_NO_REMOTE': '1', 22:37:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:37:36 INFO - 'NO_EM_RESTART': '1', 22:37:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:37:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:36 INFO - 'PWD': '/builds/slave/test', 22:37:36 INFO - 'SHELL': '/bin/bash', 22:37:36 INFO - 'SHLVL': '1', 22:37:36 INFO - 'TERM': 'linux', 22:37:36 INFO - 'TMOUT': '86400', 22:37:36 INFO - 'USER': 'cltbld', 22:37:36 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1457329280.958662-1898847378', 22:37:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:36 INFO - '_': '/tools/buildbot/bin/python'} 22:37:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:37:36 INFO - Downloading/unpacking psutil>=0.7.1 22:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:37:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:37:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:37:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:37:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:37:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:37:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:37:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:37:38 INFO - Installing collected packages: psutil 22:37:38 INFO - Running setup.py install for psutil 22:37:38 INFO - building 'psutil._psutil_linux' extension 22:37:38 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 22:37:38 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 22:37:38 INFO - building 'psutil._psutil_posix' extension 22:37:38 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 22:37:38 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 22:37:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:37:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:37:38 INFO - Successfully installed psutil 22:37:38 INFO - Cleaning up... 22:37:38 INFO - Return code: 0 22:37:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:37:38 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')]} 22:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:38 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')]} 22:37:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:38 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9eb914df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d9160>, '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 0x22da060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22da4f0>, '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': 'eca2ab57546de7b41f256b19000001ef-1457329280.958662-1898847378', '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 22:37:38 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.0.0'] in /builds/slave/test/build 22:37:38 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.0.0 22:37:38 INFO - Using env: {'DISPLAY': ':0', 22:37:38 INFO - 'HOME': '/home/cltbld', 22:37:38 INFO - 'LANG': 'en_US.UTF-8', 22:37:38 INFO - 'LANGUAGE': 'en_US:en', 22:37:38 INFO - 'LOGNAME': 'cltbld', 22:37:38 INFO - 'MAIL': '/var/mail/cltbld', 22:37:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:38 INFO - 'MOZ_NO_REMOTE': '1', 22:37:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:37:38 INFO - 'NO_EM_RESTART': '1', 22:37:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:37:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:38 INFO - 'PWD': '/builds/slave/test', 22:37:38 INFO - 'SHELL': '/bin/bash', 22:37:38 INFO - 'SHLVL': '1', 22:37:38 INFO - 'TERM': 'linux', 22:37:38 INFO - 'TMOUT': '86400', 22:37:38 INFO - 'USER': 'cltbld', 22:37:38 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1457329280.958662-1898847378', 22:37:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:38 INFO - '_': '/tools/buildbot/bin/python'} 22:37:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:37:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:37:38 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 22:37:38 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 22:37:38 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 22:37:38 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 22:37:38 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 22:37:38 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 22:37:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:37:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:37:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:37:40 INFO - Installing collected packages: mozsystemmonitor 22:37:40 INFO - Running setup.py install for mozsystemmonitor 22:37:40 INFO - Successfully installed mozsystemmonitor 22:37:40 INFO - Cleaning up... 22:37:40 INFO - Return code: 0 22:37:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:37:40 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')]} 22:37:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:40 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')]} 22:37:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:40 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 0x7f9eb914df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d9160>, '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 0x22da060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22da4f0>, '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': 'eca2ab57546de7b41f256b19000001ef-1457329280.958662-1898847378', '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 22:37:40 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 22:37:40 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 22:37:40 INFO - Using env: {'DISPLAY': ':0', 22:37:40 INFO - 'HOME': '/home/cltbld', 22:37:40 INFO - 'LANG': 'en_US.UTF-8', 22:37:40 INFO - 'LANGUAGE': 'en_US:en', 22:37:40 INFO - 'LOGNAME': 'cltbld', 22:37:40 INFO - 'MAIL': '/var/mail/cltbld', 22:37:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:40 INFO - 'MOZ_NO_REMOTE': '1', 22:37:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:37:40 INFO - 'NO_EM_RESTART': '1', 22:37:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:37:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:40 INFO - 'PWD': '/builds/slave/test', 22:37:40 INFO - 'SHELL': '/bin/bash', 22:37:40 INFO - 'SHLVL': '1', 22:37:40 INFO - 'TERM': 'linux', 22:37:40 INFO - 'TMOUT': '86400', 22:37:40 INFO - 'USER': 'cltbld', 22:37:40 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1457329280.958662-1898847378', 22:37:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:40 INFO - '_': '/tools/buildbot/bin/python'} 22:37:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:37:41 INFO - Downloading/unpacking blobuploader==1.2.4 22:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:37:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:37:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:37:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:37:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:37:42 INFO - Downloading blobuploader-1.2.4.tar.gz 22:37:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:37:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:37:43 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 22:37:43 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 22:37:43 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 22:37:43 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 22:37:43 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 22:37:43 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 22:37:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:37:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:37:43 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 22:37:43 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 22:37:43 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 22:37:43 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 22:37:43 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 22:37:43 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 22:37:43 INFO - Downloading docopt-0.6.1.tar.gz 22:37:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:37:43 INFO - Installing collected packages: blobuploader, requests, docopt 22:37:43 INFO - Running setup.py install for blobuploader 22:37:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:37:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:37:44 INFO - Running setup.py install for requests 22:37:44 INFO - Running setup.py install for docopt 22:37:44 INFO - Successfully installed blobuploader requests docopt 22:37:44 INFO - Cleaning up... 22:37:44 INFO - Return code: 0 22:37:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:37:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:37:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:37:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:44 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 0x7f9eb914df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d9160>, '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 0x22da060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22da4f0>, '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': 'eca2ab57546de7b41f256b19000001ef-1457329280.958662-1898847378', '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 22:37:44 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 22:37:44 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 22:37:44 INFO - Using env: {'DISPLAY': ':0', 22:37:44 INFO - 'HOME': '/home/cltbld', 22:37:44 INFO - 'LANG': 'en_US.UTF-8', 22:37:44 INFO - 'LANGUAGE': 'en_US:en', 22:37:44 INFO - 'LOGNAME': 'cltbld', 22:37:44 INFO - 'MAIL': '/var/mail/cltbld', 22:37:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:44 INFO - 'MOZ_NO_REMOTE': '1', 22:37:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:37:44 INFO - 'NO_EM_RESTART': '1', 22:37:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:37:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:44 INFO - 'PWD': '/builds/slave/test', 22:37:44 INFO - 'SHELL': '/bin/bash', 22:37:44 INFO - 'SHLVL': '1', 22:37:44 INFO - 'TERM': 'linux', 22:37:44 INFO - 'TMOUT': '86400', 22:37:44 INFO - 'USER': 'cltbld', 22:37:44 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1457329280.958662-1898847378', 22:37:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:44 INFO - '_': '/tools/buildbot/bin/python'} 22:37:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:37:44 INFO - Running setup.py (path:/tmp/pip-G0XNYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:37:44 INFO - Running setup.py (path:/tmp/pip-8kViA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:37:44 INFO - Running setup.py (path:/tmp/pip-OaaJ6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:37:44 INFO - Running setup.py (path:/tmp/pip-8c3jpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:37:45 INFO - Running setup.py (path:/tmp/pip-conXlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:37:45 INFO - Running setup.py (path:/tmp/pip-9CHoHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:37:45 INFO - Running setup.py (path:/tmp/pip-Kzu8KC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:37:45 INFO - Running setup.py (path:/tmp/pip-QytzDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:37:45 INFO - Running setup.py (path:/tmp/pip-3F3zsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:37:45 INFO - Running setup.py (path:/tmp/pip-c2ElUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:37:45 INFO - Running setup.py (path:/tmp/pip-uwjIdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:37:45 INFO - Running setup.py (path:/tmp/pip-kvBVGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:37:45 INFO - Running setup.py (path:/tmp/pip-VdlxDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:37:45 INFO - Running setup.py (path:/tmp/pip-8ntCXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:37:45 INFO - Running setup.py (path:/tmp/pip-z0HlR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:37:45 INFO - Running setup.py (path:/tmp/pip-JACPE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:37:45 INFO - Running setup.py (path:/tmp/pip-uozdwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:37:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:37:45 INFO - Running setup.py install for manifestparser 22:37:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:37:46 INFO - Running setup.py install for mozcrash 22:37:46 INFO - Running setup.py install for mozdebug 22:37:46 INFO - Running setup.py install for mozdevice 22:37:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:37:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:37:46 INFO - Running setup.py install for mozfile 22:37:46 INFO - Running setup.py install for mozhttpd 22:37:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:37:46 INFO - Running setup.py install for mozinfo 22:37:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:37:46 INFO - Running setup.py install for mozInstall 22:37:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:37:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:37:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:37:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:37:46 INFO - Running setup.py install for mozleak 22:37:46 INFO - Running setup.py install for mozlog 22:37:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:37:46 INFO - Running setup.py install for moznetwork 22:37:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:37:47 INFO - Running setup.py install for mozprocess 22:37:47 INFO - Running setup.py install for mozprofile 22:37:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:37:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:37:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:37:47 INFO - Running setup.py install for mozrunner 22:37:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:37:47 INFO - Running setup.py install for mozscreenshot 22:37:47 INFO - Running setup.py install for moztest 22:37:47 INFO - Running setup.py install for mozversion 22:37:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:37:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:37:47 INFO - Cleaning up... 22:37:47 INFO - Return code: 0 22:37:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:37:47 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')]} 22:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:47 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')]} 22:37:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:47 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 0x7f9eb914df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d9160>, '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 0x22da060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22da4f0>, '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': 'eca2ab57546de7b41f256b19000001ef-1457329280.958662-1898847378', '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 22:37:47 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 22:37:47 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 22:37:47 INFO - Using env: {'DISPLAY': ':0', 22:37:47 INFO - 'HOME': '/home/cltbld', 22:37:47 INFO - 'LANG': 'en_US.UTF-8', 22:37:47 INFO - 'LANGUAGE': 'en_US:en', 22:37:47 INFO - 'LOGNAME': 'cltbld', 22:37:47 INFO - 'MAIL': '/var/mail/cltbld', 22:37:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:47 INFO - 'MOZ_NO_REMOTE': '1', 22:37:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:37:47 INFO - 'NO_EM_RESTART': '1', 22:37:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:37:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:47 INFO - 'PWD': '/builds/slave/test', 22:37:47 INFO - 'SHELL': '/bin/bash', 22:37:47 INFO - 'SHLVL': '1', 22:37:47 INFO - 'TERM': 'linux', 22:37:47 INFO - 'TMOUT': '86400', 22:37:47 INFO - 'USER': 'cltbld', 22:37:47 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1457329280.958662-1898847378', 22:37:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:47 INFO - '_': '/tools/buildbot/bin/python'} 22:37:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:37:47 INFO - Running setup.py (path:/tmp/pip-32HfLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:37:48 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 22:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:37:48 INFO - Running setup.py (path:/tmp/pip-pi7CLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:37:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:37:48 INFO - Running setup.py (path:/tmp/pip-6dCiyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:37:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:37:48 INFO - Running setup.py (path:/tmp/pip-sKvO9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:37:48 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)) 22:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:37:48 INFO - Running setup.py (path:/tmp/pip-32ibbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:37:48 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)) 22:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:37:48 INFO - Running setup.py (path:/tmp/pip-6hQ7Lb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:37:48 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)) 22:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:37:48 INFO - Running setup.py (path:/tmp/pip-EDJhMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:37:48 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)) 22:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:37:48 INFO - Running setup.py (path:/tmp/pip-JFziN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:37:48 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)) 22:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:37:48 INFO - Running setup.py (path:/tmp/pip-bDXn03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:37:48 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)) 22:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:37:48 INFO - Running setup.py (path:/tmp/pip-gcVefZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:37:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 22:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:37:48 INFO - Running setup.py (path:/tmp/pip-jXPgHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:37:48 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)) 22:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:37:48 INFO - Running setup.py (path:/tmp/pip-3vkjkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:37:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 22:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:37:48 INFO - Running setup.py (path:/tmp/pip-An28T3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:37:48 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)) 22:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:37:48 INFO - Running setup.py (path:/tmp/pip-rgObRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:37:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 22:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:37:48 INFO - Running setup.py (path:/tmp/pip-RnnLnS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:37:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 22:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:37:49 INFO - Running setup.py (path:/tmp/pip-585Jm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:37:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 22:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:37:49 INFO - Running setup.py (path:/tmp/pip-5wi0NT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:37:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 22:37:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:37:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:37:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:37:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:37:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:37:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:37:49 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 22:37:49 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 22:37:49 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 22:37:49 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 22:37:49 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 22:37:49 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 22:37:51 INFO - Downloading blessings-1.6.tar.gz 22:37:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:37:51 INFO - Installing collected packages: blessings 22:37:51 INFO - Running setup.py install for blessings 22:37:51 INFO - Successfully installed blessings 22:37:51 INFO - Cleaning up... 22:37:51 INFO - Return code: 0 22:37:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:37:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:37:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:37:51 INFO - Reading from file tmpfile_stdout 22:37:51 INFO - Current package versions: 22:37:51 INFO - argparse == 1.2.1 22:37:51 INFO - blessings == 1.6 22:37:51 INFO - blobuploader == 1.2.4 22:37:51 INFO - docopt == 0.6.1 22:37:51 INFO - manifestparser == 1.1 22:37:51 INFO - mozInstall == 1.12 22:37:51 INFO - mozcrash == 0.17 22:37:51 INFO - mozdebug == 0.1 22:37:51 INFO - mozdevice == 0.48 22:37:51 INFO - mozfile == 1.2 22:37:51 INFO - mozhttpd == 0.7 22:37:51 INFO - mozinfo == 0.9 22:37:51 INFO - mozleak == 0.1 22:37:51 INFO - mozlog == 3.1 22:37:51 INFO - moznetwork == 0.27 22:37:51 INFO - mozprocess == 0.22 22:37:51 INFO - mozprofile == 0.28 22:37:51 INFO - mozrunner == 6.11 22:37:51 INFO - mozscreenshot == 0.1 22:37:51 INFO - mozsystemmonitor == 0.0 22:37:51 INFO - moztest == 0.7 22:37:51 INFO - mozversion == 1.4 22:37:51 INFO - psutil == 3.1.1 22:37:51 INFO - requests == 1.2.3 22:37:51 INFO - wsgiref == 0.1.2 22:37:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:37:51 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')]} 22:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:51 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')]} 22:37:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:51 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 0x7f9eb914df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d9160>, '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 0x22da060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22da4f0>, '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': 'eca2ab57546de7b41f256b19000001ef-1457329280.958662-1898847378', '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 22:37:51 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 22:37:51 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 22:37:51 INFO - Using env: {'DISPLAY': ':0', 22:37:51 INFO - 'HOME': '/home/cltbld', 22:37:51 INFO - 'LANG': 'en_US.UTF-8', 22:37:51 INFO - 'LANGUAGE': 'en_US:en', 22:37:51 INFO - 'LOGNAME': 'cltbld', 22:37:51 INFO - 'MAIL': '/var/mail/cltbld', 22:37:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:51 INFO - 'MOZ_NO_REMOTE': '1', 22:37:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:37:51 INFO - 'NO_EM_RESTART': '1', 22:37:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:37:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:51 INFO - 'PWD': '/builds/slave/test', 22:37:51 INFO - 'SHELL': '/bin/bash', 22:37:51 INFO - 'SHLVL': '1', 22:37:51 INFO - 'TERM': 'linux', 22:37:51 INFO - 'TMOUT': '86400', 22:37:51 INFO - 'USER': 'cltbld', 22:37:51 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1457329280.958662-1898847378', 22:37:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:51 INFO - '_': '/tools/buildbot/bin/python'} 22:37:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:37:51 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)) 22:37:51 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)) 22:37:51 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)) 22:37:51 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)) 22:37:51 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)) 22:37:51 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)) 22:37:51 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)) 22:37:51 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)) 22:37:51 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)) 22:37:51 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)) 22:37:51 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)) 22:37:51 INFO - Cleaning up... 22:37:51 INFO - Return code: 0 22:37:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:37:51 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')]} 22:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:51 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')]} 22:37:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:51 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 0x7f9eb914df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d9160>, '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 0x22da060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22da4f0>, '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': 'eca2ab57546de7b41f256b19000001ef-1457329280.958662-1898847378', '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 22:37:51 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 22:37:51 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 22:37:51 INFO - Using env: {'DISPLAY': ':0', 22:37:51 INFO - 'HOME': '/home/cltbld', 22:37:51 INFO - 'LANG': 'en_US.UTF-8', 22:37:51 INFO - 'LANGUAGE': 'en_US:en', 22:37:51 INFO - 'LOGNAME': 'cltbld', 22:37:51 INFO - 'MAIL': '/var/mail/cltbld', 22:37:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:51 INFO - 'MOZ_NO_REMOTE': '1', 22:37:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:37:51 INFO - 'NO_EM_RESTART': '1', 22:37:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:37:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:51 INFO - 'PWD': '/builds/slave/test', 22:37:51 INFO - 'SHELL': '/bin/bash', 22:37:51 INFO - 'SHLVL': '1', 22:37:51 INFO - 'TERM': 'linux', 22:37:51 INFO - 'TMOUT': '86400', 22:37:51 INFO - 'USER': 'cltbld', 22:37:51 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1457329280.958662-1898847378', 22:37:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:51 INFO - '_': '/tools/buildbot/bin/python'} 22:37:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:37:51 INFO - Downloading/unpacking jsonschema 22:37:51 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 22:37:51 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 22:37:51 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 22:37:51 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 22:37:51 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 22:37:51 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 22:37:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:37:53 INFO - Downloading/unpacking functools32 (from jsonschema) 22:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:37:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:37:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:37:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:37:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:37:53 INFO - Downloading functools32-3.2.3-2.tar.gz 22:37:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:37:53 INFO - warning: no files found matching '*.txt' 22:37:53 INFO - no previously-included directories found matching 'build' 22:37:53 INFO - no previously-included directories found matching 'dist' 22:37:53 INFO - no previously-included directories found matching '.git*' 22:37:53 INFO - Installing collected packages: jsonschema, functools32 22:37:54 INFO - Running setup.py install for functools32 22:37:54 INFO - warning: no files found matching '*.txt' 22:37:54 INFO - no previously-included directories found matching 'build' 22:37:54 INFO - no previously-included directories found matching 'dist' 22:37:54 INFO - no previously-included directories found matching '.git*' 22:37:54 INFO - Successfully installed jsonschema functools32 22:37:54 INFO - Cleaning up... 22:37:54 INFO - Return code: 0 22:37:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:37:54 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')]} 22:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:54 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')]} 22:37:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:54 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 0x7f9eb914df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d9160>, '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 0x22da060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22da4f0>, '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': 'eca2ab57546de7b41f256b19000001ef-1457329280.958662-1898847378', '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 22:37:54 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 22:37:54 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 22:37:54 INFO - Using env: {'DISPLAY': ':0', 22:37:54 INFO - 'HOME': '/home/cltbld', 22:37:54 INFO - 'LANG': 'en_US.UTF-8', 22:37:54 INFO - 'LANGUAGE': 'en_US:en', 22:37:54 INFO - 'LOGNAME': 'cltbld', 22:37:54 INFO - 'MAIL': '/var/mail/cltbld', 22:37:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:54 INFO - 'MOZ_NO_REMOTE': '1', 22:37:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:37:54 INFO - 'NO_EM_RESTART': '1', 22:37:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:37:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:54 INFO - 'PWD': '/builds/slave/test', 22:37:54 INFO - 'SHELL': '/bin/bash', 22:37:54 INFO - 'SHLVL': '1', 22:37:54 INFO - 'TERM': 'linux', 22:37:54 INFO - 'TMOUT': '86400', 22:37:54 INFO - 'USER': 'cltbld', 22:37:54 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1457329280.958662-1898847378', 22:37:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:54 INFO - '_': '/tools/buildbot/bin/python'} 22:37:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:37:54 INFO - Downloading/unpacking flake8 22:37:54 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 22:37:54 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 22:37:54 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 22:37:54 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 22:37:54 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 22:37:54 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 22:37:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:37:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:37:56 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 22:37:56 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 22:37:56 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 22:37:56 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 22:37:56 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 22:37:56 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 22:37:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:37:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:37:56 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 22:37:56 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 22:37:56 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 22:37:56 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 22:37:56 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 22:37:56 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 22:37:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:37:56 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 22:37:56 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 22:37:56 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 22:37:56 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 22:37:56 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 22:37:56 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 22:37:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:37:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:37:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:37:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:37:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:37:56 INFO - no previously-included directories found matching 'docs/_build' 22:37:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:37:56 INFO - Running setup.py install for pep8 22:37:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:37:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:37:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:37:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:37:57 INFO - no previously-included directories found matching 'docs/_build' 22:37:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:37:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:37:57 INFO - Cleaning up... 22:37:57 INFO - Return code: 0 22:37:57 INFO - Running post-action listener: _resource_record_post_action 22:37:57 INFO - Running post-action listener: _start_resource_monitoring 22:37:57 INFO - Starting resource monitoring. 22:37:57 INFO - ##### 22:37:57 INFO - ##### Running install step. 22:37:57 INFO - ##### 22:37:57 INFO - Running pre-action listener: _resource_record_pre_action 22:37:57 INFO - Running main action method: install 22:37:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:37:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:37:57 INFO - Reading from file tmpfile_stdout 22:37:57 INFO - Detecting whether we're running mozinstall >=1.0... 22:37:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:37:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:37:57 INFO - Reading from file tmpfile_stdout 22:37:57 INFO - Output received: 22:37:57 INFO - Usage: mozinstall [options] installer 22:37:57 INFO - Options: 22:37:57 INFO - -h, --help show this help message and exit 22:37:57 INFO - -d DEST, --destination=DEST 22:37:57 INFO - Directory to install application into. [default: 22:37:57 INFO - "/builds/slave/test"] 22:37:57 INFO - --app=APP Application being installed. [default: firefox] 22:37:57 INFO - mkdir: /builds/slave/test/build/application 22:37:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:37:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:38:13 INFO - Reading from file tmpfile_stdout 22:38:13 INFO - Output received: 22:38:13 INFO - /builds/slave/test/build/application/firefox/firefox 22:38:13 INFO - Running post-action listener: _resource_record_post_action 22:38:13 INFO - ##### 22:38:13 INFO - ##### Running run-tests step. 22:38:13 INFO - ##### 22:38:13 INFO - Running pre-action listener: _resource_record_pre_action 22:38:13 INFO - Running main action method: run_tests 22:38:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:38:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:38:13 INFO - Python 2.7.3 22:38:13 INFO - Return code: 0 22:38:13 INFO - grabbing minidump binary from tooltool 22:38:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:38:13 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d9160>, '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 0x22da060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22da4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:38:13 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 22:38:13 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 22:38:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:38:13 INFO - Return code: 0 22:38:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:38:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:38:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:38:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:38:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:38:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:38:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:38:14 INFO - Return code: 0 22:38:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K--FhUhsTCmoemtg8APFhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 22:38:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/K--FhUhsTCmoemtg8APFhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 22:38:14 INFO - Using env: {'DISPLAY': ':0', 22:38:14 INFO - 'HOME': '/home/cltbld', 22:38:14 INFO - 'LANG': 'en_US.UTF-8', 22:38:14 INFO - 'LANGUAGE': 'en_US:en', 22:38:14 INFO - 'LOGNAME': 'cltbld', 22:38:14 INFO - 'MAIL': '/var/mail/cltbld', 22:38:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:38:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:38:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:38:14 INFO - 'MOZ_NO_REMOTE': '1', 22:38:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:38:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:38:14 INFO - 'NO_EM_RESTART': '1', 22:38:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:38:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:38:14 INFO - 'PWD': '/builds/slave/test', 22:38:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:38:14 INFO - 'SHELL': '/bin/bash', 22:38:14 INFO - 'SHLVL': '1', 22:38:14 INFO - 'TERM': 'linux', 22:38:14 INFO - 'TMOUT': '86400', 22:38:14 INFO - 'USER': 'cltbld', 22:38:14 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1457329280.958662-1898847378', 22:38:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:38:14 INFO - '_': '/tools/buildbot/bin/python'} 22:38:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K--FhUhsTCmoemtg8APFhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 22:38:14 INFO - mozversion application_buildid: 20160306214810 22:38:14 INFO - mozversion application_changeset: fd095cbb65ad0d4e20c10f7a1c1c3e7dcf3abdab 22:38:14 INFO - mozversion application_display_name: Nightly 22:38:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:38:14 INFO - mozversion application_name: Firefox 22:38:14 INFO - mozversion application_remotingname: firefox 22:38:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:38:14 INFO - mozversion application_vendor: Mozilla 22:38:14 INFO - mozversion application_version: 47.0a1 22:38:14 INFO - mozversion platform_buildid: 20160306214810 22:38:14 INFO - mozversion platform_changeset: fd095cbb65ad0d4e20c10f7a1c1c3e7dcf3abdab 22:38:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:38:14 INFO - mozversion platform_version: 47.0a1 22:38:14 INFO - using testdate: 1457332694 22:38:14 INFO - actual date: 1457332694 22:38:14 INFO - starting webserver on 'localhost:46988' 22:38:14 INFO - SUITE-START | Running 2 tests 22:38:14 INFO - TEST-START | dromaeo_css 22:38:14 INFO - operating with platform_type : linux_ 22:38:14 INFO - Initialising browser for dromaeo_css test... 22:38:14 INFO - TEST-INFO | started process 8395 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_tj0lI/profile http://localhost:46988/getInfo.html) 22:38:18 INFO - PROCESS | 8395 | __metrics Screen width/height:1600/1200 22:38:18 INFO - PROCESS | 8395 | colorDepth:24 22:38:18 INFO - PROCESS | 8395 | Browser inner width/height: 1024/697 22:38:18 INFO - PROCESS | 8395 | __metrics 22:38:20 INFO - PROCESS | 8395 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:38:20 INFO - PROCESS | 8395 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 22:38:21 INFO - TEST-INFO | 8395: exit 0 22:38:21 INFO - Browser initialized. 22:38:21 INFO - Running cycle 1/1 for dromaeo_css test... 22:38:21 INFO - TEST-INFO | started process 8486 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_tj0lI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:38:33 INFO - PROCESS | 8486 | RSS: Main: 155693056 22:38:33 INFO - PROCESS | 8486 | 22:39:24 INFO - PROCESS | 8486 | 1457332764503 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] 22:41:36 INFO - PROCESS | 8486 | Cycle 1(1): loaded http://localhost:46988/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46988/tests/dromaeo/cssquery-ext.html) 22:41:37 INFO - PROCESS | 8486 | RSS: Main: 244006912 22:41:37 INFO - PROCESS | 8486 | 22:44:39 INFO - PROCESS | 8486 | Cycle 1(1): loaded http://localhost:46988/tests/dromaeo/cssquery-ext.html (next: http://localhost:46988/tests/dromaeo/cssquery-jquery.html) 22:44:39 INFO - PROCESS | 8486 | RSS: Main: 234569728 22:44:39 INFO - PROCESS | 8486 | 22:47:41 INFO - PROCESS | 8486 | Cycle 1(1): loaded http://localhost:46988/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46988/tests/dromaeo/cssquery-mootools.html) 22:47:42 INFO - PROCESS | 8486 | RSS: Main: 240058368 22:47:42 INFO - PROCESS | 8486 | 22:50:44 INFO - PROCESS | 8486 | Cycle 1(1): loaded http://localhost:46988/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46988/tests/dromaeo/cssquery-prototype.html) 22:50:44 INFO - PROCESS | 8486 | RSS: Main: 208322560 22:50:44 INFO - PROCESS | 8486 | 22:53:47 INFO - PROCESS | 8486 | Cycle 1(1): loaded http://localhost:46988/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46988/tests/dromaeo/cssquery-yui.html) 22:53:48 INFO - PROCESS | 8486 | RSS: Main: 222662656 22:53:48 INFO - PROCESS | 8486 | 22:56:50 INFO - PROCESS | 8486 | Cycle 1(1): loaded http://localhost:46988/tests/dromaeo/cssquery-yui.html (next: http://localhost:46988/tests/dromaeo/cssquery-dojo.html) 22:56:50 INFO - PROCESS | 8486 | RSS: Main: 262426624 22:56:50 INFO - PROCESS | 8486 | 22:56:50 INFO - PROCESS | 8486 | __start_tp_report 22:56:50 INFO - PROCESS | 8486 | _x_x_mozilla_page_load 22:56:50 INFO - PROCESS | 8486 | _x_x_mozilla_page_load_details 22:56:50 INFO - PROCESS | 8486 | |i|pagename|runs| 22:56:50 INFO - PROCESS | 8486 | |0;dojo.html;2602.531544322022;2622.632831403605;2670.279024663341;2670.7863370930327;2673.8262012969158;4455.108978204364;4517.5256598057185;4533.501314855367;4567.543245675431;4569.4745104313015;4528.275475923853;4587.655925805561;4623.30650402439;4656.650751193657;4659.254519276908;4246.554111818261;4249.3413520904305;4254.6170844623975;4288.356746488021;4419.64642828573;4091.1817636472674;4325.718828276152;4362.1275744851;4386.736795792247;4390.670699697535;4143.7720925349095;4185.351270553069;4198.643115335185;4207.032382552;4217.325227963542;4235.449391579105;4268.146370725836;4272.46594175728;4301.376300436419;4310.331898555729;4074.1444296697728;4247.193033323659;4263.8081286342185;4269.850555230552;4299.07569872479;4489.304157855538;4524.140413321458;4542.863714088583;4583.060472603109;4583.747893865836;4796.496367881392;4805.927911081337;4810.63920205986;4814.446338671062;4832.565069143794;4819.807207711688;4821.831235906761;4852.781624826891;4861.586765124934;4892.68197567157;4577.267637178035;4597.885052873705;4601;4606.170889239936;4638.536146385402;5019.874503137377;5020.422651395136;5021.6735912165595;5028.094942910238;5066.569341606005;4773.498782627844;4829.492903245179;4845.685030473008;4846.200376937766;4918.0901533216465;4861.27080937855;4879.219324908068;4880.633952453581;4890.24201248807;4914.975425122851;4815.133276010351;4837.95162048382;4838.201696720002;4840.346553215341;4878.853634390974;4741.383620129361;4794.640401969797;4797.208460604031;4862.756862156878;4879.1461494238365;4050.817713202854;4055.8174882130374;4058.066644671742;4058.7970601470397;4082.4896887889013;3575.785452872836;3580.785152890835;3587.6053634100226;3601.693856022215;3612.151144481045;4099.057216840084;4174.979125104355;4198.097409057006;4275.123599662062;4276.465441819772;4865.878353041202;4868.707877527359;4868.853934381974;4879.2925025871045;4893.779779909842;4198.685098617616;4199.580041995837;4199.97900010498;4203.978980105141;4236.216299984513;4218.17745539623;4331;4368.978155109267;4393.846215382447;4404.911901761947;4624.606908412823;4632.420947381577;4647.62818974488;4649.604783593432;4693.55411235932;4726.243800991825;4858.441279252931;4863.95136048635;4865.294532292868;4909.116359055404;4535.934055497021;4593.425821772278;4617;4641.930371044505;4672.205725026822;4692.061587682409;4704.059188162313;4710.623150148049;4722.433308002925;4738.739369334719;4800.255960326155;4800.495947925558;4848.9757551212015;4863.902721945612;4949.232868905326;4633.212353899912;4655.301704744315;4692.601128904082;4704.553067458586;4738.218193997952;4698.036902434924;4700.2244629635725;4702;4736.029114031684;4738.407699037621;4563.292689633112;4594.448666160082;4615.353850461005;4619.953800461953;4643.326717625858;4726.1729197391005;4748.810047598057;4756.19144745401;4756.738379389167;4758.595519380891;4664;4668.5798278155125;4669.48635650085;4675.3688252086895;4684.016356565159 22:56:50 INFO - PROCESS | 8486 | |1;ext.html;461.6330017635979;471.83485779977013;473.9691920025196;477.58450148370923;498.11335822236407;22501.21245756399;22955.770442295594;28696.282592935186;28723.42553148941;28773;30610;31253.687463125363;31255.531167032514;31376.68623313772;31558.68441315586;7417.406607471403;7591.924080759204;7597.696092156307;7601.543907365576;7602.923970760305;7506.587137707424;7614.961925190366;7619.619019049025;7627.161012288644;7629.8474030519355;7784.727534536292;7868.52788832669;7881.9359386482665;7891.210878912091;7894.407919406039;7733.690652373926;7749.108852481981;7807.687692492322;7815.335696465807;7819.3744500439825;7559.130699969519;7678.616069196573;7684.654190561382;7685.769426917202;7690.077190737092;30787.076387708406;31040.8447957761;31064.534031989537;31168;31332.530012049836;2559.948801023988;2642.5771876499666;2679.9062032828756;2735.00172437061;3008.6389633244153;24190.032398704032;24297;24306.513869722683;24343.14798982027;24392.760243838362;3351.6648335166533;3359.4624860022523;3382.594088709346;3409.130671678731;3504.123969007748;204397;204688;204836;205489.97255013778;206040;38225.61774382276;38451.807740961114;39140.41289380661;39166.412503811895;39627;42597.78701106475;44205;44763;44809.55190448054;44812.55187448149;11455.885441145649;11687.123465740104;11733.4719937603;11982.520699171935;11998.160128791076;7945.920540794634;7968.402369822286;7974.082980457321;7990.360771138295;8008.839823203503;14366.13803171813;14366.712665746627;14475.276236188149;14520.564383068524;14921.104733716013;5869;5976.9540330442;6056.36408177135;6085.2393450818645;6128.3258841527395;719.0400814912047;772.0388116794514;777.2654841175035;787.696736756353;807.0799288810761;22740.772592273865;23290.65064024041;23373.181938632068;23451.530969380517;23732;789.9170587088388;835.9916400835914;837.2673910328463;860.3031544448892;935.8689783430325;11841.171118021655;12257.080718946114;12342.197757145757;12370.81443778344;12387.814182787266;257025;262430.3177261713;263319;263697;264033;37215;37363;37544.43683344752;37611.247775044896;37713.62286377101;980.4411485453223;993.1756641987133;1015.1016350529834;1016.11090295991;1018.9694309170885;22481.550368992856;22739.545209096057;22911.770882290963;22960.540789184455;23019.88490057539;33226.335473290885;33233.50149747804;33480.49779253362;33510.32979340448;33596.66403335935;250091;251495;251524;252060;252410;22125.66811497861;25014.374640633403;25456.618150727383;25797.6130358041;25933.740662593133;28932.710672893;29374.118776436742;29596;29614.259643509085;29614.703852962055;25940.740592593833;26011.609825853007;26533.734662653125;27758.44483110367;28599.714002859706;27087;27171.1848644541;27191;27230.319242019108;27389;25107.99568017259;25400.237992860242;25466.490670186122;25502.489950201263;25844.483110338064;24441.755582443948;25320.873395632905;25360;25428.237152885442;25693.61459578145;20264.493387665425;20832.68750968767;20867.373978780663;20957.476063098544;20961.161553537688 22:56:50 INFO - PROCESS | 8486 | |2;jquery.html;308.8147111732959;317.54115303386584;321.46476117264757;322.4695376106305;327.91965968337746;13958.51145209918;14331.068480548756;14439.133651980876;14452.20512871793;14696.338664760086;12712.809307860389;12898.484060637564;12931.224126552414;13025;13180.604581862535;4797.760111994395;4931.186354251544;4959.900801983958;4959.925601115986;4960.801567937297;4770.4275486941615;4833.975830120845;4834.782434790425;4854.490278520758;4855;4789.976050119744;4806.543378379066;4878.292647566101;4885.43817460993;4945.455999840015;4831.565159135659;4884.072026314989;4884.29177769225;4907.828226012072;4909.091818013679;4307.375430562551;4368.672349573763;4369.344598310279;4375.343698445258;4378.978105109454;17154.399596014206;17259.482215533553;17634.206460709298;17903;17907.1941762621;1685.755565443004;1785.8571314294954;1790.5255107396551;1869.5886904880904;2181.007641523119;11532.481038353295;11783;11892.940535297355;12150.878491215062;12172.147949643528;1758.78015248094;1784.125778368603;1790.9820901790945;1797.2451570340488;1817.6092140189924;52392.99999999962;52585;53264.40206793803;53719.73140134313;54289.185662215095;8902.777430564158;9174.981504069094;9190.586423610954;9364.719058428122;9372.437653740797;11416.714582135513;11439.199256052163;11506.137039722054;11518.769624607461;11535.134864885167;6036.698165091816;6082.9695851520455;6175.69121543921;6179.474744646665;6243.157173781572;5597.893169291001;6095.146679464879;6097.786577469856;6258.561900667;6280.811575652738;3862.575116737157;3928.1750832325533;3943.3493473576536;3961.7821019844187;4000.439938408625;1632.7061128996895;1657.2211060801403;1658.610226596773;1682.4532027091;1702.9744553831454;768.5696010234286;778.9493682910593;794.5749024271987;807.1887752808507;850.9446885952393;13879.791803122962;14437.278136093153;14461.27693615315;14503.419863205565;14533.85466145325;753.9472236943361;767.0603510699349;767.3630886364305;809.8380323935237;826.3595713322223;8044.597770111471;8045.919540804634;8118.837623247502;8261.13258107902;8339.20777526134;281851;366810;380291;380406;382411;51635.48364516382;59379.40620593739;62492.37507624865;62923.6853815728;68547.31452685509;782.7847341981001;924.6624981881699;927.2628260532892;958.8753462049889;963.710886733977;12565.120441569368;12846.67883302925;12871.549495767604;13049.478020879058;13056.477740890257;31020.53469198009;32037.519437208928;32067;32147.19632009125;32590.185245369055;38482.6151738479;39019.609803902735;41142.79428602838;41443.79278103711;41672.3749143757;6785.762498312535;6892.241853396022;6939.155454006891;7050.224475307609;7092.574445533284;9493.952530237304;10376.584936602754;10475.633352832614;10530.526126324181;10785.838212426663;8813.454836512468;8915.777105572153;9268.490233037248;9357.906420935704;9437.528123593931;8539.188777066169;8582;8992.55037248148;9099.226565741987;9156.725298241063;8774.824503509766;8925.955370223108;9000.36997410175;9027.187553120251;9543.379680320757;6628.370304821035;6629.436497897733;6882.105326307548;6915.273896240822;6952.165740111219;9093.727188184364;9296.95351523238;9347.485888276211;9550.85673714881;9637.71086867395 22:56:50 INFO - PROCESS | 8486 | |3;mootools.html;1054.9841752373711;1106.6569363497315;1113.6770336602385;1121.8653761548615;1287.0668765145272;6186.721597528111;6968.756093536727;7097.964510177455;7121.715131394738;7125.6793444295;6778.152730908637;6904.1714994200765;6911.377975982161;6917.51577389583;6935.306469353062;1664.2261348472957;1703.8466538011576;1705.9317627294893;2023.3929821053698;2035.2571311471354;1745.8952462852205;2049.231538173185;2101.506146055676;2103.3584756649216;2103.663413853784;2046.9795302047012;2051.169276443043;2052.1791283486577;2057.4547744847628;2058.670612701968;1951.736515570394;2020.5049762808133;2020.919163233469;2024.2712623455545;2026.9797302026939;1966.1152481383435;2000.8499362547868;2001.86987845791;2015.647261729206;2025.463252238158;7301.561906285639;7347.742829000959;7357.043584334056;7373.225811289791;7376.225496322916;4145.937810932808;4301.677374196947;4303.720258183208;4306.80619372129;4308.892277693051;2641.4320921002077;2715.0361621624434;2761.502929472694;2764.2536515141;2795.0636536760207;784.2275358771606;796.7888509544975;806.6692656011007;816.4774544291598;824.2293455619016;9999.100080992746;10009;10011.699649010541;10084.445355505444;10086.344387614781;3914.451976723261;4001.579834117434;4008.4367096832257;4080.3879418087527;4101.753894766323;8368.37237207212;8425.283850872744;8447.45091569046;8450.154984501502;8478.448900821428;4177.644900183518;4178.331466965271;4180.122174343361;4181.644560212355;4183.895402614959;3176.571162893026;3271.1985563537087;3723.888283351504;3746.1383881706815;3755.2489502099143;3049.557814116941;3108.3006323577465;3273.3126043530647;3329.9833500832824;3349.3468773588916;1045.900639439252;1084.3710647824244;1088.684281558355;1097.3306283167262;1102.9889701102886;838.2455789789117;843.2874221283006;852.8720691896265;1036.652721338345;1082.5994382078525;6654.367835055662;6713.26154123046;6739.393454589012;6742.123523941857;6772.356626120609;923.7182659288982;937.6952490440634;940.2853831088422;967.2165545907696;968.3512046928574;5294.867628309246;5348.973255133699;5409.459054094559;5413.350397952192;5422.078246698071;8470.449420787629;8763.956180219186;8828.470291782514;9082.091790820998;9089.81820363589;8952.14954579314;8967.730968070839;8999.595018224196;9079.636814527477;9102.317326200562;6348.333424990402;6524.119243902012;6828.146481689789;6897.965510172417;6905.240423553405;6651.866962660622;6683.9331606685255;6703.02806093104;6729.69716362755;6748.628825414649;7522.022137122139;7579.583122928071;7698.03774528184;7764.805879852823;7788;7701.1143718473095;7936.166702496154;7954.125046244792;7990.161033091675;8069.636866340911;5998.580099393001;6061.848453788514;6069.939300606938;6073.453389194994;6078.939210607838;6330.208723909512;6446.8388290293115;6459;6478.028295755675;6478.902816457663;5638.633488823213;5759.193712880284;5777.884442311214;5796.652200867961;5842.853928651818;5581.134924086773;5625.240592520121;5663.9716801415725;5689.459501347365;5731;5853.531717462678;5882;5922.111683247547;5939.554533410098;5992.9700351499705;5573.832785016456;5734.856628584319;5743.310802703702;5746.42535746422;5781.710914454345;5501.642393244426;5509.421510741475;5525.198846167203;5535.114381698909;5535.501804837584 22:56:50 INFO - PROCESS | 8486 | |4;prototype.html;292.122172870524;293.398533007335;295.12348325473346;296.7625899280575;299.52525247482737;5233.8953220935555;5271.367435907687;5283.181106928428;5287.259783630295;5290.470952904712;5292.550133238679;5334.653247538908;5357.7589008494615;5362.410134885169;5369.328833895763;3820.3505404081234;3941.389084691863;4073.490813648294;4075.714699971003;4105.1379210365785;4065.4714887064642;4075.470188875442;4081.653059489947;4082.3672330788777;4091.3249313863175;4031.8185681644395;4038.2125485530332;4038.919221615566;4040.797960101998;4051.1897620475875;3806.5812760596314;3904.9414258786283;4020.537638171589;4025.6175663311938;4026.094128820992;3464.9826750866087;3467.063892748969;3472.9131771705656;3477.23500829817;3478;5136.255242989783;5142.794288228466;5149.665271757323;5150.562202212779;5158.329417175743;4600.976995115003;4602.838900638495;4605.516420775837;4610.147122782262;4612.976935115303;5555;5561.388247292794;5561.694106824123;5567.331920169565;5567.47109024642;3770.3967365221706;3771.849126034955;3775.9811200944096;3781.735278530504;3783.886483405502;5620.3784686332;5790.739416726257;5854.6194497357965;5859.35547089824;5861.736221869984;3849.711271654637;3872.302985462644;3873.3028054949814;3874.9806250968563;3880.049387899983;3926.2147570485445;3927.116398810245;3927.4697915781576;3937.625925537069;3937.7440466369594;4564.7717614119165;4571.451425828922;4574.108048930427;4575.633949284049;4580.312953057068;5553.333599968029;5556.361018482926;5559.749811258423;5565;5565.972170139124;1353.911995720275;1367.0703921333588;1367.4188469900253;1368.2337890781193;1371.149887070023;833.3000279764906;846;921.4287141971886;939.8684184214216;941.1388579449726;4831.492693267227;4870.683405578697;4875.366202393737;4876.463589005207;4883.536064073907;5723.799667011718;5748.798792042258;5778.104393818965;5795.043817770021;5800.013997620415;4850.83022094225;4858.416989961227;4859.392575928009;4861.222204447272;4861.343718597944;3051.130427828058;3082.5222090576;3086.5215891536845;3088.042706760866;3089.382123575294;5424.864378390572;5428;5430.104032834538;5430.348358196962;5434.239206511092;5698.715064246771;5870.148828419855;5875.41245875409;5894;5896.734646940898;5404.702741349185;5421;5425.972870135624;5431.185322201702;5441.8095366662765;5698.373178950395;5712.7714891403875;5720.971395142998;5722.027255366681;5724.771009159587;5565.972170139124;5588.972055139699;5592.384837667934;5597.860053498695;5601.271834661468;5421.2681288025615;5424.484673955968;5426.511613954605;5428.755705993319;5429.1313389859015;3693.224422871227;3805.828737706865;3816.1413681922454;3818.465414841869;3830.6935445164877;5689.374168841341;5696.629719068247;5703.771849126155;5714.885702286014;5725.799597014085;5303.257543943774;5451.809186678447;5483.314585676791;5489.204065410573;5583.218349431164;5575.749091290821;5580.051391263576;5580.888382232251;5586.52514536269;5587.832365029056;5464.945350546603;5475.67145971243;5481.095619222783;5481.643693159932;5484.506394424521;5616;5621.578381621313;5625.071863142535;5628.0432326505415;5630.5777066720975;5478.616496845182;5488.670679759227;5492.862678432912;5493;5502.119660854244 22:56:50 INFO - PROCESS | 8486 | |5;yui.html;526.976286067127;528.4213785904436;550.2324257660562;562.4993755557555;591.1930215256175;10430.322029068106;10566.313189642688;10615.681529554126;10619.25665203436;10625.149988000961;9944.801103977916;9984.951580084078;10004.799904001915;10420.791584168312;11151.219414640978;501.20058506681875;504.8182654244469;505.6056276104644;507.3049921607403;508.4965883775073;523.8140460136653;528.4556906386429;531.6544246239936;534.5883669574425;541.1368866657675;548.4131978782705;549.1762356465302;549.64547866626;553.5792797473929;553.6069390732584;567.6735876870816;568.2243737298598;569.9943000569982;570.7346084070906;575.6948817126888;416.2382839403884;418.374530077536;419.850952911718;419.96640268778424;424.7939749221656;11004.449777511092;11025.669229923114;11099.556017759362;11103.666889993314;11128.554857805679;10237.641682541076;10577.36535807854;10701.143908487302;10722.249442539025;10742.355458672504;7659.119201291867;7952.403569732235;8322.70870519529;8323.209295116954;8425.873611895826;3019.5772591837163;3019.6527399348915;3068.8925887593828;3069.1866655336353;3078.1381213260324;35485.29029419397;35555.822220888986;39508.60491395078;39720.80139599313;41265.174696506205;8441.282490988211;8456.2812160967;8591.5704214789;8606.632625211509;8692.087330830298;13783.035187536776;13787.034907556375;13916.860831391556;13940.860591393955;13989.30053497321;5949.0481522956115;6071.392860713893;6169.907451388232;6199.380061993765;6266.905996410058;3289.934201316008;3294.472884338494;3299.703026727606;3446;3480.460528618068;2245.259064508708;2260.4235919840335;2266.8753218572806;2270.3756466971713;2270.3869955112027;416.20297130993805;419.7691269801658;431.09685209486076;431.42620314981;433.6552440809564;481.7856054055911;486.7104073076514;534.2840593604589;553.950144486998;568.2640979930999;6860;7023.122109736283;7046.964765176142;7235.204127545966;7257.45569082321;425.0478927203105;473.412967919777;522.7699812082672;546.1970902772997;560.3332034878482;3285.4414749492644;3324.1357247115925;3438.8452519636676;3447.500112483676;3458.9308213836084;46601.766991164826;47053.29420058702;47449.76275118671;47592.286115708295;47641.28538071932;42470.57529424728;42851.78574107109;43387.13225735468;43514.12971740548;43751.34372984408;33747.49378759321;34548.30903381918;38819.80590097088;41052.79473602673;41081;6773.424258938046;6783.3555812197765;6855.211650660238;6905;6919.342662447059;29330.560041598965;29448.11655650334;30346.69653303439;30577.08268751941;30611.693883061776;35928;36626.26747464982;36647.45028824516;36763.63236367602;36827.447588285664;8341;8605.440646357967;8610.268127209258;8684.131586841519;8978.685745998859;9810.558524866256;10118.038786315288;10166.135878450119;10213.846792297973;10253.897461025294;9469.715908522756;9474.336796424184;9698.56356463975;9734.318597698093;10151.898481015096;8628.266597339296;8713.433626814236;8814.779630509289;8925.866112008454;8938.553072346227;9682.661106861226;9954.352967057408;10054.64808731691;10325.173986081245;10410.895891040993;8152.184781521801;8273.958630206811;8275.08974012846;8462;8671.956640216758;8402.201790829862;8545.102764209669;8573.957130214309;8702.782430439289;8989.775255618662 22:56:50 INFO - PROCESS | 8486 | __end_tp_report 22:56:50 INFO - PROCESS | 8486 | __start_cc_report 22:56:50 INFO - PROCESS | 8486 | _x_x_mozilla_cycle_collect,929 22:56:50 INFO - PROCESS | 8486 | __end_cc_report 22:56:50 INFO - PROCESS | 8486 | __startTimestamp1457333810916__endTimestamp 22:56:50 INFO - PROCESS | 8486 | 22:56:50 INFO - PROCESS | 8486 | ------- Summary: start ------- 22:56:50 INFO - PROCESS | 8486 | Number of tests: 6 22:56:50 INFO - PROCESS | 8486 | 22:56:50 INFO - PROCESS | 8486 | [#0] dojo.html Cycles:165 Average:4506.10 Median:4638.54 stddev:450.56 (9.7%) stddev-sans-first:426.48 22:56:50 INFO - PROCESS | 8486 | Values: 2602.5 2622.6 2670.3 2670.8 2673.8 4455.1 4517.5 4533.5 4567.5 4569.5 4528.3 4587.7 4623.3 4656.7 4659.3 4246.6 4249.3 4254.6 4288.4 4419.6 4091.2 4325.7 4362.1 4386.7 4390.7 4143.8 4185.4 4198.6 4207.0 4217.3 4235.4 4268.1 4272.5 4301.4 4310.3 4074.1 4247.2 4263.8 4269.9 4299.1 4489.3 4524.1 4542.9 4583.1 4583.7 4796.5 4805.9 4810.6 4814.4 4832.6 4819.8 4821.8 4852.8 4861.6 4892.7 4577.3 4597.9 4601.0 4606.2 4638.5 5019.9 5020.4 5021.7 5028.1 5066.6 4773.5 4829.5 4845.7 4846.2 4918.1 4861.3 4879.2 4880.6 4890.2 4915.0 4815.1 4838.0 4838.2 4840.3 4878.9 4741.4 4794.6 4797.2 4862.8 4879.1 4050.8 4055.8 4058.1 4058.8 4082.5 3575.8 3580.8 3587.6 3601.7 3612.2 4099.1 4175.0 4198.1 4275.1 4276.5 4865.9 4868.7 4868.9 4879.3 4893.8 4198.7 4199.6 4200.0 4204.0 4236.2 4218.2 4331.0 4369.0 4393.8 4404.9 4624.6 4632.4 4647.6 4649.6 4693.6 4726.2 4858.4 4864.0 4865.3 4909.1 4535.9 4593.4 4617.0 4641.9 4672.2 4692.1 4704.1 4710.6 4722.4 4738.7 4800.3 4800.5 4849.0 4863.9 4949.2 4633.2 4655.3 4692.6 4704.6 4738.2 4698.0 4700.2 4702.0 4736.0 4738.4 4563.3 4594.4 4615.4 4620.0 4643.3 4726.2 4748.8 4756.2 4756.7 4758.6 4664.0 4668.6 4669.5 4675.4 4684.0 22:56:50 INFO - PROCESS | 8486 | 22:56:50 INFO - PROCESS | 8486 | [#1] ext.html Cycles:180 Average:36445.58 Median:29614.48 stddev:63000.25 (212.7%) stddev-sans-first:63119.05 22:56:50 INFO - PROCESS | 8486 | Values: 461.6 471.8 474.0 477.6 498.1 22501.2 22955.8 28696.3 28723.4 28773.0 30610.0 31253.7 31255.5 31376.7 31558.7 7417.4 7591.9 7597.7 7601.5 7602.9 7506.6 7615.0 7619.6 7627.2 7629.8 7784.7 7868.5 7881.9 7891.2 7894.4 7733.7 7749.1 7807.7 7815.3 7819.4 7559.1 7678.6 7684.7 7685.8 7690.1 30787.1 31040.8 31064.5 31168.0 31332.5 2559.9 2642.6 2679.9 2735.0 3008.6 24190.0 24297.0 24306.5 24343.1 24392.8 3351.7 3359.5 3382.6 3409.1 3504.1 204397.0 204688.0 204836.0 205490.0 206040.0 38225.6 38451.8 39140.4 39166.4 39627.0 42597.8 44205.0 44763.0 44809.6 44812.6 11455.9 11687.1 11733.5 11982.5 11998.2 7945.9 7968.4 7974.1 7990.4 8008.8 14366.1 14366.7 14475.3 14520.6 14921.1 5869.0 5977.0 6056.4 6085.2 6128.3 719.0 772.0 777.3 787.7 807.1 22740.8 23290.7 23373.2 23451.5 23732.0 789.9 836.0 837.3 860.3 935.9 11841.2 12257.1 12342.2 12370.8 12387.8 257025.0 262430.3 263319.0 263697.0 264033.0 37215.0 37363.0 37544.4 37611.2 37713.6 980.4 993.2 1015.1 1016.1 1019.0 22481.6 22739.5 22911.8 22960.5 23019.9 33226.3 33233.5 33480.5 33510.3 33596.7 250091.0 251495.0 251524.0 252060.0 252410.0 22125.7 25014.4 25456.6 25797.6 25933.7 28932.7 29374.1 29596.0 29614.3 29614.7 25940.7 26011.6 26533.7 27758.4 28599.7 27087.0 27171.2 27191.0 27230.3 27389.0 25108.0 25400.2 25466.5 25502.5 25844.5 24441.8 25320.9 25360.0 25428.2 25693.6 20264.5 20832.7 20867.4 20957.5 20961.2 22:56:50 INFO - PROCESS | 8486 | 22:56:50 INFO - PROCESS | 8486 | [#2] jquery.html Cycles:180 Average:21292.03 Median:4844.64 stddev:59104.48 (1220.0%) stddev-sans-first:59249.29 22:56:50 INFO - PROCESS | 8486 | Values: 308.8 317.5 321.5 322.5 327.9 13958.5 14331.1 14439.1 14452.2 14696.3 12712.8 12898.5 12931.2 13025.0 13180.6 4797.8 4931.2 4959.9 4959.9 4960.8 4770.4 4834.0 4834.8 4854.5 4855.0 4790.0 4806.5 4878.3 4885.4 4945.5 4831.6 4884.1 4884.3 4907.8 4909.1 4307.4 4368.7 4369.3 4375.3 4379.0 17154.4 17259.5 17634.2 17903.0 17907.2 1685.8 1785.9 1790.5 1869.6 2181.0 11532.5 11783.0 11892.9 12150.9 12172.1 1758.8 1784.1 1791.0 1797.2 1817.6 52393.0 52585.0 53264.4 53719.7 54289.2 8902.8 9175.0 9190.6 9364.7 9372.4 11416.7 11439.2 11506.1 11518.8 11535.1 6036.7 6083.0 6175.7 6179.5 6243.2 5597.9 6095.1 6097.8 6258.6 6280.8 3862.6 3928.2 3943.3 3961.8 4000.4 1632.7 1657.2 1658.6 1682.5 1703.0 768.6 778.9 794.6 807.2 850.9 13879.8 14437.3 14461.3 14503.4 14533.9 753.9 767.1 767.4 809.8 826.4 8044.6 8045.9 8118.8 8261.1 8339.2 281851.0 366810.0 380291.0 380406.0 382411.0 51635.5 59379.4 62492.4 62923.7 68547.3 782.8 924.7 927.3 958.9 963.7 12565.1 12846.7 12871.5 13049.5 13056.5 31020.5 32037.5 32067.0 32147.2 32590.2 38482.6 39019.6 41142.8 41443.8 41672.4 6785.8 6892.2 6939.2 7050.2 7092.6 9494.0 10376.6 10475.6 10530.5 10785.8 8813.5 8915.8 9268.5 9357.9 9437.5 8539.2 8582.0 8992.6 9099.2 9156.7 8774.8 8926.0 9000.4 9027.2 9543.4 6628.4 6629.4 6882.1 6915.3 6952.2 9093.7 9297.0 9347.5 9550.9 9637.7 22:56:50 INFO - PROCESS | 8486 | 22:56:50 INFO - PROCESS | 8486 | [#3] mootools.html Cycles:180 Average:4901.16 Median:5752.81 stddev:2644.67 (46.0%) stddev-sans-first:2636.28 22:56:50 INFO - PROCESS | 8486 | Values: 1055.0 1106.7 1113.7 1121.9 1287.1 6186.7 6968.8 7098.0 7121.7 7125.7 6778.2 6904.2 6911.4 6917.5 6935.3 1664.2 1703.8 1705.9 2023.4 2035.3 1745.9 2049.2 2101.5 2103.4 2103.7 2047.0 2051.2 2052.2 2057.5 2058.7 1951.7 2020.5 2020.9 2024.3 2027.0 1966.1 2000.8 2001.9 2015.6 2025.5 7301.6 7347.7 7357.0 7373.2 7376.2 4145.9 4301.7 4303.7 4306.8 4308.9 2641.4 2715.0 2761.5 2764.3 2795.1 784.2 796.8 806.7 816.5 824.2 9999.1 10009.0 10011.7 10084.4 10086.3 3914.5 4001.6 4008.4 4080.4 4101.8 8368.4 8425.3 8447.5 8450.2 8478.4 4177.6 4178.3 4180.1 4181.6 4183.9 3176.6 3271.2 3723.9 3746.1 3755.2 3049.6 3108.3 3273.3 3330.0 3349.3 1045.9 1084.4 1088.7 1097.3 1103.0 838.2 843.3 852.9 1036.7 1082.6 6654.4 6713.3 6739.4 6742.1 6772.4 923.7 937.7 940.3 967.2 968.4 5294.9 5349.0 5409.5 5413.4 5422.1 8470.4 8764.0 8828.5 9082.1 9089.8 8952.1 8967.7 8999.6 9079.6 9102.3 6348.3 6524.1 6828.1 6898.0 6905.2 6651.9 6683.9 6703.0 6729.7 6748.6 7522.0 7579.6 7698.0 7764.8 7788.0 7701.1 7936.2 7954.1 7990.2 8069.6 5998.6 6061.8 6069.9 6073.5 6078.9 6330.2 6446.8 6459.0 6478.0 6478.9 5638.6 5759.2 5777.9 5796.7 5842.9 5581.1 5625.2 5664.0 5689.5 5731.0 5853.5 5882.0 5922.1 5939.6 5993.0 5573.8 5734.9 5743.3 5746.4 5781.7 5501.6 5509.4 5525.2 5535.1 5535.5 22:56:50 INFO - PROCESS | 8486 | 22:56:50 INFO - PROCESS | 8486 | [#4] prototype.html Cycles:180 Average:4574.83 Median:5297.90 stddev:1372.63 (25.9%) stddev-sans-first:1338.32 22:56:50 INFO - PROCESS | 8486 | Values: 292.1 293.4 295.1 296.8 299.5 5233.9 5271.4 5283.2 5287.3 5290.5 5292.6 5334.7 5357.8 5362.4 5369.3 3820.4 3941.4 4073.5 4075.7 4105.1 4065.5 4075.5 4081.7 4082.4 4091.3 4031.8 4038.2 4038.9 4040.8 4051.2 3806.6 3904.9 4020.5 4025.6 4026.1 3465.0 3467.1 3472.9 3477.2 3478.0 5136.3 5142.8 5149.7 5150.6 5158.3 4601.0 4602.8 4605.5 4610.1 4613.0 5555.0 5561.4 5561.7 5567.3 5567.5 3770.4 3771.8 3776.0 3781.7 3783.9 5620.4 5790.7 5854.6 5859.4 5861.7 3849.7 3872.3 3873.3 3875.0 3880.0 3926.2 3927.1 3927.5 3937.6 3937.7 4564.8 4571.5 4574.1 4575.6 4580.3 5553.3 5556.4 5559.7 5565.0 5566.0 1353.9 1367.1 1367.4 1368.2 1371.1 833.3 846.0 921.4 939.9 941.1 4831.5 4870.7 4875.4 4876.5 4883.5 5723.8 5748.8 5778.1 5795.0 5800.0 4850.8 4858.4 4859.4 4861.2 4861.3 3051.1 3082.5 3086.5 3088.0 3089.4 5424.9 5428.0 5430.1 5430.3 5434.2 5698.7 5870.1 5875.4 5894.0 5896.7 5404.7 5421.0 5426.0 5431.2 5441.8 5698.4 5712.8 5721.0 5722.0 5724.8 5566.0 5589.0 5592.4 5597.9 5601.3 5421.3 5424.5 5426.5 5428.8 5429.1 3693.2 3805.8 3816.1 3818.5 3830.7 5689.4 5696.6 5703.8 5714.9 5725.8 5303.3 5451.8 5483.3 5489.2 5583.2 5575.7 5580.1 5580.9 5586.5 5587.8 5464.9 5475.7 5481.1 5481.6 5484.5 5616.0 5621.6 5625.1 5628.0 5630.6 5478.6 5488.7 5492.9 5493.0 5502.1 22:56:50 INFO - PROCESS | 8486 | 22:56:50 INFO - PROCESS | 8486 | [#5] yui.html Cycles:180 Average:11317.75 Median:47521.02 stddev:13160.28 (27.7%) stddev-sans-first:13172.25 22:56:50 INFO - PROCESS | 8486 | Values: 527.0 528.4 550.2 562.5 591.2 10430.3 10566.3 10615.7 10619.3 10625.1 9944.8 9985.0 10004.8 10420.8 11151.2 501.2 504.8 505.6 507.3 508.5 523.8 528.5 531.7 534.6 541.1 548.4 549.2 549.6 553.6 553.6 567.7 568.2 570.0 570.7 575.7 416.2 418.4 419.9 420.0 424.8 11004.4 11025.7 11099.6 11103.7 11128.6 10237.6 10577.4 10701.1 10722.2 10742.4 7659.1 7952.4 8322.7 8323.2 8425.9 3019.6 3019.7 3068.9 3069.2 3078.1 35485.3 35555.8 39508.6 39720.8 41265.2 8441.3 8456.3 8591.6 8606.6 8692.1 13783.0 13787.0 13916.9 13940.9 13989.3 5949.0 6071.4 6169.9 6199.4 6266.9 3289.9 3294.5 3299.7 3446.0 3480.5 2245.3 2260.4 2266.9 2270.4 2270.4 416.2 419.8 431.1 431.4 433.7 481.8 486.7 534.3 554.0 568.3 6860.0 7023.1 7047.0 7235.2 7257.5 425.0 473.4 522.8 546.2 560.3 3285.4 3324.1 3438.8 3447.5 3458.9 46601.8 47053.3 47449.8 47592.3 47641.3 42470.6 42851.8 43387.1 43514.1 43751.3 33747.5 34548.3 38819.8 41052.8 41081.0 6773.4 6783.4 6855.2 6905.0 6919.3 29330.6 29448.1 30346.7 30577.1 30611.7 35928.0 36626.3 36647.5 36763.6 36827.4 8341.0 8605.4 8610.3 8684.1 8978.7 9810.6 10118.0 10166.1 10213.8 10253.9 9469.7 9474.3 9698.6 9734.3 10151.9 8628.3 8713.4 8814.8 8925.9 8938.6 9682.7 9954.4 10054.6 10325.2 10410.9 8152.2 8274.0 8275.1 8462.0 8672.0 8402.2 8545.1 8574.0 8702.8 8989.8 22:56:50 INFO - PROCESS | 8486 | -------- Summary: end -------- 22:56:50 INFO - PROCESS | 8486 | 22:56:51 INFO - TEST-INFO | 8486: exit 0 22:56:51 INFO - TEST-OK | dromaeo_css | took 1117194ms 22:56:51 INFO - TEST-START | kraken 22:56:51 INFO - operating with platform_type : linux_ 22:56:51 INFO - Initialising browser for kraken test... 22:56:51 INFO - TEST-INFO | started process 8663 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfbo3GI/profile http://localhost:46988/getInfo.html) 22:56:56 INFO - PROCESS | 8663 | __metrics Screen width/height:1600/1200 22:56:56 INFO - PROCESS | 8663 | colorDepth:24 22:56:56 INFO - PROCESS | 8663 | Browser inner width/height: 1024/697 22:56:56 INFO - PROCESS | 8663 | __metrics 22:56:57 INFO - PROCESS | 8663 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:56:58 INFO - TEST-INFO | 8663: exit 0 22:56:58 INFO - Browser initialized. 22:56:58 INFO - Running cycle 1/1 for kraken test... 22:56:58 INFO - TEST-INFO | started process 8751 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfbo3GI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:57:10 INFO - PROCESS | 8751 | RSS: Main: 156835840 22:57:10 INFO - PROCESS | 8751 | 22:57:12 INFO - PROCESS | 8751 | Cycle 1(1): loaded http://localhost:46988/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46988/tests/kraken/driver.html?testName=audio-beat-detection) 22:57:13 INFO - PROCESS | 8751 | RSS: Main: 200466432 22:57:13 INFO - PROCESS | 8751 | 22:57:16 INFO - PROCESS | 8751 | Cycle 1(1): loaded http://localhost:46988/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46988/tests/kraken/driver.html?testName=audio-dft) 22:57:16 INFO - PROCESS | 8751 | RSS: Main: 188448768 22:57:16 INFO - PROCESS | 8751 | 22:57:19 INFO - PROCESS | 8751 | Cycle 1(1): loaded http://localhost:46988/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46988/tests/kraken/driver.html?testName=audio-fft) 22:57:20 INFO - PROCESS | 8751 | RSS: Main: 175509504 22:57:20 INFO - PROCESS | 8751 | 22:57:22 INFO - PROCESS | 8751 | Cycle 1(1): loaded http://localhost:46988/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46988/tests/kraken/driver.html?testName=audio-oscillator) 22:57:23 INFO - PROCESS | 8751 | RSS: Main: 176218112 22:57:23 INFO - PROCESS | 8751 | 22:57:25 INFO - PROCESS | 8751 | Cycle 1(1): loaded http://localhost:46988/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46988/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:57:26 INFO - PROCESS | 8751 | RSS: Main: 175599616 22:57:26 INFO - PROCESS | 8751 | 22:57:29 INFO - PROCESS | 8751 | Cycle 1(1): loaded http://localhost:46988/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46988/tests/kraken/driver.html?testName=imaging-darkroom) 22:57:29 INFO - PROCESS | 8751 | RSS: Main: 176648192 22:57:29 INFO - PROCESS | 8751 | 22:57:33 INFO - PROCESS | 8751 | Cycle 1(1): loaded http://localhost:46988/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46988/tests/kraken/driver.html?testName=imaging-desaturate) 22:57:33 INFO - PROCESS | 8751 | RSS: Main: 174817280 22:57:33 INFO - PROCESS | 8751 | 22:57:36 INFO - PROCESS | 8751 | Cycle 1(1): loaded http://localhost:46988/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46988/tests/kraken/driver.html?testName=json-parse-financial) 22:57:37 INFO - PROCESS | 8751 | RSS: Main: 174653440 22:57:37 INFO - PROCESS | 8751 | 22:57:39 INFO - PROCESS | 8751 | Cycle 1(1): loaded http://localhost:46988/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46988/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:57:39 INFO - PROCESS | 8751 | RSS: Main: 189906944 22:57:39 INFO - PROCESS | 8751 | 22:57:41 INFO - PROCESS | 8751 | Cycle 1(1): loaded http://localhost:46988/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46988/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:57:42 INFO - PROCESS | 8751 | RSS: Main: 188837888 22:57:42 INFO - PROCESS | 8751 | 22:57:44 INFO - PROCESS | 8751 | Cycle 1(1): loaded http://localhost:46988/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46988/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:57:45 INFO - PROCESS | 8751 | RSS: Main: 199802880 22:57:45 INFO - PROCESS | 8751 | 22:57:47 INFO - PROCESS | 8751 | Cycle 1(1): loaded http://localhost:46988/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46988/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:57:48 INFO - PROCESS | 8751 | RSS: Main: 207568896 22:57:48 INFO - PROCESS | 8751 | 22:57:50 INFO - PROCESS | 8751 | Cycle 1(1): loaded http://localhost:46988/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46988/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:57:51 INFO - PROCESS | 8751 | RSS: Main: 204316672 22:57:51 INFO - PROCESS | 8751 | 22:57:53 INFO - PROCESS | 8751 | Cycle 1(1): loaded http://localhost:46988/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46988/tests/kraken/driver.html?testName=ai-astar) 22:57:53 INFO - PROCESS | 8751 | RSS: Main: 265781248 22:57:53 INFO - PROCESS | 8751 | 22:57:53 INFO - PROCESS | 8751 | __start_tp_report 22:57:53 INFO - PROCESS | 8751 | _x_x_mozilla_page_load 22:57:53 INFO - PROCESS | 8751 | _x_x_mozilla_page_load_details 22:57:53 INFO - PROCESS | 8751 | |i|pagename|runs| 22:57:53 INFO - PROCESS | 8751 | |0;ai-astar;112;114;109;112;114;115;103;113;113;113 22:57:53 INFO - PROCESS | 8751 | |1;audio-beat-detection;160;133;163;171;134;159;171;134;180;135 22:57:53 INFO - PROCESS | 8751 | |2;audio-dft;161;160;160;160;161;162;161;162;161;161 22:57:53 INFO - PROCESS | 8751 | |3;audio-fft;74;74;74;151;74;74;74;74;162;74 22:57:53 INFO - PROCESS | 8751 | |4;audio-oscillator;94;95;146;95;96;94;142;95;96;131 22:57:53 INFO - PROCESS | 8751 | |5;imaging-gaussian-blur;116;117;117;117;118;117;117;117;117;117 22:57:53 INFO - PROCESS | 8751 | |6;imaging-darkroom;147;148;147;146;146;147;146;147;146;146 22:57:53 INFO - PROCESS | 8751 | |7;imaging-desaturate;96;95;95;96;95;95;96;96;95;95 22:57:53 INFO - PROCESS | 8751 | |8;json-parse-financial;71;69;70;71;70;70;70;79;67;69 22:57:53 INFO - PROCESS | 8751 | |9;json-stringify-tinderbox;70;69;71;70;71;70;71;70;70;70 22:57:53 INFO - PROCESS | 8751 | |10;stanford-crypto-aes;81;81;84;81;88;82;82;82;83;82 22:57:53 INFO - PROCESS | 8751 | |11;stanford-crypto-ccm;128;124;119;118;124;122;120;123;121;128 22:57:53 INFO - PROCESS | 8751 | |12;stanford-crypto-pbkdf2;153;144;169;150;151;140;151;150;149;140 22:57:53 INFO - PROCESS | 8751 | |13;stanford-crypto-sha256-iterative;71;73;72;73;70;70;70;72;74;71 22:57:53 INFO - PROCESS | 8751 | __end_tp_report 22:57:53 INFO - PROCESS | 8751 | __start_cc_report 22:57:53 INFO - PROCESS | 8751 | _x_x_mozilla_cycle_collect,1172 22:57:53 INFO - PROCESS | 8751 | __end_cc_report 22:57:53 INFO - PROCESS | 8751 | __startTimestamp1457333873463__endTimestamp 22:57:53 INFO - PROCESS | 8751 | 22:57:53 INFO - PROCESS | 8751 | ------- Summary: start ------- 22:57:53 INFO - PROCESS | 8751 | Number of tests: 14 22:57:53 INFO - PROCESS | 8751 | 22:57:53 INFO - PROCESS | 8751 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.00 stddev:3.49 (3.1%) stddev-sans-first:3.70 22:57:53 INFO - PROCESS | 8751 | Values: 112.0 114.0 109.0 112.0 114.0 115.0 103.0 113.0 113.0 113.0 22:57:53 INFO - PROCESS | 8751 | 22:57:53 INFO - PROCESS | 8751 | [#1] audio-beat-detection Cycles:10 Average:154.00 Median:161.50 stddev:18.25 (11.3%) stddev-sans-first:19.23 22:57:53 INFO - PROCESS | 8751 | Values: 160.0 133.0 163.0 171.0 134.0 159.0 171.0 134.0 180.0 135.0 22:57:53 INFO - PROCESS | 8751 | 22:57:53 INFO - PROCESS | 8751 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 22:57:53 INFO - PROCESS | 8751 | Values: 161.0 160.0 160.0 160.0 161.0 162.0 161.0 162.0 161.0 161.0 22:57:53 INFO - PROCESS | 8751 | 22:57:53 INFO - PROCESS | 8751 | [#3] audio-fft Cycles:10 Average:90.50 Median:74.00 stddev:34.88 (47.1%) stddev-sans-first:36.48 22:57:53 INFO - PROCESS | 8751 | Values: 74.0 74.0 74.0 151.0 74.0 74.0 74.0 74.0 162.0 74.0 22:57:53 INFO - PROCESS | 8751 | 22:57:53 INFO - PROCESS | 8751 | [#4] audio-oscillator Cycles:10 Average:108.40 Median:95.00 stddev:21.89 (23.0%) stddev-sans-first:22.59 22:57:53 INFO - PROCESS | 8751 | Values: 94.0 95.0 146.0 95.0 96.0 94.0 142.0 95.0 96.0 131.0 22:57:53 INFO - PROCESS | 8751 | 22:57:53 INFO - PROCESS | 8751 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 22:57:53 INFO - PROCESS | 8751 | Values: 116.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 22:57:53 INFO - PROCESS | 8751 | 22:57:53 INFO - PROCESS | 8751 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 22:57:53 INFO - PROCESS | 8751 | Values: 147.0 148.0 147.0 146.0 146.0 147.0 146.0 147.0 146.0 146.0 22:57:53 INFO - PROCESS | 8751 | 22:57:53 INFO - PROCESS | 8751 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 22:57:53 INFO - PROCESS | 8751 | Values: 96.0 95.0 95.0 96.0 95.0 95.0 96.0 96.0 95.0 95.0 22:57:53 INFO - PROCESS | 8751 | 22:57:53 INFO - PROCESS | 8751 | [#8] json-parse-financial Cycles:10 Average:70.60 Median:70.00 stddev:3.17 (4.5%) stddev-sans-first:3.36 22:57:53 INFO - PROCESS | 8751 | Values: 71.0 69.0 70.0 71.0 70.0 70.0 70.0 79.0 67.0 69.0 22:57:53 INFO - PROCESS | 8751 | 22:57:53 INFO - PROCESS | 8751 | [#9] json-stringify-tinderbox Cycles:10 Average:70.20 Median:70.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 22:57:53 INFO - PROCESS | 8751 | Values: 70.0 69.0 71.0 70.0 71.0 70.0 71.0 70.0 70.0 70.0 22:57:53 INFO - PROCESS | 8751 | 22:57:53 INFO - PROCESS | 8751 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:82.00 stddev:2.12 (2.6%) stddev-sans-first:2.17 22:57:53 INFO - PROCESS | 8751 | Values: 81.0 81.0 84.0 81.0 88.0 82.0 82.0 82.0 83.0 82.0 22:57:53 INFO - PROCESS | 8751 | 22:57:53 INFO - PROCESS | 8751 | [#11] stanford-crypto-ccm Cycles:10 Average:122.70 Median:123.50 stddev:3.43 (2.8%) stddev-sans-first:3.06 22:57:53 INFO - PROCESS | 8751 | Values: 128.0 124.0 119.0 118.0 124.0 122.0 120.0 123.0 121.0 128.0 22:57:53 INFO - PROCESS | 8751 | 22:57:53 INFO - PROCESS | 8751 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.70 Median:150.50 stddev:8.22 (5.5%) stddev-sans-first:8.63 22:57:53 INFO - PROCESS | 8751 | Values: 153.0 144.0 169.0 150.0 151.0 140.0 151.0 150.0 149.0 140.0 22:57:53 INFO - PROCESS | 8751 | 22:57:53 INFO - PROCESS | 8751 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:72.00 stddev:1.43 (2.0%) stddev-sans-first:1.50 22:57:53 INFO - PROCESS | 8751 | Values: 71.0 73.0 72.0 73.0 70.0 70.0 70.0 72.0 74.0 71.0 22:57:53 INFO - PROCESS | 8751 | -------- Summary: end -------- 22:57:53 INFO - PROCESS | 8751 | 22:57:54 INFO - TEST-INFO | 8751: exit 0 22:57:54 INFO - TEST-OK | kraken | took 62828ms 22:57:54 INFO - SUITE-END | took 1180s 22:57:54 INFO - Completed test suite (00:19:40) 22:57:54 INFO - javascript benchmark 22:57:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2602.531544322022, 2622.632831403605, 2670.279024663341, 2670.7863370930327, 2673.8262012969158, 4455.108978204364, 4517.5256598057185, 4533.501314855367, 4567.543245675431, 4569.4745104313015, 4528.275475923853, 4587.655925805561, 4623.30650402439, 4656.650751193657, 4659.254519276908, 4246.554111818261, 4249.3413520904305, 4254.6170844623975, 4288.356746488021, 4419.64642828573, 4091.1817636472674, 4325.718828276152, 4362.1275744851, 4386.736795792247, 4390.670699697535, 4143.7720925349095, 4185.351270553069, 4198.643115335185, 4207.032382552, 4217.325227963542, 4235.449391579105, 4268.146370725836, 4272.46594175728, 4301.376300436419, 4310.331898555729, 4074.1444296697728, 4247.193033323659, 4263.8081286342185, 4269.850555230552, 4299.07569872479, 4489.304157855538, 4524.140413321458, 4542.863714088583, 4583.060472603109, 4583.747893865836, 4796.496367881392, 4805.927911081337, 4810.63920205986, 4814.446338671062, 4832.565069143794, 4819.807207711688, 4821.831235906761, 4852.781624826891, 4861.586765124934, 4892.68197567157, 4577.267637178035, 4597.885052873705, 4601.0, 4606.170889239936, 4638.536146385402, 5019.874503137377, 5020.422651395136, 5021.6735912165595, 5028.094942910238, 5066.569341606005, 4773.498782627844, 4829.492903245179, 4845.685030473008, 4846.200376937766, 4918.0901533216465, 4861.27080937855, 4879.219324908068, 4880.633952453581, 4890.24201248807, 4914.975425122851, 4815.133276010351, 4837.95162048382, 4838.201696720002, 4840.346553215341, 4878.853634390974, 4741.383620129361, 4794.640401969797, 4797.208460604031, 4862.756862156878, 4879.1461494238365, 4050.817713202854, 4055.8174882130374, 4058.066644671742, 4058.7970601470397, 4082.4896887889013, 3575.785452872836, 3580.785152890835, 3587.6053634100226, 3601.693856022215, 3612.151144481045, 4099.057216840084, 4174.979125104355, 4198.097409057006, 4275.123599662062, 4276.465441819772, 4865.878353041202, 4868.707877527359, 4868.853934381974, 4879.2925025871045, 4893.779779909842, 4198.685098617616, 4199.580041995837, 4199.97900010498, 4203.978980105141, 4236.216299984513, 4218.17745539623, 4331.0, 4368.978155109267, 4393.846215382447, 4404.911901761947, 4624.606908412823, 4632.420947381577, 4647.62818974488, 4649.604783593432, 4693.55411235932, 4726.243800991825, 4858.441279252931, 4863.95136048635, 4865.294532292868, 4909.116359055404, 4535.934055497021, 4593.425821772278, 4617.0, 4641.930371044505, 4672.205725026822, 4692.061587682409, 4704.059188162313, 4710.623150148049, 4722.433308002925, 4738.739369334719, 4800.255960326155, 4800.495947925558, 4848.9757551212015, 4863.902721945612, 4949.232868905326, 4633.212353899912, 4655.301704744315, 4692.601128904082, 4704.553067458586, 4738.218193997952, 4698.036902434924, 4700.2244629635725, 4702.0, 4736.029114031684, 4738.407699037621, 4563.292689633112, 4594.448666160082, 4615.353850461005, 4619.953800461953, 4643.326717625858, 4726.1729197391005, 4748.810047598057, 4756.19144745401, 4756.738379389167, 4758.595519380891, 4664.0, 4668.5798278155125, 4669.48635650085, 4675.3688252086895, 4684.016356565159], "unit": "score", "name": "dojo.html", "value": 4479.012755369515}, {"lowerIsBetter": false, "replicates": [461.6330017635979, 471.83485779977013, 473.9691920025196, 477.58450148370923, 498.11335822236407, 22501.21245756399, 22955.770442295594, 28696.282592935186, 28723.42553148941, 28773.0, 30610.0, 31253.687463125363, 31255.531167032514, 31376.68623313772, 31558.68441315586, 7417.406607471403, 7591.924080759204, 7597.696092156307, 7601.543907365576, 7602.923970760305, 7506.587137707424, 7614.961925190366, 7619.619019049025, 7627.161012288644, 7629.8474030519355, 7784.727534536292, 7868.52788832669, 7881.9359386482665, 7891.210878912091, 7894.407919406039, 7733.690652373926, 7749.108852481981, 7807.687692492322, 7815.335696465807, 7819.3744500439825, 7559.130699969519, 7678.616069196573, 7684.654190561382, 7685.769426917202, 7690.077190737092, 30787.076387708406, 31040.8447957761, 31064.534031989537, 31168.0, 31332.530012049836, 2559.948801023988, 2642.5771876499666, 2679.9062032828756, 2735.00172437061, 3008.6389633244153, 24190.032398704032, 24297.0, 24306.513869722683, 24343.14798982027, 24392.760243838362, 3351.6648335166533, 3359.4624860022523, 3382.594088709346, 3409.130671678731, 3504.123969007748, 204397.0, 204688.0, 204836.0, 205489.97255013778, 206040.0, 38225.61774382276, 38451.807740961114, 39140.41289380661, 39166.412503811895, 39627.0, 42597.78701106475, 44205.0, 44763.0, 44809.55190448054, 44812.55187448149, 11455.885441145649, 11687.123465740104, 11733.4719937603, 11982.520699171935, 11998.160128791076, 7945.920540794634, 7968.402369822286, 7974.082980457321, 7990.360771138295, 8008.839823203503, 14366.13803171813, 14366.712665746627, 14475.276236188149, 14520.564383068524, 14921.104733716013, 5869.0, 5976.9540330442, 6056.36408177135, 6085.2393450818645, 6128.3258841527395, 719.0400814912047, 772.0388116794514, 777.2654841175035, 787.696736756353, 807.0799288810761, 22740.772592273865, 23290.65064024041, 23373.181938632068, 23451.530969380517, 23732.0, 789.9170587088388, 835.9916400835914, 837.2673910328463, 860.3031544448892, 935.8689783430325, 11841.171118021655, 12257.080718946114, 12342.197757145757, 12370.81443778344, 12387.814182787266, 257025.0, 262430.3177261713, 263319.0, 263697.0, 264033.0, 37215.0, 37363.0, 37544.43683344752, 37611.247775044896, 37713.62286377101, 980.4411485453223, 993.1756641987133, 1015.1016350529834, 1016.11090295991, 1018.9694309170885, 22481.550368992856, 22739.545209096057, 22911.770882290963, 22960.540789184455, 23019.88490057539, 33226.335473290885, 33233.50149747804, 33480.49779253362, 33510.32979340448, 33596.66403335935, 250091.0, 251495.0, 251524.0, 252060.0, 252410.0, 22125.66811497861, 25014.374640633403, 25456.618150727383, 25797.6130358041, 25933.740662593133, 28932.710672893, 29374.118776436742, 29596.0, 29614.259643509085, 29614.703852962055, 25940.740592593833, 26011.609825853007, 26533.734662653125, 27758.44483110367, 28599.714002859706, 27087.0, 27171.1848644541, 27191.0, 27230.319242019108, 27389.0, 25107.99568017259, 25400.237992860242, 25466.490670186122, 25502.489950201263, 25844.483110338064, 24441.755582443948, 25320.873395632905, 25360.0, 25428.237152885442, 25693.61459578145, 20264.493387665425, 20832.68750968767, 20867.373978780663, 20957.476063098544, 20961.161553537688], "unit": "score", "name": "ext.html", "value": 14436.50334228426}, {"lowerIsBetter": false, "replicates": [308.8147111732959, 317.54115303386584, 321.46476117264757, 322.4695376106305, 327.91965968337746, 13958.51145209918, 14331.068480548756, 14439.133651980876, 14452.20512871793, 14696.338664760086, 12712.809307860389, 12898.484060637564, 12931.224126552414, 13025.0, 13180.604581862535, 4797.760111994395, 4931.186354251544, 4959.900801983958, 4959.925601115986, 4960.801567937297, 4770.4275486941615, 4833.975830120845, 4834.782434790425, 4854.490278520758, 4855.0, 4789.976050119744, 4806.543378379066, 4878.292647566101, 4885.43817460993, 4945.455999840015, 4831.565159135659, 4884.072026314989, 4884.29177769225, 4907.828226012072, 4909.091818013679, 4307.375430562551, 4368.672349573763, 4369.344598310279, 4375.343698445258, 4378.978105109454, 17154.399596014206, 17259.482215533553, 17634.206460709298, 17903.0, 17907.1941762621, 1685.755565443004, 1785.8571314294954, 1790.5255107396551, 1869.5886904880904, 2181.007641523119, 11532.481038353295, 11783.0, 11892.940535297355, 12150.878491215062, 12172.147949643528, 1758.78015248094, 1784.125778368603, 1790.9820901790945, 1797.2451570340488, 1817.6092140189924, 52392.99999999962, 52585.0, 53264.40206793803, 53719.73140134313, 54289.185662215095, 8902.777430564158, 9174.981504069094, 9190.586423610954, 9364.719058428122, 9372.437653740797, 11416.714582135513, 11439.199256052163, 11506.137039722054, 11518.769624607461, 11535.134864885167, 6036.698165091816, 6082.9695851520455, 6175.69121543921, 6179.474744646665, 6243.157173781572, 5597.893169291001, 6095.146679464879, 6097.786577469856, 6258.561900667, 6280.811575652738, 3862.575116737157, 3928.1750832325533, 3943.3493473576536, 3961.7821019844187, 4000.439938408625, 1632.7061128996895, 1657.2211060801403, 1658.610226596773, 1682.4532027091, 1702.9744553831454, 768.5696010234286, 778.9493682910593, 794.5749024271987, 807.1887752808507, 850.9446885952393, 13879.791803122962, 14437.278136093153, 14461.27693615315, 14503.419863205565, 14533.85466145325, 753.9472236943361, 767.0603510699349, 767.3630886364305, 809.8380323935237, 826.3595713322223, 8044.597770111471, 8045.919540804634, 8118.837623247502, 8261.13258107902, 8339.20777526134, 281851.0, 366810.0, 380291.0, 380406.0, 382411.0, 51635.48364516382, 59379.40620593739, 62492.37507624865, 62923.6853815728, 68547.31452685509, 782.7847341981001, 924.6624981881699, 927.2628260532892, 958.8753462049889, 963.710886733977, 12565.120441569368, 12846.67883302925, 12871.549495767604, 13049.478020879058, 13056.477740890257, 31020.53469198009, 32037.519437208928, 32067.0, 32147.19632009125, 32590.185245369055, 38482.6151738479, 39019.609803902735, 41142.79428602838, 41443.79278103711, 41672.3749143757, 6785.762498312535, 6892.241853396022, 6939.155454006891, 7050.224475307609, 7092.574445533284, 9493.952530237304, 10376.584936602754, 10475.633352832614, 10530.526126324181, 10785.838212426663, 8813.454836512468, 8915.777105572153, 9268.490233037248, 9357.906420935704, 9437.528123593931, 8539.188777066169, 8582.0, 8992.55037248148, 9099.226565741987, 9156.725298241063, 8774.824503509766, 8925.955370223108, 9000.36997410175, 9027.187553120251, 9543.379680320757, 6628.370304821035, 6629.436497897733, 6882.105326307548, 6915.273896240822, 6952.165740111219, 9093.727188184364, 9296.95351523238, 9347.485888276211, 9550.85673714881, 9637.71086867395], "unit": "score", "name": "jquery.html", "value": 7293.557591935395}, {"lowerIsBetter": false, "replicates": [1054.9841752373711, 1106.6569363497315, 1113.6770336602385, 1121.8653761548615, 1287.0668765145272, 6186.721597528111, 6968.756093536727, 7097.964510177455, 7121.715131394738, 7125.6793444295, 6778.152730908637, 6904.1714994200765, 6911.377975982161, 6917.51577389583, 6935.306469353062, 1664.2261348472957, 1703.8466538011576, 1705.9317627294893, 2023.3929821053698, 2035.2571311471354, 1745.8952462852205, 2049.231538173185, 2101.506146055676, 2103.3584756649216, 2103.663413853784, 2046.9795302047012, 2051.169276443043, 2052.1791283486577, 2057.4547744847628, 2058.670612701968, 1951.736515570394, 2020.5049762808133, 2020.919163233469, 2024.2712623455545, 2026.9797302026939, 1966.1152481383435, 2000.8499362547868, 2001.86987845791, 2015.647261729206, 2025.463252238158, 7301.561906285639, 7347.742829000959, 7357.043584334056, 7373.225811289791, 7376.225496322916, 4145.937810932808, 4301.677374196947, 4303.720258183208, 4306.80619372129, 4308.892277693051, 2641.4320921002077, 2715.0361621624434, 2761.502929472694, 2764.2536515141, 2795.0636536760207, 784.2275358771606, 796.7888509544975, 806.6692656011007, 816.4774544291598, 824.2293455619016, 9999.100080992746, 10009.0, 10011.699649010541, 10084.445355505444, 10086.344387614781, 3914.451976723261, 4001.579834117434, 4008.4367096832257, 4080.3879418087527, 4101.753894766323, 8368.37237207212, 8425.283850872744, 8447.45091569046, 8450.154984501502, 8478.448900821428, 4177.644900183518, 4178.331466965271, 4180.122174343361, 4181.644560212355, 4183.895402614959, 3176.571162893026, 3271.1985563537087, 3723.888283351504, 3746.1383881706815, 3755.2489502099143, 3049.557814116941, 3108.3006323577465, 3273.3126043530647, 3329.9833500832824, 3349.3468773588916, 1045.900639439252, 1084.3710647824244, 1088.684281558355, 1097.3306283167262, 1102.9889701102886, 838.2455789789117, 843.2874221283006, 852.8720691896265, 1036.652721338345, 1082.5994382078525, 6654.367835055662, 6713.26154123046, 6739.393454589012, 6742.123523941857, 6772.356626120609, 923.7182659288982, 937.6952490440634, 940.2853831088422, 967.2165545907696, 968.3512046928574, 5294.867628309246, 5348.973255133699, 5409.459054094559, 5413.350397952192, 5422.078246698071, 8470.449420787629, 8763.956180219186, 8828.470291782514, 9082.091790820998, 9089.81820363589, 8952.14954579314, 8967.730968070839, 8999.595018224196, 9079.636814527477, 9102.317326200562, 6348.333424990402, 6524.119243902012, 6828.146481689789, 6897.965510172417, 6905.240423553405, 6651.866962660622, 6683.9331606685255, 6703.02806093104, 6729.69716362755, 6748.628825414649, 7522.022137122139, 7579.583122928071, 7698.03774528184, 7764.805879852823, 7788.0, 7701.1143718473095, 7936.166702496154, 7954.125046244792, 7990.161033091675, 8069.636866340911, 5998.580099393001, 6061.848453788514, 6069.939300606938, 6073.453389194994, 6078.939210607838, 6330.208723909512, 6446.8388290293115, 6459.0, 6478.028295755675, 6478.902816457663, 5638.633488823213, 5759.193712880284, 5777.884442311214, 5796.652200867961, 5842.853928651818, 5581.134924086773, 5625.240592520121, 5663.9716801415725, 5689.459501347365, 5731.0, 5853.531717462678, 5882.0, 5922.111683247547, 5939.554533410098, 5992.9700351499705, 5573.832785016456, 5734.856628584319, 5743.310802703702, 5746.42535746422, 5781.710914454345, 5501.642393244426, 5509.421510741475, 5525.198846167203, 5535.114381698909, 5535.501804837584], "unit": "score", "name": "mootools.html", "value": 3961.0120424822862}, {"lowerIsBetter": false, "replicates": [292.122172870524, 293.398533007335, 295.12348325473346, 296.7625899280575, 299.52525247482737, 5233.8953220935555, 5271.367435907687, 5283.181106928428, 5287.259783630295, 5290.470952904712, 5292.550133238679, 5334.653247538908, 5357.7589008494615, 5362.410134885169, 5369.328833895763, 3820.3505404081234, 3941.389084691863, 4073.490813648294, 4075.714699971003, 4105.1379210365785, 4065.4714887064642, 4075.470188875442, 4081.653059489947, 4082.3672330788777, 4091.3249313863175, 4031.8185681644395, 4038.2125485530332, 4038.919221615566, 4040.797960101998, 4051.1897620475875, 3806.5812760596314, 3904.9414258786283, 4020.537638171589, 4025.6175663311938, 4026.094128820992, 3464.9826750866087, 3467.063892748969, 3472.9131771705656, 3477.23500829817, 3478.0, 5136.255242989783, 5142.794288228466, 5149.665271757323, 5150.562202212779, 5158.329417175743, 4600.976995115003, 4602.838900638495, 4605.516420775837, 4610.147122782262, 4612.976935115303, 5555.0, 5561.388247292794, 5561.694106824123, 5567.331920169565, 5567.47109024642, 3770.3967365221706, 3771.849126034955, 3775.9811200944096, 3781.735278530504, 3783.886483405502, 5620.3784686332, 5790.739416726257, 5854.6194497357965, 5859.35547089824, 5861.736221869984, 3849.711271654637, 3872.302985462644, 3873.3028054949814, 3874.9806250968563, 3880.049387899983, 3926.2147570485445, 3927.116398810245, 3927.4697915781576, 3937.625925537069, 3937.7440466369594, 4564.7717614119165, 4571.451425828922, 4574.108048930427, 4575.633949284049, 4580.312953057068, 5553.333599968029, 5556.361018482926, 5559.749811258423, 5565.0, 5565.972170139124, 1353.911995720275, 1367.0703921333588, 1367.4188469900253, 1368.2337890781193, 1371.149887070023, 833.3000279764906, 846.0, 921.4287141971886, 939.8684184214216, 941.1388579449726, 4831.492693267227, 4870.683405578697, 4875.366202393737, 4876.463589005207, 4883.536064073907, 5723.799667011718, 5748.798792042258, 5778.104393818965, 5795.043817770021, 5800.013997620415, 4850.83022094225, 4858.416989961227, 4859.392575928009, 4861.222204447272, 4861.343718597944, 3051.130427828058, 3082.5222090576, 3086.5215891536845, 3088.042706760866, 3089.382123575294, 5424.864378390572, 5428.0, 5430.104032834538, 5430.348358196962, 5434.239206511092, 5698.715064246771, 5870.148828419855, 5875.41245875409, 5894.0, 5896.734646940898, 5404.702741349185, 5421.0, 5425.972870135624, 5431.185322201702, 5441.8095366662765, 5698.373178950395, 5712.7714891403875, 5720.971395142998, 5722.027255366681, 5724.771009159587, 5565.972170139124, 5588.972055139699, 5592.384837667934, 5597.860053498695, 5601.271834661468, 5421.2681288025615, 5424.484673955968, 5426.511613954605, 5428.755705993319, 5429.1313389859015, 3693.224422871227, 3805.828737706865, 3816.1413681922454, 3818.465414841869, 3830.6935445164877, 5689.374168841341, 5696.629719068247, 5703.771849126155, 5714.885702286014, 5725.799597014085, 5303.257543943774, 5451.809186678447, 5483.314585676791, 5489.204065410573, 5583.218349431164, 5575.749091290821, 5580.051391263576, 5580.888382232251, 5586.52514536269, 5587.832365029056, 5464.945350546603, 5475.67145971243, 5481.095619222783, 5481.643693159932, 5484.506394424521, 5616.0, 5621.578381621313, 5625.071863142535, 5628.0432326505415, 5630.5777066720975, 5478.616496845182, 5488.670679759227, 5492.862678432912, 5493.0, 5502.119660854244], "unit": "score", "name": "prototype.html", "value": 4126.565130254924}, {"lowerIsBetter": false, "replicates": [526.976286067127, 528.4213785904436, 550.2324257660562, 562.4993755557555, 591.1930215256175, 10430.322029068106, 10566.313189642688, 10615.681529554126, 10619.25665203436, 10625.149988000961, 9944.801103977916, 9984.951580084078, 10004.799904001915, 10420.791584168312, 11151.219414640978, 501.20058506681875, 504.8182654244469, 505.6056276104644, 507.3049921607403, 508.4965883775073, 523.8140460136653, 528.4556906386429, 531.6544246239936, 534.5883669574425, 541.1368866657675, 548.4131978782705, 549.1762356465302, 549.64547866626, 553.5792797473929, 553.6069390732584, 567.6735876870816, 568.2243737298598, 569.9943000569982, 570.7346084070906, 575.6948817126888, 416.2382839403884, 418.374530077536, 419.850952911718, 419.96640268778424, 424.7939749221656, 11004.449777511092, 11025.669229923114, 11099.556017759362, 11103.666889993314, 11128.554857805679, 10237.641682541076, 10577.36535807854, 10701.143908487302, 10722.249442539025, 10742.355458672504, 7659.119201291867, 7952.403569732235, 8322.70870519529, 8323.209295116954, 8425.873611895826, 3019.5772591837163, 3019.6527399348915, 3068.8925887593828, 3069.1866655336353, 3078.1381213260324, 35485.29029419397, 35555.822220888986, 39508.60491395078, 39720.80139599313, 41265.174696506205, 8441.282490988211, 8456.2812160967, 8591.5704214789, 8606.632625211509, 8692.087330830298, 13783.035187536776, 13787.034907556375, 13916.860831391556, 13940.860591393955, 13989.30053497321, 5949.0481522956115, 6071.392860713893, 6169.907451388232, 6199.380061993765, 6266.905996410058, 3289.934201316008, 3294.472884338494, 3299.703026727606, 3446.0, 3480.460528618068, 2245.259064508708, 2260.4235919840335, 2266.8753218572806, 2270.3756466971713, 2270.3869955112027, 416.20297130993805, 419.7691269801658, 431.09685209486076, 431.42620314981, 433.6552440809564, 481.7856054055911, 486.7104073076514, 534.2840593604589, 553.950144486998, 568.2640979930999, 6860.0, 7023.122109736283, 7046.964765176142, 7235.204127545966, 7257.45569082321, 425.0478927203105, 473.412967919777, 522.7699812082672, 546.1970902772997, 560.3332034878482, 3285.4414749492644, 3324.1357247115925, 3438.8452519636676, 3447.500112483676, 3458.9308213836084, 46601.766991164826, 47053.29420058702, 47449.76275118671, 47592.286115708295, 47641.28538071932, 42470.57529424728, 42851.78574107109, 43387.13225735468, 43514.12971740548, 43751.34372984408, 33747.49378759321, 34548.30903381918, 38819.80590097088, 41052.79473602673, 41081.0, 6773.424258938046, 6783.3555812197765, 6855.211650660238, 6905.0, 6919.342662447059, 29330.560041598965, 29448.11655650334, 30346.69653303439, 30577.08268751941, 30611.693883061776, 35928.0, 36626.26747464982, 36647.45028824516, 36763.63236367602, 36827.447588285664, 8341.0, 8605.440646357967, 8610.268127209258, 8684.131586841519, 8978.685745998859, 9810.558524866256, 10118.038786315288, 10166.135878450119, 10213.846792297973, 10253.897461025294, 9469.715908522756, 9474.336796424184, 9698.56356463975, 9734.318597698093, 10151.898481015096, 8628.266597339296, 8713.433626814236, 8814.779630509289, 8925.866112008454, 8938.553072346227, 9682.661106861226, 9954.352967057408, 10054.64808731691, 10325.173986081245, 10410.895891040993, 8152.184781521801, 8273.958630206811, 8275.08974012846, 8462.0, 8671.956640216758, 8402.201790829862, 8545.102764209669, 8573.957130214309, 8702.782430439289, 8989.775255618662], "unit": "score", "name": "yui.html", "value": 4967.607165483505}], "name": "dromaeo_css", "value": 5805.785480105759}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 114.0, 109.0, 112.0, 114.0, 115.0, 103.0, 113.0, 113.0, 113.0], "unit": "score", "name": "ai-astar", "value": 111.8}, {"lowerIsBetter": true, "replicates": [160.0, 133.0, 163.0, 171.0, 134.0, 159.0, 171.0, 134.0, 180.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 154.0}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 160.0, 160.0, 161.0, 162.0, 161.0, 162.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 74.0, 151.0, 74.0, 74.0, 74.0, 74.0, 162.0, 74.0], "unit": "score", "name": "audio-fft", "value": 90.5}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 146.0, 95.0, 96.0, 94.0, 142.0, 95.0, 96.0, 131.0], "unit": "score", "name": "audio-oscillator", "value": 108.4}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.0}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [71.0, 69.0, 70.0, 71.0, 70.0, 70.0, 70.0, 79.0, 67.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 70.6}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 71.0, 70.0, 71.0, 70.0, 71.0, 70.0, 70.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.2}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 84.0, 81.0, 88.0, 82.0, 82.0, 82.0, 83.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.6}, {"lowerIsBetter": true, "replicates": [128.0, 124.0, 119.0, 118.0, 124.0, 122.0, 120.0, 123.0, 121.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.7}, {"lowerIsBetter": true, "replicates": [153.0, 144.0, 169.0, 150.0, 151.0, 140.0, 151.0, 150.0, 149.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.7}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 72.0, 73.0, 70.0, 70.0, 70.0, 72.0, 74.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.6}], "name": "kraken", "value": 1552.0}]} 22:57:54 INFO - Return code: 0 22:57:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:57:54 INFO - # TBPL SUCCESS # 22:57:54 INFO - Running post-action listener: _resource_record_post_action 22:57:54 INFO - Running post-run listener: _resource_record_post_run 22:57:55 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 521752576; Read time: 20; Write time: 430580 22:57:55 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 233644032; Read time: 0; Write time: 242608 22:57:55 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288108544; Read time: 20; Write time: 187972 22:57:55 INFO - Running post-run listener: _upload_blobber_files 22:57:55 INFO - Blob upload gear active. 22:57:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:57:55 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 22:57:55 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:57:55 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:57:56 INFO - (blobuploader) - INFO - Open directory for files ... 22:57:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:57:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:57:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:57:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:57:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:57:57 INFO - (blobuploader) - INFO - Done attempting. 22:57:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:57:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:57:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:57:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:57:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:57:57 INFO - (blobuploader) - INFO - Done attempting. 22:57:57 INFO - (blobuploader) - INFO - Iteration through files over. 22:57:57 INFO - Return code: 0 22:57:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:57:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:57:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7a3fb194218f48f8a46004540b09ef517c2191e5ed93ec091423a1dd37c896f7c6c4159aea80590c718b1c8397f23098c427f892b712c999b2c13ef99ef1474b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3855d7cb8c45b8e46718cb082aaaf38e7388690d9c07b1e23c9fea7f046628391b3a057560cbad11f9b8d2fdc8ab2f965820e2371e1baa70cc6414deb382981a"} 22:57:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:57:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:57:57 INFO - Contents: 22:57:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7a3fb194218f48f8a46004540b09ef517c2191e5ed93ec091423a1dd37c896f7c6c4159aea80590c718b1c8397f23098c427f892b712c999b2c13ef99ef1474b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3855d7cb8c45b8e46718cb082aaaf38e7388690d9c07b1e23c9fea7f046628391b3a057560cbad11f9b8d2fdc8ab2f965820e2371e1baa70cc6414deb382981a"} 22:57:57 INFO - Running post-run listener: copy_logs_to_upload_dir 22:57:57 INFO - Copying logs to upload dir... 22:57:57 INFO - mkdir: /builds/slave/test/build/upload/logs 22:57:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.976537 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-03-06 22:57:57.192763) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-06 22:57:57.196639) ========= 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=eca2ab57546de7b41f256b19000001ef-1457329280.958662-1898847378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7a3fb194218f48f8a46004540b09ef517c2191e5ed93ec091423a1dd37c896f7c6c4159aea80590c718b1c8397f23098c427f892b712c999b2c13ef99ef1474b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3855d7cb8c45b8e46718cb082aaaf38e7388690d9c07b1e23c9fea7f046628391b3a057560cbad11f9b8d2fdc8ab2f965820e2371e1baa70cc6414deb382981a"} build_url:https://queue.taskcluster.net/v1/task/K--FhUhsTCmoemtg8APFhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011488 build_url: 'https://queue.taskcluster.net/v1/task/K--FhUhsTCmoemtg8APFhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7a3fb194218f48f8a46004540b09ef517c2191e5ed93ec091423a1dd37c896f7c6c4159aea80590c718b1c8397f23098c427f892b712c999b2c13ef99ef1474b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3855d7cb8c45b8e46718cb082aaaf38e7388690d9c07b1e23c9fea7f046628391b3a057560cbad11f9b8d2fdc8ab2f965820e2371e1baa70cc6414deb382981a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-06 22:57:57.222079) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 22:57:57.222406) ========= 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=eca2ab57546de7b41f256b19000001ef-1457329280.958662-1898847378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004541 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 22:57:57.306040) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-06 22:57:57.306359) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-06 22:57:57.306636) ========= ========= Total master_lag: 1.17 =========