builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-064 starttime: 1457419924.69 results: success (0) buildid: 20160307213736 builduid: 7df4401702494fc59225da265697ff43 revision: 557e8160f3518163e4d734852f376bc17da0a9b0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-07 22:52:04.686186) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-07 22:52:04.686687) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-07 22:52:04.687086) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1457418317.89644-1415155459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006459 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-07 22:52:04.718624) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-07 22:52:04.718924) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-07 22:52:05.259337) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 22:52:05.259647) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1457418317.89644-1415155459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004632 ========= master_lag: 0.56 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 22:52:05.827389) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-07 22:52:05.827712) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-07 22:52:05.828047) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 22:52:05.828338) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1457418317.89644-1415155459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-07 22:52:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 48.0K=0.2s 2016-03-07 22:52:06 (48.0 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.416086 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 22:52:06.265298) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 22:52:06.265590) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1457418317.89644-1415155459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013504 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 22:52:06.316812) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 22:52:06.317156) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 557e8160f3518163e4d734852f376bc17da0a9b0 --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 557e8160f3518163e4d734852f376bc17da0a9b0 --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=a12cd81e0ef515edd9e0d800000001bb-1457418317.89644-1415155459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-07 22:52:06,781 truncating revision to first 12 chars 2016-03-07 22:52:06,781 Setting DEBUG logging. 2016-03-07 22:52:06,781 attempt 1/10 2016-03-07 22:52:06,781 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/557e8160f351?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-07 22:52:07,044 unpacking tar archive at: fx-team-557e8160f351/testing/mozharness/ program finished with exit code 0 elapsedTime=0.568416 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 22:52:06.899059) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-07 22:52:06.899378) ========= echo 557e8160f3518163e4d734852f376bc17da0a9b0 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'557e8160f3518163e4d734852f376bc17da0a9b0'] 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=a12cd81e0ef515edd9e0d800000001bb-1457418317.89644-1415155459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 557e8160f3518163e4d734852f376bc17da0a9b0 program finished with exit code 0 elapsedTime=0.004718 script_repo_revision: '557e8160f3518163e4d734852f376bc17da0a9b0' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-07 22:52:06.951733) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-07 22:52:06.952008) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-07 22:52:06.962415) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-03-07 22:52:06.962677) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=a12cd81e0ef515edd9e0d800000001bb-1457418317.89644-1415155459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:52:07 INFO - MultiFileLogger online at 20160307 22:52:07 in /builds/slave/test 22:52:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:52:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:52:07 INFO - {'append_to_log': False, 22:52:07 INFO - 'base_work_dir': '/builds/slave/test', 22:52:07 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:52:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:52:07 INFO - 'branch': 'Fx-Team-Non-PGO', 22:52:07 INFO - 'buildbot_json_path': 'buildprops.json', 22:52:07 INFO - 'config_files': ('talos/linux_config.py',), 22:52:07 INFO - 'default_actions': ('clobber', 22:52:07 INFO - 'read-buildbot-config', 22:52:07 INFO - 'download-and-extract', 22:52:07 INFO - 'populate-webroot', 22:52:07 INFO - 'create-virtualenv', 22:52:07 INFO - 'install', 22:52:07 INFO - 'run-tests'), 22:52:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:52:07 INFO - 'download_minidump_stackwalk': True, 22:52:07 INFO - 'download_symbols': 'ondemand', 22:52:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:52:07 INFO - 'tooltool.py': '/tools/tooltool.py', 22:52:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:52:07 INFO - '/tools/misc-python/virtualenv.py')}, 22:52:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:52:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:52:07 INFO - 'installer_path': 'installer.exe', 22:52:07 INFO - 'log_level': 'info', 22:52:07 INFO - 'log_name': 'talos', 22:52:07 INFO - 'log_to_console': True, 22:52:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:52:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:52:07 INFO - 'opt_config_files': (), 22:52:07 INFO - 'pip_index': False, 22:52:07 INFO - 'sps_profile': False, 22:52:07 INFO - 'sps_profile_interval': 0, 22:52:07 INFO - 'suite': 'dromaeojs-e10s', 22:52:07 INFO - 'system_bits': '32', 22:52:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:52:07 INFO - 'title': 'talos-linux64-ix-064', 22:52:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:52:07 INFO - 'use_talos_json': True, 22:52:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:52:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:52:07 INFO - 'work_dir': 'build'} 22:52:07 INFO - ##### 22:52:07 INFO - ##### Running clobber step. 22:52:07 INFO - ##### 22:52:07 INFO - Running pre-action listener: _resource_record_pre_action 22:52:07 INFO - Running main action method: clobber 22:52:07 INFO - rmtree: /builds/slave/test/build 22:52:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:52:07 INFO - Running post-action listener: _resource_record_post_action 22:52:07 INFO - ##### 22:52:07 INFO - ##### Running read-buildbot-config step. 22:52:07 INFO - ##### 22:52:07 INFO - Running pre-action listener: _resource_record_pre_action 22:52:07 INFO - Running main action method: read_buildbot_config 22:52:07 INFO - Using buildbot properties: 22:52:07 INFO - { 22:52:07 INFO - "project": "", 22:52:07 INFO - "product": "firefox", 22:52:07 INFO - "script_repo_revision": "production", 22:52:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:52:07 INFO - "repository": "", 22:52:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 22:52:07 INFO - "buildid": "20160307213736", 22:52:07 INFO - "pgo_build": "False", 22:52:07 INFO - "basedir": "/builds/slave/test", 22:52:07 INFO - "buildnumber": 977, 22:52:07 INFO - "slavename": "talos-linux64-ix-064", 22:52:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:52:07 INFO - "platform": "ubuntu64_hw", 22:52:07 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:52:07 INFO - "branch": "fx-team", 22:52:07 INFO - "repo_path": "integration/fx-team", 22:52:07 INFO - "revision": "557e8160f3518163e4d734852f376bc17da0a9b0", 22:52:07 INFO - "stage_platform": "linux64", 22:52:07 INFO - "builduid": "7df4401702494fc59225da265697ff43", 22:52:07 INFO - "slavebuilddir": "test" 22:52:07 INFO - } 22:52:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/L0ZTin4pTeimAVyL1Cw1NQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 22:52:07 INFO - Running post-action listener: _resource_record_post_action 22:52:07 INFO - ##### 22:52:07 INFO - ##### Running download-and-extract step. 22:52:07 INFO - ##### 22:52:07 INFO - Running pre-action listener: _resource_record_pre_action 22:52:07 INFO - Running main action method: download_and_extract 22:52:07 INFO - mkdir: /builds/slave/test/build/tests 22:52:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:07 INFO - https://queue.taskcluster.net/v1/task/L0ZTin4pTeimAVyL1Cw1NQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:52:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L0ZTin4pTeimAVyL1Cw1NQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 22:52:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L0ZTin4pTeimAVyL1Cw1NQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 22:52:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L0ZTin4pTeimAVyL1Cw1NQ/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:52:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L0ZTin4pTeimAVyL1Cw1NQ/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:52:17 INFO - Downloaded 1448 bytes. 22:52:17 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 22:52:17 INFO - Using the following test package requirements: 22:52:17 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:52:17 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:52:17 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:52:17 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:52:17 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:52:17 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:52:17 INFO - u'jsshell-linux-x86_64.zip'], 22:52:17 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:52:17 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:52:17 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:52:17 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:52:17 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:52:17 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:52:17 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:52:17 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:52:17 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:52:17 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:52:17 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:52:17 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:52:17 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:52:17 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:52:17 INFO - https://queue.taskcluster.net/v1/task/L0ZTin4pTeimAVyL1Cw1NQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:52:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L0ZTin4pTeimAVyL1Cw1NQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:52:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L0ZTin4pTeimAVyL1Cw1NQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:52:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L0ZTin4pTeimAVyL1Cw1NQ/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:52:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L0ZTin4pTeimAVyL1Cw1NQ/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:52:22 INFO - Downloaded 22092138 bytes. 22:52:22 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:52:22 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:52:23 INFO - Return code: 0 22:52:23 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:52:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:23 INFO - https://queue.taskcluster.net/v1/task/L0ZTin4pTeimAVyL1Cw1NQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:52:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L0ZTin4pTeimAVyL1Cw1NQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:52:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L0ZTin4pTeimAVyL1Cw1NQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:52:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L0ZTin4pTeimAVyL1Cw1NQ/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:52:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L0ZTin4pTeimAVyL1Cw1NQ/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:52:29 INFO - Downloaded 22092138 bytes. 22:52:29 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:52:29 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:52:31 INFO - Return code: 0 22:52: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:52:31 INFO - https://queue.taskcluster.net/v1/task/L0ZTin4pTeimAVyL1Cw1NQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:52:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L0ZTin4pTeimAVyL1Cw1NQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:52:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L0ZTin4pTeimAVyL1Cw1NQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:52:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L0ZTin4pTeimAVyL1Cw1NQ/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:52:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L0ZTin4pTeimAVyL1Cw1NQ/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:52:32 INFO - Downloaded 10845161 bytes. 22:52:32 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:52:32 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:52:32 INFO - Return code: 0 22:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:32 INFO - https://queue.taskcluster.net/v1/task/L0ZTin4pTeimAVyL1Cw1NQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:52:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L0ZTin4pTeimAVyL1Cw1NQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:52:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L0ZTin4pTeimAVyL1Cw1NQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:52:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L0ZTin4pTeimAVyL1Cw1NQ/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:52:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L0ZTin4pTeimAVyL1Cw1NQ/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:52:34 INFO - Downloaded 54407395 bytes. 22:52:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L0ZTin4pTeimAVyL1Cw1NQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:52:34 INFO - mkdir: /builds/slave/test/properties 22:52:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:52:34 INFO - Writing to file /builds/slave/test/properties/build_url 22:52:34 INFO - Contents: 22:52:34 INFO - build_url:https://queue.taskcluster.net/v1/task/L0ZTin4pTeimAVyL1Cw1NQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:52:34 INFO - Running post-action listener: _resource_record_post_action 22:52:34 INFO - Running post-action listener: set_extra_try_arguments 22:52:34 INFO - ##### 22:52:34 INFO - ##### Running populate-webroot step. 22:52:34 INFO - ##### 22:52:34 INFO - Running pre-action listener: _resource_record_pre_action 22:52:34 INFO - Running main action method: populate_webroot 22:52:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:52:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:52:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:52:34 INFO - '--tppagecycles', 22:52:34 INFO - '7'], 22:52:34 INFO - 'tests': ['tsvgm']}}, 22:52:34 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:52:34 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:52:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:52:34 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:52:34 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:52:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:52:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:52:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:52:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:52:34 INFO - 'talos_options': ['--e10s'], 22:52:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:52:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:52:34 INFO - 'tests': ['damp', 'tps']}, 22:52:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:52:34 INFO - 'talos_options': ['--e10s'], 22:52:34 INFO - 'tests': ['damp', 'tps']}, 22:52:34 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:52:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:52:34 INFO - 'other': {'tests': ['a11yr', 22:52:34 INFO - 'ts_paint', 22:52:34 INFO - 'tpaint', 22:52:34 INFO - 'sessionrestore', 22:52:34 INFO - 'sessionrestore_no_auto_restore', 22:52:34 INFO - 'tabpaint']}, 22:52:34 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:52:34 INFO - 'tests': ['a11yr', 22:52:34 INFO - 'ts_paint', 22:52:34 INFO - 'tpaint', 22:52:34 INFO - 'sessionrestore', 22:52:34 INFO - 'sessionrestore_no_auto_restore', 22:52:34 INFO - 'tabpaint']}, 22:52:34 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:52:34 INFO - 'tests': ['a11yr', 22:52:34 INFO - 'ts_paint', 22:52:34 INFO - 'tpaint', 22:52:34 INFO - 'sessionrestore', 22:52:34 INFO - 'sessionrestore_no_auto_restore', 22:52:34 INFO - 'tabpaint']}, 22:52:34 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:52:34 INFO - 'tests': ['a11yr', 22:52:34 INFO - 'ts_paint', 22:52:34 INFO - 'tpaint', 22:52:34 INFO - 'sessionrestore', 22:52:34 INFO - 'sessionrestore_no_auto_restore', 22:52:34 INFO - 'tabpaint']}, 22:52:34 INFO - 'other_l64': {'tests': ['a11yr', 22:52:34 INFO - 'ts_paint', 22:52:34 INFO - 'tpaint', 22:52:34 INFO - 'sessionrestore', 22:52:34 INFO - 'sessionrestore_no_auto_restore', 22:52:34 INFO - 'tabpaint']}, 22:52:34 INFO - 'other_nol64': {'tests': ['a11yr', 22:52:34 INFO - 'ts_paint', 22:52:34 INFO - 'tpaint', 22:52:34 INFO - 'sessionrestore', 22:52:34 INFO - 'sessionrestore_no_auto_restore', 22:52:34 INFO - 'tabpaint']}, 22:52:34 INFO - 'svgr': {'tests': ['tsvgx', 22:52:34 INFO - 'tsvgr_opacity', 22:52:34 INFO - 'tart', 22:52:34 INFO - 'tscrollx', 22:52:34 INFO - 'cart']}, 22:52:34 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:52:34 INFO - 'tests': ['tsvgx', 22:52:34 INFO - 'tsvgr_opacity', 22:52:34 INFO - 'tart', 22:52:34 INFO - 'tscrollx', 22:52:34 INFO - 'cart']}, 22:52:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:52:34 INFO - 'tests': ['tp5o']}, 22:52:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:52:34 INFO - 'talos_options': ['--e10s'], 22:52:34 INFO - 'tests': ['tp5o']}, 22:52:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:52:34 INFO - 'talos_options': ['--xperf_path', 22:52:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:52:34 INFO - 'tests': ['tp5n']}, 22:52:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:52:34 INFO - 'talos_options': ['--e10s', 22:52:34 INFO - '--xperf_path', 22:52:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:52:34 INFO - 'tests': ['tp5n']}}, 22:52:34 INFO - 'talos.zip': {'path': '', 22:52:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:52:34 INFO - Running post-action listener: _resource_record_post_action 22:52:34 INFO - ##### 22:52:34 INFO - ##### Running create-virtualenv step. 22:52:34 INFO - ##### 22:52:34 INFO - Running pre-action listener: _resource_record_pre_action 22:52:34 INFO - Running main action method: create_virtualenv 22:52:34 INFO - Creating virtualenv /builds/slave/test/build/venv 22:52:34 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:52:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:52:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:52:35 INFO - Using real prefix '/usr' 22:52:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:52:35 INFO - Installing distribute.............................................................................................................................................................................................done. 22:52:37 INFO - Installing pip.................done. 22:52:37 INFO - Return code: 0 22:52:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:52:37 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:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:52:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:37 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:52:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:52:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:37 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 0x7f368dc7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2735410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c4160>, '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 0x27c5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c54f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1457418317.89644-1415155459', '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:52:37 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:52:37 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:52:37 INFO - Using env: {'DISPLAY': ':0', 22:52:37 INFO - 'HOME': '/home/cltbld', 22:52:37 INFO - 'LANG': 'en_US.UTF-8', 22:52:37 INFO - 'LANGUAGE': 'en_US:en', 22:52:37 INFO - 'LOGNAME': 'cltbld', 22:52:37 INFO - 'MAIL': '/var/mail/cltbld', 22:52:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:52:37 INFO - 'MOZ_NO_REMOTE': '1', 22:52:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:52:37 INFO - 'NO_EM_RESTART': '1', 22:52:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:52:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:52:37 INFO - 'PWD': '/builds/slave/test', 22:52:37 INFO - 'SHELL': '/bin/bash', 22:52:37 INFO - 'SHLVL': '1', 22:52:37 INFO - 'TERM': 'linux', 22:52:37 INFO - 'TMOUT': '86400', 22:52:37 INFO - 'USER': 'cltbld', 22:52:37 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1457418317.89644-1415155459', 22:52:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:52:37 INFO - '_': '/tools/buildbot/bin/python'} 22:52:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:52:37 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:52:37 INFO - Cleaning up... 22:52:37 INFO - Return code: 0 22:52:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:52:37 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:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:52:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:37 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:52:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:52:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:37 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 0x7f368dc7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2735410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c4160>, '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 0x27c5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c54f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1457418317.89644-1415155459', '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:52:37 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:52:37 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:52:37 INFO - Using env: {'DISPLAY': ':0', 22:52:37 INFO - 'HOME': '/home/cltbld', 22:52:37 INFO - 'LANG': 'en_US.UTF-8', 22:52:37 INFO - 'LANGUAGE': 'en_US:en', 22:52:37 INFO - 'LOGNAME': 'cltbld', 22:52:37 INFO - 'MAIL': '/var/mail/cltbld', 22:52:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:52:37 INFO - 'MOZ_NO_REMOTE': '1', 22:52:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:52:37 INFO - 'NO_EM_RESTART': '1', 22:52:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:52:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:52:37 INFO - 'PWD': '/builds/slave/test', 22:52:37 INFO - 'SHELL': '/bin/bash', 22:52:37 INFO - 'SHLVL': '1', 22:52:37 INFO - 'TERM': 'linux', 22:52:37 INFO - 'TMOUT': '86400', 22:52:37 INFO - 'USER': 'cltbld', 22:52:37 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1457418317.89644-1415155459', 22:52:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:52:37 INFO - '_': '/tools/buildbot/bin/python'} 22:52:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:52:37 INFO - Downloading/unpacking psutil>=0.7.1 22:52:37 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:52:37 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:52:37 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:52:37 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:52:37 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:52:37 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:52:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:52:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:52:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:52:39 INFO - Installing collected packages: psutil 22:52:39 INFO - Running setup.py install for psutil 22:52:39 INFO - building 'psutil._psutil_linux' extension 22:52:39 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:52:40 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:52:40 INFO - building 'psutil._psutil_posix' extension 22:52:40 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:52:40 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:52:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:52:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:52:40 INFO - Successfully installed psutil 22:52:40 INFO - Cleaning up... 22:52:40 INFO - Return code: 0 22:52:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:52: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:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:52:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52: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:52:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:52:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52: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', '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 0x7f368dc7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2735410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c4160>, '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 0x27c5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c54f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1457418317.89644-1415155459', '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:52: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 22:52: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 mozsystemmonitor==0.0.0 22:52:40 INFO - Using env: {'DISPLAY': ':0', 22:52:40 INFO - 'HOME': '/home/cltbld', 22:52:40 INFO - 'LANG': 'en_US.UTF-8', 22:52:40 INFO - 'LANGUAGE': 'en_US:en', 22:52:40 INFO - 'LOGNAME': 'cltbld', 22:52:40 INFO - 'MAIL': '/var/mail/cltbld', 22:52:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:52:40 INFO - 'MOZ_NO_REMOTE': '1', 22:52:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:52:40 INFO - 'NO_EM_RESTART': '1', 22:52:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:52:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:52:40 INFO - 'PWD': '/builds/slave/test', 22:52:40 INFO - 'SHELL': '/bin/bash', 22:52:40 INFO - 'SHLVL': '1', 22:52:40 INFO - 'TERM': 'linux', 22:52:40 INFO - 'TMOUT': '86400', 22:52:40 INFO - 'USER': 'cltbld', 22:52:40 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1457418317.89644-1415155459', 22:52:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:52:40 INFO - '_': '/tools/buildbot/bin/python'} 22:52:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:52:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:52:40 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:52:40 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:52:40 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:52:40 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:52:40 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:52:40 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:52:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:52:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:52:42 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:52:42 INFO - Installing collected packages: mozsystemmonitor 22:52:42 INFO - Running setup.py install for mozsystemmonitor 22:52:42 INFO - Successfully installed mozsystemmonitor 22:52:42 INFO - Cleaning up... 22:52:42 INFO - Return code: 0 22:52:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:52:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:52:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:42 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 0x7f368dc7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2735410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c4160>, '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 0x27c5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c54f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1457418317.89644-1415155459', '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:52:42 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:52:42 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:52:42 INFO - Using env: {'DISPLAY': ':0', 22:52:42 INFO - 'HOME': '/home/cltbld', 22:52:42 INFO - 'LANG': 'en_US.UTF-8', 22:52:42 INFO - 'LANGUAGE': 'en_US:en', 22:52:42 INFO - 'LOGNAME': 'cltbld', 22:52:42 INFO - 'MAIL': '/var/mail/cltbld', 22:52:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:52:42 INFO - 'MOZ_NO_REMOTE': '1', 22:52:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:52:42 INFO - 'NO_EM_RESTART': '1', 22:52:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:52:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:52:42 INFO - 'PWD': '/builds/slave/test', 22:52:42 INFO - 'SHELL': '/bin/bash', 22:52:42 INFO - 'SHLVL': '1', 22:52:42 INFO - 'TERM': 'linux', 22:52:42 INFO - 'TMOUT': '86400', 22:52:42 INFO - 'USER': 'cltbld', 22:52:42 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1457418317.89644-1415155459', 22:52:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:52:42 INFO - '_': '/tools/buildbot/bin/python'} 22:52:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:52:42 INFO - Downloading/unpacking blobuploader==1.2.4 22:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:44 INFO - Downloading blobuploader-1.2.4.tar.gz 22:52:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:52:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:52:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:52:45 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:52:45 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:52:45 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:52:45 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:52:45 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:52:45 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:52:45 INFO - Downloading docopt-0.6.1.tar.gz 22:52:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:52:45 INFO - Installing collected packages: blobuploader, requests, docopt 22:52:45 INFO - Running setup.py install for blobuploader 22:52:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:52:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:52:45 INFO - Running setup.py install for requests 22:52:45 INFO - Running setup.py install for docopt 22:52:46 INFO - Successfully installed blobuploader requests docopt 22:52:46 INFO - Cleaning up... 22:52:46 INFO - Return code: 0 22:52:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:52:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:52:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:52:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:46 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 0x7f368dc7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2735410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c4160>, '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 0x27c5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c54f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1457418317.89644-1415155459', '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:52:46 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:52:46 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:52:46 INFO - Using env: {'DISPLAY': ':0', 22:52:46 INFO - 'HOME': '/home/cltbld', 22:52:46 INFO - 'LANG': 'en_US.UTF-8', 22:52:46 INFO - 'LANGUAGE': 'en_US:en', 22:52:46 INFO - 'LOGNAME': 'cltbld', 22:52:46 INFO - 'MAIL': '/var/mail/cltbld', 22:52:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:52:46 INFO - 'MOZ_NO_REMOTE': '1', 22:52:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:52:46 INFO - 'NO_EM_RESTART': '1', 22:52:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:52:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:52:46 INFO - 'PWD': '/builds/slave/test', 22:52:46 INFO - 'SHELL': '/bin/bash', 22:52:46 INFO - 'SHLVL': '1', 22:52:46 INFO - 'TERM': 'linux', 22:52:46 INFO - 'TMOUT': '86400', 22:52:46 INFO - 'USER': 'cltbld', 22:52:46 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1457418317.89644-1415155459', 22:52:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:52:46 INFO - '_': '/tools/buildbot/bin/python'} 22:52:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:52:46 INFO - Running setup.py (path:/tmp/pip-xa_44V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:52:46 INFO - Running setup.py (path:/tmp/pip-jxMu5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:52:46 INFO - Running setup.py (path:/tmp/pip-drhsZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:52:46 INFO - Running setup.py (path:/tmp/pip-h_C9Po-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:52:46 INFO - Running setup.py (path:/tmp/pip-70XmeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:52:46 INFO - Running setup.py (path:/tmp/pip-1_SwCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:52:46 INFO - Running setup.py (path:/tmp/pip-Fd28n0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:52:46 INFO - Running setup.py (path:/tmp/pip-0C0y4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:52:46 INFO - Running setup.py (path:/tmp/pip-KExVIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:52:46 INFO - Running setup.py (path:/tmp/pip-QzLT_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:52:46 INFO - Running setup.py (path:/tmp/pip-tiQskB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:52:47 INFO - Running setup.py (path:/tmp/pip-W6kyva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:52:47 INFO - Running setup.py (path:/tmp/pip-cXhGDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:52:47 INFO - Running setup.py (path:/tmp/pip-jrO7H4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:52:47 INFO - Running setup.py (path:/tmp/pip-dSmFYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:52:47 INFO - Running setup.py (path:/tmp/pip-6W2jsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:52:47 INFO - Running setup.py (path:/tmp/pip-Caq98A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:52:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:52:47 INFO - Running setup.py install for manifestparser 22:52:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:52:47 INFO - Running setup.py install for mozcrash 22:52:47 INFO - Running setup.py install for mozdebug 22:52:47 INFO - Running setup.py install for mozdevice 22:52:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:52:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:52:47 INFO - Running setup.py install for mozfile 22:52:48 INFO - Running setup.py install for mozhttpd 22:52:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:52:48 INFO - Running setup.py install for mozinfo 22:52:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:52:48 INFO - Running setup.py install for mozInstall 22:52:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:52:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:52:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:52:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:52:48 INFO - Running setup.py install for mozleak 22:52:48 INFO - Running setup.py install for mozlog 22:52:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:52:48 INFO - Running setup.py install for moznetwork 22:52:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:52:48 INFO - Running setup.py install for mozprocess 22:52:48 INFO - Running setup.py install for mozprofile 22:52:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:52:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:52:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:52:48 INFO - Running setup.py install for mozrunner 22:52:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:52:48 INFO - Running setup.py install for mozscreenshot 22:52:49 INFO - Running setup.py install for moztest 22:52:49 INFO - Running setup.py install for mozversion 22:52:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:52:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:52:49 INFO - Cleaning up... 22:52:49 INFO - Return code: 0 22:52:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:52:49 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:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:52:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:49 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:52:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:52:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:49 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 0x7f368dc7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2735410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c4160>, '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 0x27c5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c54f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1457418317.89644-1415155459', '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:52:49 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:52:49 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:52:49 INFO - Using env: {'DISPLAY': ':0', 22:52:49 INFO - 'HOME': '/home/cltbld', 22:52:49 INFO - 'LANG': 'en_US.UTF-8', 22:52:49 INFO - 'LANGUAGE': 'en_US:en', 22:52:49 INFO - 'LOGNAME': 'cltbld', 22:52:49 INFO - 'MAIL': '/var/mail/cltbld', 22:52:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:52:49 INFO - 'MOZ_NO_REMOTE': '1', 22:52:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:52:49 INFO - 'NO_EM_RESTART': '1', 22:52:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:52:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:52:49 INFO - 'PWD': '/builds/slave/test', 22:52:49 INFO - 'SHELL': '/bin/bash', 22:52:49 INFO - 'SHLVL': '1', 22:52:49 INFO - 'TERM': 'linux', 22:52:49 INFO - 'TMOUT': '86400', 22:52:49 INFO - 'USER': 'cltbld', 22:52:49 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1457418317.89644-1415155459', 22:52:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:52:49 INFO - '_': '/tools/buildbot/bin/python'} 22:52:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:52:49 INFO - Running setup.py (path:/tmp/pip-th3B3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:52:49 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:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:52:49 INFO - Running setup.py (path:/tmp/pip-B52cIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:52:49 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:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:52:49 INFO - Running setup.py (path:/tmp/pip-cG0OYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:52:49 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:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:52:49 INFO - Running setup.py (path:/tmp/pip-Cm58CU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:52:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:52:49 INFO - Running setup.py (path:/tmp/pip-Cv4drN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:52:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 22:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:52:49 INFO - Running setup.py (path:/tmp/pip-_g9e0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:52:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 22:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:52:49 INFO - Running setup.py (path:/tmp/pip-C6VOls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:52:50 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:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:52:50 INFO - Running setup.py (path:/tmp/pip-Rwuy0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:52:50 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:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:52:50 INFO - Running setup.py (path:/tmp/pip-A8LwL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:52:50 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:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:52:50 INFO - Running setup.py (path:/tmp/pip-5torOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:52:50 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:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:52:50 INFO - Running setup.py (path:/tmp/pip-LDAjqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:52:50 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:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:52:50 INFO - Running setup.py (path:/tmp/pip-GafIgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:52:50 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:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:52:50 INFO - Running setup.py (path:/tmp/pip-fL4wb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:52:50 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:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:52:50 INFO - Running setup.py (path:/tmp/pip-cc9QpR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:52:50 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:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:52:50 INFO - Running setup.py (path:/tmp/pip-kwlkx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:52:50 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:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:52:50 INFO - Running setup.py (path:/tmp/pip-PN0TtM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:52:50 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:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:52:50 INFO - Running setup.py (path:/tmp/pip-sWIFAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:52:50 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:52:50 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:52:50 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:52:50 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:52:50 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:52:50 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:52:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:52 INFO - Downloading blessings-1.6.tar.gz 22:52:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:52:52 INFO - Installing collected packages: blessings 22:52:52 INFO - Running setup.py install for blessings 22:52:52 INFO - Successfully installed blessings 22:52:52 INFO - Cleaning up... 22:52:52 INFO - Return code: 0 22:52:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:52:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:52:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:52:52 INFO - Reading from file tmpfile_stdout 22:52:52 INFO - Current package versions: 22:52:52 INFO - argparse == 1.2.1 22:52:52 INFO - blessings == 1.6 22:52:53 INFO - blobuploader == 1.2.4 22:52:53 INFO - docopt == 0.6.1 22:52:53 INFO - manifestparser == 1.1 22:52:53 INFO - mozInstall == 1.12 22:52:53 INFO - mozcrash == 0.17 22:52:53 INFO - mozdebug == 0.1 22:52:53 INFO - mozdevice == 0.48 22:52:53 INFO - mozfile == 1.2 22:52:53 INFO - mozhttpd == 0.7 22:52:53 INFO - mozinfo == 0.9 22:52:53 INFO - mozleak == 0.1 22:52:53 INFO - mozlog == 3.1 22:52:53 INFO - moznetwork == 0.27 22:52:53 INFO - mozprocess == 0.22 22:52:53 INFO - mozprofile == 0.28 22:52:53 INFO - mozrunner == 6.11 22:52:53 INFO - mozscreenshot == 0.1 22:52:53 INFO - mozsystemmonitor == 0.0 22:52:53 INFO - moztest == 0.7 22:52:53 INFO - mozversion == 1.4 22:52:53 INFO - psutil == 3.1.1 22:52:53 INFO - requests == 1.2.3 22:52:53 INFO - wsgiref == 0.1.2 22:52:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:52:53 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:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:52:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:53 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:52:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:52:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:53 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 0x7f368dc7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2735410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c4160>, '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 0x27c5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c54f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1457418317.89644-1415155459', '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:52:53 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:52:53 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:52:53 INFO - Using env: {'DISPLAY': ':0', 22:52:53 INFO - 'HOME': '/home/cltbld', 22:52:53 INFO - 'LANG': 'en_US.UTF-8', 22:52:53 INFO - 'LANGUAGE': 'en_US:en', 22:52:53 INFO - 'LOGNAME': 'cltbld', 22:52:53 INFO - 'MAIL': '/var/mail/cltbld', 22:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:52:53 INFO - 'MOZ_NO_REMOTE': '1', 22:52:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:52:53 INFO - 'NO_EM_RESTART': '1', 22:52:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:52:53 INFO - 'PWD': '/builds/slave/test', 22:52:53 INFO - 'SHELL': '/bin/bash', 22:52:53 INFO - 'SHLVL': '1', 22:52:53 INFO - 'TERM': 'linux', 22:52:53 INFO - 'TMOUT': '86400', 22:52:53 INFO - 'USER': 'cltbld', 22:52:53 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1457418317.89644-1415155459', 22:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:52:53 INFO - '_': '/tools/buildbot/bin/python'} 22:52:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:52:53 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:52:53 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:52:53 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:52:53 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:52:53 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:52:53 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:52:53 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:52:53 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:52:53 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:52:53 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:52:53 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:52:53 INFO - Cleaning up... 22:52:53 INFO - Return code: 0 22:52:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:52:53 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:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:52:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:53 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:52:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:52:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:53 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 0x7f368dc7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2735410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c4160>, '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 0x27c5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c54f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1457418317.89644-1415155459', '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:52:53 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:52:53 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:52:53 INFO - Using env: {'DISPLAY': ':0', 22:52:53 INFO - 'HOME': '/home/cltbld', 22:52:53 INFO - 'LANG': 'en_US.UTF-8', 22:52:53 INFO - 'LANGUAGE': 'en_US:en', 22:52:53 INFO - 'LOGNAME': 'cltbld', 22:52:53 INFO - 'MAIL': '/var/mail/cltbld', 22:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:52:53 INFO - 'MOZ_NO_REMOTE': '1', 22:52:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:52:53 INFO - 'NO_EM_RESTART': '1', 22:52:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:52:53 INFO - 'PWD': '/builds/slave/test', 22:52:53 INFO - 'SHELL': '/bin/bash', 22:52:53 INFO - 'SHLVL': '1', 22:52:53 INFO - 'TERM': 'linux', 22:52:53 INFO - 'TMOUT': '86400', 22:52:53 INFO - 'USER': 'cltbld', 22:52:53 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1457418317.89644-1415155459', 22:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:52:53 INFO - '_': '/tools/buildbot/bin/python'} 22:52:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:52:53 INFO - Downloading/unpacking jsonschema 22:52: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:52: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:52: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:52: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:52: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:52: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:52:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:52:55 INFO - Downloading/unpacking functools32 (from jsonschema) 22:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:55 INFO - Downloading functools32-3.2.3-2.tar.gz 22:52:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:52:55 INFO - warning: no files found matching '*.txt' 22:52:55 INFO - no previously-included directories found matching 'build' 22:52:55 INFO - no previously-included directories found matching 'dist' 22:52:55 INFO - no previously-included directories found matching '.git*' 22:52:55 INFO - Installing collected packages: jsonschema, functools32 22:52:55 INFO - Running setup.py install for functools32 22:52:55 INFO - warning: no files found matching '*.txt' 22:52:55 INFO - no previously-included directories found matching 'build' 22:52:55 INFO - no previously-included directories found matching 'dist' 22:52:55 INFO - no previously-included directories found matching '.git*' 22:52:55 INFO - Successfully installed jsonschema functools32 22:52:55 INFO - Cleaning up... 22:52:55 INFO - Return code: 0 22:52:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:52:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:52:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:52:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f368dc7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2735410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c4160>, '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 0x27c5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c54f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1457418317.89644-1415155459', '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:52:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 22:52:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:52:55 INFO - Using env: {'DISPLAY': ':0', 22:52:55 INFO - 'HOME': '/home/cltbld', 22:52:55 INFO - 'LANG': 'en_US.UTF-8', 22:52:55 INFO - 'LANGUAGE': 'en_US:en', 22:52:55 INFO - 'LOGNAME': 'cltbld', 22:52:55 INFO - 'MAIL': '/var/mail/cltbld', 22:52:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:52:55 INFO - 'MOZ_NO_REMOTE': '1', 22:52:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:52:55 INFO - 'NO_EM_RESTART': '1', 22:52:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:52:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:52:55 INFO - 'PWD': '/builds/slave/test', 22:52:55 INFO - 'SHELL': '/bin/bash', 22:52:55 INFO - 'SHLVL': '1', 22:52:55 INFO - 'TERM': 'linux', 22:52:55 INFO - 'TMOUT': '86400', 22:52:55 INFO - 'USER': 'cltbld', 22:52:55 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1457418317.89644-1415155459', 22:52:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:52:55 INFO - '_': '/tools/buildbot/bin/python'} 22:52:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:52:55 INFO - Downloading/unpacking flake8 22:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:52:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:52:57 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:52:57 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:52:57 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:52:57 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:52:57 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:52:57 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:52:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:52:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:52:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:52:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:52:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:52:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:52:58 INFO - no previously-included directories found matching 'docs/_build' 22:52:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:52:58 INFO - Running setup.py install for pep8 22:52:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:52:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:52:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:52:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:52:58 INFO - no previously-included directories found matching 'docs/_build' 22:52:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:52:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:52:58 INFO - Cleaning up... 22:52:58 INFO - Return code: 0 22:52:58 INFO - Running post-action listener: _resource_record_post_action 22:52:58 INFO - Running post-action listener: _start_resource_monitoring 22:52:58 INFO - Starting resource monitoring. 22:52:58 INFO - ##### 22:52:58 INFO - ##### Running install step. 22:52:58 INFO - ##### 22:52:58 INFO - Running pre-action listener: _resource_record_pre_action 22:52:58 INFO - Running main action method: install 22:52:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:52:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:52:59 INFO - Reading from file tmpfile_stdout 22:52:59 INFO - Detecting whether we're running mozinstall >=1.0... 22:52:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:52:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:52:59 INFO - Reading from file tmpfile_stdout 22:52:59 INFO - Output received: 22:52:59 INFO - Usage: mozinstall [options] installer 22:52:59 INFO - Options: 22:52:59 INFO - -h, --help show this help message and exit 22:52:59 INFO - -d DEST, --destination=DEST 22:52:59 INFO - Directory to install application into. [default: 22:52:59 INFO - "/builds/slave/test"] 22:52:59 INFO - --app=APP Application being installed. [default: firefox] 22:52:59 INFO - mkdir: /builds/slave/test/build/application 22:52:59 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:52:59 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:53:15 INFO - Reading from file tmpfile_stdout 22:53:15 INFO - Output received: 22:53:15 INFO - /builds/slave/test/build/application/firefox/firefox 22:53:15 INFO - Running post-action listener: _resource_record_post_action 22:53:15 INFO - ##### 22:53:15 INFO - ##### Running run-tests step. 22:53:15 INFO - ##### 22:53:15 INFO - Running pre-action listener: _resource_record_pre_action 22:53:15 INFO - Running main action method: run_tests 22:53:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:53:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:53:15 INFO - Python 2.7.3 22:53:15 INFO - Return code: 0 22:53:15 INFO - grabbing minidump binary from tooltool 22:53: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:53:15 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 0x27c4160>, '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 0x27c5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c54f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:53:15 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:53:15 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:53:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:53:15 INFO - Return code: 0 22:53:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:53:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:53:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:53:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:53:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:53:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:53:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:53:16 INFO - Return code: 0 22:53:16 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L0ZTin4pTeimAVyL1Cw1NQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 22:53:16 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/L0ZTin4pTeimAVyL1Cw1NQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:53:16 INFO - Using env: {'DISPLAY': ':0', 22:53:16 INFO - 'HOME': '/home/cltbld', 22:53:16 INFO - 'LANG': 'en_US.UTF-8', 22:53:16 INFO - 'LANGUAGE': 'en_US:en', 22:53:16 INFO - 'LOGNAME': 'cltbld', 22:53:16 INFO - 'MAIL': '/var/mail/cltbld', 22:53:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:53:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:53:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:16 INFO - 'MOZ_NO_REMOTE': '1', 22:53:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:53:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:16 INFO - 'NO_EM_RESTART': '1', 22:53:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:53:16 INFO - 'PWD': '/builds/slave/test', 22:53:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:53:16 INFO - 'SHELL': '/bin/bash', 22:53:16 INFO - 'SHLVL': '1', 22:53:16 INFO - 'TERM': 'linux', 22:53:16 INFO - 'TMOUT': '86400', 22:53:16 INFO - 'USER': 'cltbld', 22:53:16 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1457418317.89644-1415155459', 22:53:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:16 INFO - '_': '/tools/buildbot/bin/python'} 22:53:16 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L0ZTin4pTeimAVyL1Cw1NQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:53:16 INFO - mozversion application_buildid: 20160307213736 22:53:16 INFO - mozversion application_changeset: 557e8160f3518163e4d734852f376bc17da0a9b0 22:53:16 INFO - mozversion application_display_name: Nightly 22:53:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:53:16 INFO - mozversion application_name: Firefox 22:53:16 INFO - mozversion application_remotingname: firefox 22:53:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:53:16 INFO - mozversion application_vendor: Mozilla 22:53:16 INFO - mozversion application_version: 47.0a1 22:53:16 INFO - mozversion platform_buildid: 20160307213736 22:53:16 INFO - mozversion platform_changeset: 557e8160f3518163e4d734852f376bc17da0a9b0 22:53:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:53:16 INFO - mozversion platform_version: 47.0a1 22:53:16 INFO - using testdate: 1457419996 22:53:16 INFO - actual date: 1457419996 22:53:16 INFO - starting webserver on 'localhost:51819' 22:53:16 INFO - SUITE-START | Running 2 tests 22:53:16 INFO - TEST-START | dromaeo_css 22:53:16 INFO - operating with platform_type : linux_ 22:53:16 INFO - Initialising browser for dromaeo_css test... 22:53:16 INFO - TEST-INFO | started process 25744 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvbmMc8/profile http://localhost:51819/getInfo.html) 22:53:20 INFO - PROCESS | 25744 | 22:53:20 INFO - PROCESS | 25744 | (process:25826): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:53:21 INFO - PROCESS | 25744 | __metrics Screen width/height:1600/1200 22:53:21 INFO - PROCESS | 25744 | colorDepth:24 22:53:21 INFO - PROCESS | 25744 | Browser inner width/height: 1024/697 22:53:21 INFO - PROCESS | 25744 | __metrics 22:53:22 ERROR - PROCESS | 25744 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 22:53:23 INFO - TEST-INFO | 25744: exit 0 22:53:23 INFO - Browser initialized. 22:53:23 INFO - Running cycle 1/1 for dromaeo_css test... 22:53:23 INFO - TEST-INFO | started process 25879 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvbmMc8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:53:25 INFO - PROCESS | 25879 | 22:53:25 INFO - PROCESS | 25879 | (process:25940): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:53:35 INFO - PROCESS | 25879 | RSS: Main: 165478400 22:53:35 INFO - PROCESS | 25879 | 22:54:25 INFO - PROCESS | 25879 | 1457420065244 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:56:37 INFO - PROCESS | 25879 | Cycle 1(1): loaded http://localhost:51819/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51819/tests/dromaeo/cssquery-ext.html) 22:56:38 INFO - PROCESS | 25879 | RSS: Main: 167759872 22:56:38 INFO - PROCESS | 25879 | 22:59:39 INFO - PROCESS | 25879 | Cycle 1(1): loaded http://localhost:51819/tests/dromaeo/cssquery-ext.html (next: http://localhost:51819/tests/dromaeo/cssquery-jquery.html) 22:59:40 INFO - PROCESS | 25879 | RSS: Main: 167800832 22:59:40 INFO - PROCESS | 25879 | 23:02:42 INFO - PROCESS | 25879 | Cycle 1(1): loaded http://localhost:51819/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51819/tests/dromaeo/cssquery-mootools.html) 23:02:42 INFO - PROCESS | 25879 | RSS: Main: 168861696 23:02:42 INFO - PROCESS | 25879 | 23:05:44 INFO - PROCESS | 25879 | Cycle 1(1): loaded http://localhost:51819/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51819/tests/dromaeo/cssquery-prototype.html) 23:05:45 INFO - PROCESS | 25879 | RSS: Main: 167960576 23:05:45 INFO - PROCESS | 25879 | 23:08:47 INFO - PROCESS | 25879 | Cycle 1(1): loaded http://localhost:51819/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51819/tests/dromaeo/cssquery-yui.html) 23:08:48 INFO - PROCESS | 25879 | RSS: Main: 167702528 23:08:48 INFO - PROCESS | 25879 | 23:11:50 INFO - PROCESS | 25879 | Cycle 1(1): loaded http://localhost:51819/tests/dromaeo/cssquery-yui.html (next: http://localhost:51819/tests/dromaeo/cssquery-dojo.html) 23:11:50 INFO - PROCESS | 25879 | RSS: Main: 170438656 23:11:50 INFO - PROCESS | 25879 | 23:11:50 INFO - PROCESS | 25879 | __start_tp_report 23:11:50 INFO - PROCESS | 25879 | _x_x_mozilla_page_load 23:11:50 INFO - PROCESS | 25879 | _x_x_mozilla_page_load_details 23:11:50 INFO - PROCESS | 25879 | |i|pagename|runs| 23:11:50 INFO - PROCESS | 25879 | |0;dojo.html;2609.060738134272;2639.709631940487;2664.3205982474465;2678.3304173956512;2685.6777186737595;4601.355810186572;4634.884127896804;4636.4899861015265;4673.9065218695605;4679.906401871961;4558.111168322179;4625.791839367228;4647.442306923165;4658.60401865841;4708.152532544149;4260.70175087744;4296.505901821283;4342.869713908588;4354.738715677054;4412.889677758049;4245.214635292481;4245.681573881971;4321.611055005049;4324.6107850293465;4378.321360189176;4229.027323715547;4276;4292.699511034229;4294.463192100988;4343.457067866517;4246.808893599796;4252.617264446215;4260.169266992938;4280.058387154821;4289.378040184187;4110.403991421257;4187.20443115807;4197.18154959783;4201.831926722927;4232.9153416931795;4536.183486972343;4546.636269098464;4560.840370587013;4612.976935115336;4613.1696294666945;4935.037667654773;4948.331975183341;4956.182229932093;4972.154733695281;4972.179590367585;4869.245266983623;4986.326845875797;5002.399712034543;5043.470435604246;5051.87370315745;4605.631549476034;4622.214223581999;4636.907261854744;4659;4665.860024199212;5080.745962701924;5088.389393272831;5095.8726031848755;5103.923441148386;5145.742712864342;4790.616750659939;4864.708117512961;4888.6577939543895;4890.462049174588;4933.309336692794;4834.274858771212;4963.280324353021;4974.37820272466;5031.069252188357;5101.0818052750865;4935.703857768545;4936.506349365107;4946.703197808071;4958.281049247911;5001.549860512571;4724.763761811964;4779.354787103696;4824.204006338985;4880.585150262267;4892.975535122301;4135.441715368387;4135.813888375031;4138.358554424069;4140.068484590943;4182.163567286494;3612.7897154453026;3616.746827722087;3623.673869351718;3651.9817400912825;3668.6514781095752;4294.699371044059;4318.050028993616;4335.523092459827;4337.934930976038;4358.411614432074;4929.088118698052;4948.505149485023;4952.207646776498;4974.626902982219;4988.80044798204;4211.36829475575;4255.425517555091;4256.914861702749;4279.229738647074;4298.054428025829;4418.337249412614;4431.290993441034;4436.0906014267;4458.242098843204;4473.373727678128;4704.553067458586;4736.976315118402;4752.192127338291;4758.571728544448;4810.254410566367;4863.513648635249;4972.055309491185;5001.374828146481;5005.77474013663;5041.294218809443;4664.650151238603;4689.366935463669;4753.334533165429;4777.689450185727;4778.402699662543;4921.926171107365;4931.6301277405055;4934.235193545006;4935.210366341368;4988.12707776145;4872.049950259665;4957.578605818546;5018.121828679893;5038;5070.112730272114;4695.201815691273;4784.641151913551;4836.322914792002;4849.95150048495;4876.073546026244;4865.051314993542;4866.8053277868485;4875.512448755097;4891.26631005352;4914.508549145057;4608.055348653585;4685.484596694293;4767.904641907073;4780.569748722632;4796.37647105874;4907.141250281258;4907.386576677915;4908.656394052525;4909.116359055404;4936.3089167515855;4774.594159496482;4780.402449693788;4786.856394308176;4799.328094066903;4852.175130227799 23:11:50 INFO - PROCESS | 25879 | |1;ext.html;491.5723320710982;497.57705949942533;511.7083262540351;533.2774091106551;535.5073332534067;32652.67347326529;33194.50208246872;33244;33262.16844578884;33307.66692333082;36203.275934481295;36586.63413365872;36893.631063689354;36936.630633693654;36950.630493695055;7655.8468830623215;7779.144294127642;7822.960885195566;7825.726099586515;7845.450818442711;7366.963165184166;7475.887861682079;7770;7914;7916;7505.362044226247;7510.061242344707;7511.6995320187125;7517.323440890319;7536.246375362474;7431.145418276913;7458.813529661747;7484.288992545699;7489.213632568556;7492.962535187344;7337.816554586178;7381.114266288027;7413.036305280333;7450.96274518624;7455.254474552556;37939.24121517582;38476.615233847864;38542.807285963674;38553.80723096366;38599.8070009651;2371.774681405264;2799.398129402168;2808.9859550702117;2890.2918784897624;2931.1353150820346;26115.869420652965;27257.454850902872;27289.317767055785;27587;27968.580471292946;3461.5153878457036;3517.6306487818924;3517.7537572369943;3585.74035867324;3633.128049268183;145925;145940.27029864784;146078;146631;147018.52981470156;52102.478975209764;52512.212316815276;52792;52831.735841320544;52899.73550132302;54511.45488545143;54617.726911365186;60302;60765.392346075976;61677.38322616806;11982.64052078439;12036.217645852992;12056;12096.697582560506;12129.332886691316;9629.085236902483;9671.854922176173;9734.659286924923;9745.951270243746;9848.458334791656;18722.15750291213;18889;18927.716084258747;18951.90524047371;18979.62040759177;7708.845823083507;7981.441299109123;8048.5975701215875;8098.149694282133;8120.147384524658;738.5605564689001;767.6814122139361;807.7051876065194;882.0121463960277;943.9528023598739;25758.48483030329;25948.962041518505;26068.34829129287;26200.8689956549;26221.868890655423;887.8179973105498;888.4092078767676;916.6745805239044;920.1396694091046;976.4824642939253;13621.318934053455;13926.860731392759;13993.3702983366;14157.221352825487;14165.71668566623;330068;381225;387759;391074;391676;44234.77882610566;44641.55358446374;45335.546644533795;45416.77291613521;45536.77231613821;1173.700706319883;1179.899708524785;1206.3304865799566;1208.6494916474123;1231.310466138965;25846.095386661378;26720.52633157677;27124;27273;27420.725792741818;40658.1868362637;41189.382159268236;41346;41430.1713965725;41578.168436631706;239946;242946;243627;244085;246878;29396.706032939397;29548.852255738584;29715.702842971292;30096;30125;39885.401718973655;40008;40582.39126413165;40729.59270407258;40884.79557602193;34457;34713.479297810045;35045.64954350526;35127.29745405026;35154.47268291029;33574.66425335715;33637.663623363456;33958.001129701144;34006.14984625404;34219.31561368709;34465.48301775425;34612;36453.45319820258;37073.629263707015;37161.256774864894;27106.186814395598;28319;28554.85722571374;28645.856770716015;29164.70835291705;23759.64360534628;23834.284971450885;23836.761632383455;23972;24196.87901560481 23:11:50 INFO - PROCESS | 25879 | |2;jquery.html;320.9021248519201;339.97450191235646;342.3068286719393;343.82980424689765;352.57514694792775;14622.70754584909;15099.547013589596;15635.296411661475;15646.139462329567;15654.921725391385;14434.42262309509;14664.266786660677;14666.706665866675;15408.152551609657;15498.767518487204;4789.42526896772;4994.200927851544;5011.599072074226;5034.471380505049;5037.395512538482;4772.856814295559;4931.358923339961;4968;4970.801167953296;4988.301637770715;4896.510348965111;4912.803487860481;4938.506149385051;4942.555170034696;4945.604351651859;4761.690490118166;4811.855644330676;4820.204666230068;4915.975420122894;4923.458419573844;4325.351197320427;4336;4358.389825424443;4364.018095928423;4366.148601022802;18479.445616631387;18516.537086572807;18653.906730466395;18778.436646900616;18811.52971175718;1772.2822256985942;1798.2537247042462;1830.03922940456;1872.586197420952;2092.5187206942487;12282.815757763641;12459.688507787287;12541.372931353395;12627;12739.61781146567;1708.7180615198477;1722.7846519185102;1725.447856685861;1773.3704534890187;1792.2024699008946;52576.2113568293;54923;56283.15575266374;56562.717186414215;56958;8964.955175224082;9006.86489702655;9082.909170908339;9163.404378715362;9229.16937475617;12387.690307742198;12422.565210217599;12503.624891253277;12514.81227781584;12531.18547294423;6366.204224471941;6446.323136070645;6491.091247225392;6528.673566321665;6624.105745724266;5846.970765146232;5858.53131749459;5898.085796701518;5904.498117660047;5930.673812940329;4124.711270211056;4128.8348466061025;4160.993409944949;4163.292240319153;4169.791510424467;1726.2490816494865;1741.8084010758807;1781.403229917966;1781.8930864148192;1786.937457188992;752.6913965274321;775.3370867907857;789.0846617923181;826.0747962282283;865.8484765166071;14891.627709307353;15239;15473.690526189414;15632.218389080728;15968.680626387639;812.792737851844;835.5446281776447;836.3643630840605;844.9746507604659;849.1762989899787;8739.60671769772;8802.427842190236;8951.731448056438;8951.820963580822;8990.100989900957;387840;390682;396293;398107;400041;43201;48214.27678584824;58993.70503147542;60689.696551517845;60917.69541152266;909.6088681866728;910.1853840812436;937.723371605378;940.6613619097257;942.3733217410345;14241.572752817432;14311.642208944444;14345.569632911029;14369.712605747618;14781.334839932013;29549.852250738608;31515.84242078775;31589.52615710812;31627.841860790548;32501.67498325081;43612.56387436085;44263.55736442594;44368.11263774771;44425.77787111044;44922.32616510821;7156.892646610201;7197.676104575202;7252.891206631799;7352.191258961403;7383.926160738324;7331.596762178131;8059.952206213155;10860.185486088418;11099.611513596985;11284.605038823602;8835.602397891982;9518.714438566854;9570.042995700374;9643.758906027406;9781.85327220078;9505.857412138685;9640;9645.37305075168;9672.93597704238;9681.612735490784;5683.460071293221;9544.236461083236;9770.36492627977;9828.4102953823;10093.041161089684;6964.442844572523;7017.859642807218;7048.541844780073;7079.2566780487305;7136.536125151849;7803.648835802289;9585.664501742405;9600.423974561549;9600.66397676078;9725.31922765428 23:11:50 INFO - PROCESS | 25879 | |3;mootools.html;1385.4665953607862;1392.8676775706308;1515.3786947351582;1729.878908476407;1754.9561260968483;6280.309165991749;6947.166340039203;7013.263607321228;7140.071790667213;7179;7432.702691892331;7467.813304667372;7499.887501687479;7505.474616776828;7550.773476795691;2162.8753048414815;2189.1462329691353;2191.9890400547974;2195.879226642534;2197.3407977606653;2105.9262925797602;2154.4183070570934;2181.4873504726456;2182.7489838668516;2189.813865821407;2177.292379976514;2192.9780702192934;2211.1708109458955;2215.4572129828216;2225.744039435461;2171.533120379126;2203.030666506732;2203.0967303405605;2208.3706143749114;2210.668399740036;2114.693369461435;2140.4541841830232;2156.3315372234656;2161.794629510194;2171.0230396321563;7597.848043039108;7677.692892284302;7680;7682.4238182136005;7693.384529237704;4402.691811573191;4501.0547784964865;4502.774861256957;4517.909641807146;4520.86437406875;2796.986015069932;2866.698996605368;2909.7090290970946;2913.766898648103;2922.1233629911153;938.3525367496405;950.8763860698134;952.2382094324513;952.7284723853669;969.0745338202071;10467.424291663956;10508.632197873038;10530.210234232463;10560.841587376195;10577.735556611146;3963.4649322341693;4016.377461493473;4115.794210289474;4152.2525945330135;4173.061061261253;8734.082921293173;8735.908011498563;8752.737417877473;8801.119888011148;8829.514376709343;4421.491528474202;4447.844325448658;4468.597826195658;4477.462704475483;4486.147631949919;3387.3394688036087;3997;4036.1322315702264;4043.474348334698;4060.0864805418546;3487.232808782064;3565.5186549815444;3566.982165089158;3596.172880237508;3609.007522931215;1140.6977151054978;1143.742657901982;1150.1029197226178;1150.804363258248;1150.9539618415338;909.1953621045423;929.0338048429693;930.9069093090773;967.2213867836459;1226.068188176992;7221.277872212737;7229.566226026455;7245.529040612343;7268.636568171571;7311.378532824663;459.25371271683514;459.73105733145815;461.2988257848052;462.79868257307504;469.60553135365774;5495.780168793203;5522.834314970557;5572.804951826666;5588.329400471969;5615.494605485526;8837.469751814911;9113.77215569616;9167.449953002708;9169.174774270348;9194.954025229965;8917.910820891708;8964.596593153194;8983.910160898438;9001.144891235323;9061;6491.188601424822;6624.238212605515;6627.436667883284;6679.265280819009;6711.4966377520905;6590.143281373391;6685.699143538455;6700.932990670226;6704.027915952062;6708.42978346846;7671.884921726067;7729.690812367668;7914.881276780968;7961.920380796118;8041.959790201012;7992.560409177318;8001.519908805491;8008.039035315799;8054.83890322202;8194.385421093322;6049.78825741097;6151.5386346025125;6168.475679567107;6199.256089269316;6206.503479721521;6884.827879302858;6912.827179320558;6913.75801846933;6926.9307306926285;6959.304069593;6147.84630384244;6370.394812492806;6421.678916054272;6462.741490340334;6617.8014659560295;6122;6252.155958945484;6369.7452101915405;6374.362563743589;6400.839979000376;6498.187726534184;6522.739090436329;6525.282218956006;6527.706253218522;6545.443637290693;6088.056351265561;6137.938620613915;6162.168107305636;6351.777687780906;6352;6404.871902562016;6429.4856411486035;6429.9678501607195;6432.453241474527;6439.420452159328 23:11:50 INFO - PROCESS | 25879 | |4;prototype.html;305.15928616661097;306.2741303111627;312.8107494965546;314.42303373309977;317.05043395031885;5582.916256256154;5626.043572592659;5768.884622307556;5774.105013722879;5782.971085144579;5571.13647384655;5661.716914154286;5677.091665333547;5684.459976302255;5706.087026075828;4045.63589276965;4121.814518346667;4201.936970945439;4261.595148460891;4271.1671224111315;4188.518320393163;4189.79051047448;4192.748435093904;4203.726757760751;4207.600277973587;4161.0429601191745;4171.979140104295;4192.895177620553;4209.6421804146685;4223.556526564697;4214.115035842477;4221.894452638693;4224.176285624305;4233.153369326147;4239.342901850218;3642.3261696586214;3645.052286405527;3647.908802279938;3648.1244501319757;3656.104254457675;5408.378036525811;5415.187721841716;5426.050441172779;5450.781968721247;5461.371942226615;4685.6485763567525;4856.781444834991;4861.781219845116;4885.071836351118;4902.926456103161;5885.735141918624;5886.20536227608;5892.263467066617;5895.469407753323;5919.3192782829665;3984.7011474139554;3988.80055997199;3995.06116062725;3995.440638310639;3995.9200815983518;6127.816165515042;6169.691515424211;6222.284437289724;6225.87548249037;6232.501399888043;4114.19773144234;4115.938260926028;4123.567025462343;4128.298189307765;4139.668826493873;4167.729097608646;4173.373993900939;4190.916181676411;4197.790110494463;4200.159968006411;4626.699264547794;4744.240921452551;4751.928721069186;4821.373221481185;4859.878503037452;5870.3249126350165;5900.350961394243;5922.289325280994;5950.345461999176;5977.103434484862;1441.2793603198402;1460.9415623374946;1461.283970854295;1461.4884790323515;1462.641652795072;958.2477754962321;969.5927710361665;977.5796407544682;985.9260555458369;988.5502096546054;5139.229115632685;5148.588112950955;5163.199704045804;5165.147750621106;5186.948130518646;6143.723532441051;6143.96928015357;6151.292601350812;6162;6170.197874276315;4973.502649734997;5145.305383773218;5159.25190847325;5167.741612919339;5176.352955880515;3221.8872339468007;3320.817355045496;3335.266241426882;3339.2486690494443;3343.0639420961684;5815.651060936273;5833.912491312633;5844.736986835603;5851.829634073202;5853.44392282741;6391;6395.968020159869;6410.391012853772;6411.647359395185;6434.292227854932;5796.623219490804;5824.650520968756;5833.125031245348;5848.210491583667;5887.764489420375;6018.548608854266;6196.690165491797;6208.379162083756;6215.192025036717;6225.626462412089;5969.432903874125;6024.638521688713;6050.727717252822;6051.939480605138;6078.149059131813;5804.419558044331;5810.564207684356;5843.766249349978;5854.853628659318;5868.061110222344;4145.1295228002455;4159.521655009713;4167.708260421741;4175.97912010438;4176.415301857682;6163.291221509584;6198.628082314895;6202.751889924533;6215.34738852414;6217.595856269328;5798.275215598051;5970.164177015135;5976.880462390641;5987.491063259672;5990.2212712348855;5948.821535353946;5962.4633782959745;5972.13404056418;5980.073088671263;5988.820335389945;5875.471207591338;5899.852503687271;5909.852253693692;5916.615419997686;5924.377940316204;6006.489448396936;6014.1580178775885;6020.4280593343565;6024.939750602438;6030.939690603038;5729.083346664514;5870.677112758839;5883.794067207627;5887.882242355044;5895.20414744004 23:11:50 INFO - PROCESS | 25879 | |5;yui.html;713.1655962523848;716.4698123388694;721.5273995532928;723.5550136665952;746.76103646833;11727.706807329821;11910.583129590466;11992.10059245558;12140.635780926576;12166.087543434245;11530.423478826067;11649.941750291237;12153.088518361114;12975.286359250238;13011.73976520469;785.4148659248854;795.1690483444785;796.8207153390499;798.2974982015818;801.1507801730155;776.7708525984848;778.9805254868617;784.2432053068787;784.419529548136;785.9096203936534;826.7726375246795;829.2536716954759;829.4276948905266;831.9750407487785;833.0669649992018;819.0499021135485;819.4141189049828;820.4830956497428;822.0792712162356;822.6257053040912;608.9695515224265;612.5344737999153;613.2242712968099;614.8647297594522;615.6213928433981;11661.591844285409;11677.065834733286;11724.237924534964;11757.294562326288;11764.647060588197;12166.391680415943;12181.025517958542;12234.143609947307;12282.692932676666;12304.200226985216;9471.857922131105;9476.431414115175;9538.52307384628;9611.951940240255;9717.854232186452;3217.9839100804347;3251.1872031992;3273.705366517001;3299.5875515560556;3315.4032274190636;35995;38259.80870095632;41165.79417102895;42065.369019464735;42073.579264207576;9378.390404623678;9519.762005949906;9564.378315409476;9629.277804164716;9705.563249653642;16083.839161608468;16087.195640217942;16140.192990350435;16145.919270403807;16185.4335098271;6708.429783468362;6797.762078327235;6803.625800580917;6914.1702995639835;7115.430765538745;3512.2097528056493;3629.4374371972385;3676.8345424455965;3723.4600982857874;3755.173861750465;2554.757298056719;2563.3207200091992;2582.2769624505167;2587.637730717701;2588.2494076717917;499.32744663003086;507.3505912432093;507.90349833531513;508.5016683650044;512.943576206617;432.89177705573604;458.95410458954507;469.5603072945294;485.22121994199506;496.86584622151815;7229.385502232369;7279.636018199175;7347;7368.0846176126415;7413.1104267488245;560.5683623609879;568.6275489554348;569.5102212097593;582.9621074630136;590.4862769390572;3307.9503807442907;3526.7354948378975;3582.1044738815294;3586.5158203642172;3593.2813437312643;45843.083138337046;45951.77024114925;46030.53969460262;46588.7670561645;46636.7668161657;42826.57173428226;42869;42869.35695964563;43504.564954350055;43620.12759744787;39728;40825;40837.795811020755;40901.59098409038;42344.57655423468;8176.591170441335;8183.263506284463;8367.62345694433;8412.747617571482;8431.28334091609;30574.694253057183;30789;30808.845955770077;30815;31846.52230216595;36778;39388.60611393849;39390.21219575535;39714;39993.80003100082;9897.752556186153;10130.696079117639;10399.94800025995;10430.68707938763;10522.526486307981;10810.67567972962;10955.45222738844;10984.395858227554;10995.450227488434;11026.44867756625;10536.262461627612;10645.201609879136;10745;10773.138148948223;10861.456927153453;9988.700338989842;10029.398236105857;10030.448325342177;10273.691789246335;10501.107405870282;10352.120069793851;10388.428636424767;10453.320534165256;10534.36793792375;10594.364338139736;8675.522846243517;8921.15249051339;8930.419522731001;8968.865467018131;8998.370114091951;8806.911930880866;8860.911390886009;8976.640934362813;9032.503212323385;9043.32175086858 23:11:50 INFO - PROCESS | 25879 | __end_tp_report 23:11:50 INFO - PROCESS | 25879 | __start_cc_report 23:11:50 INFO - PROCESS | 25879 | _x_x_mozilla_cycle_collect,354 23:11:50 INFO - PROCESS | 25879 | __end_cc_report 23:11:50 INFO - PROCESS | 25879 | __startTimestamp1457421110855__endTimestamp 23:11:50 INFO - PROCESS | 25879 | 23:11:50 INFO - PROCESS | 25879 | ------- Summary: start ------- 23:11:50 INFO - PROCESS | 25879 | Number of tests: 6 23:11:50 INFO - PROCESS | 25879 | 23:11:50 INFO - PROCESS | 25879 | [#0] dojo.html Cycles:165 Average:4591.14 Median:4736.98 stddev:478.89 (10.1%) stddev-sans-first:454.41 23:11:50 INFO - PROCESS | 25879 | Values: 2609.1 2639.7 2664.3 2678.3 2685.7 4601.4 4634.9 4636.5 4673.9 4679.9 4558.1 4625.8 4647.4 4658.6 4708.2 4260.7 4296.5 4342.9 4354.7 4412.9 4245.2 4245.7 4321.6 4324.6 4378.3 4229.0 4276.0 4292.7 4294.5 4343.5 4246.8 4252.6 4260.2 4280.1 4289.4 4110.4 4187.2 4197.2 4201.8 4232.9 4536.2 4546.6 4560.8 4613.0 4613.2 4935.0 4948.3 4956.2 4972.2 4972.2 4869.2 4986.3 5002.4 5043.5 5051.9 4605.6 4622.2 4636.9 4659.0 4665.9 5080.7 5088.4 5095.9 5103.9 5145.7 4790.6 4864.7 4888.7 4890.5 4933.3 4834.3 4963.3 4974.4 5031.1 5101.1 4935.7 4936.5 4946.7 4958.3 5001.5 4724.8 4779.4 4824.2 4880.6 4893.0 4135.4 4135.8 4138.4 4140.1 4182.2 3612.8 3616.7 3623.7 3652.0 3668.7 4294.7 4318.1 4335.5 4337.9 4358.4 4929.1 4948.5 4952.2 4974.6 4988.8 4211.4 4255.4 4256.9 4279.2 4298.1 4418.3 4431.3 4436.1 4458.2 4473.4 4704.6 4737.0 4752.2 4758.6 4810.3 4863.5 4972.1 5001.4 5005.8 5041.3 4664.7 4689.4 4753.3 4777.7 4778.4 4921.9 4931.6 4934.2 4935.2 4988.1 4872.0 4957.6 5018.1 5038.0 5070.1 4695.2 4784.6 4836.3 4850.0 4876.1 4865.1 4866.8 4875.5 4891.3 4914.5 4608.1 4685.5 4767.9 4780.6 4796.4 4907.1 4907.4 4908.7 4909.1 4936.3 4774.6 4780.4 4786.9 4799.3 4852.2 23:11:50 INFO - PROCESS | 25879 | 23:11:50 INFO - PROCESS | 25879 | [#1] ext.html Cycles:180 Average:41371.17 Median:36740.13 stddev:72078.21 (196.2%) stddev-sans-first:72215.05 23:11:50 INFO - PROCESS | 25879 | Values: 491.6 497.6 511.7 533.3 535.5 32652.7 33194.5 33244.0 33262.2 33307.7 36203.3 36586.6 36893.6 36936.6 36950.6 7655.8 7779.1 7823.0 7825.7 7845.5 7367.0 7475.9 7770.0 7914.0 7916.0 7505.4 7510.1 7511.7 7517.3 7536.2 7431.1 7458.8 7484.3 7489.2 7493.0 7337.8 7381.1 7413.0 7451.0 7455.3 37939.2 38476.6 38542.8 38553.8 38599.8 2371.8 2799.4 2809.0 2890.3 2931.1 26115.9 27257.5 27289.3 27587.0 27968.6 3461.5 3517.6 3517.8 3585.7 3633.1 145925.0 145940.3 146078.0 146631.0 147018.5 52102.5 52512.2 52792.0 52831.7 52899.7 54511.5 54617.7 60302.0 60765.4 61677.4 11982.6 12036.2 12056.0 12096.7 12129.3 9629.1 9671.9 9734.7 9746.0 9848.5 18722.2 18889.0 18927.7 18951.9 18979.6 7708.8 7981.4 8048.6 8098.1 8120.1 738.6 767.7 807.7 882.0 944.0 25758.5 25949.0 26068.3 26200.9 26221.9 887.8 888.4 916.7 920.1 976.5 13621.3 13926.9 13993.4 14157.2 14165.7 330068.0 381225.0 387759.0 391074.0 391676.0 44234.8 44641.6 45335.5 45416.8 45536.8 1173.7 1179.9 1206.3 1208.6 1231.3 25846.1 26720.5 27124.0 27273.0 27420.7 40658.2 41189.4 41346.0 41430.2 41578.2 239946.0 242946.0 243627.0 244085.0 246878.0 29396.7 29548.9 29715.7 30096.0 30125.0 39885.4 40008.0 40582.4 40729.6 40884.8 34457.0 34713.5 35045.6 35127.3 35154.5 33574.7 33637.7 33958.0 34006.1 34219.3 34465.5 34612.0 36453.5 37073.6 37161.3 27106.2 28319.0 28554.9 28645.9 29164.7 23759.6 23834.3 23836.8 23972.0 24196.9 23:11:50 INFO - PROCESS | 25879 | 23:11:50 INFO - PROCESS | 25879 | [#2] jquery.html Cycles:180 Average:22558.50 Median:26555.39 stddev:64501.81 (242.9%) stddev-sans-first:64661.14 23:11:50 INFO - PROCESS | 25879 | Values: 320.9 340.0 342.3 343.8 352.6 14622.7 15099.5 15635.3 15646.1 15654.9 14434.4 14664.3 14666.7 15408.2 15498.8 4789.4 4994.2 5011.6 5034.5 5037.4 4772.9 4931.4 4968.0 4970.8 4988.3 4896.5 4912.8 4938.5 4942.6 4945.6 4761.7 4811.9 4820.2 4916.0 4923.5 4325.4 4336.0 4358.4 4364.0 4366.1 18479.4 18516.5 18653.9 18778.4 18811.5 1772.3 1798.3 1830.0 1872.6 2092.5 12282.8 12459.7 12541.4 12627.0 12739.6 1708.7 1722.8 1725.4 1773.4 1792.2 52576.2 54923.0 56283.2 56562.7 56958.0 8965.0 9006.9 9082.9 9163.4 9229.2 12387.7 12422.6 12503.6 12514.8 12531.2 6366.2 6446.3 6491.1 6528.7 6624.1 5847.0 5858.5 5898.1 5904.5 5930.7 4124.7 4128.8 4161.0 4163.3 4169.8 1726.2 1741.8 1781.4 1781.9 1786.9 752.7 775.3 789.1 826.1 865.8 14891.6 15239.0 15473.7 15632.2 15968.7 812.8 835.5 836.4 845.0 849.2 8739.6 8802.4 8951.7 8951.8 8990.1 387840.0 390682.0 396293.0 398107.0 400041.0 43201.0 48214.3 58993.7 60689.7 60917.7 909.6 910.2 937.7 940.7 942.4 14241.6 14311.6 14345.6 14369.7 14781.3 29549.9 31515.8 31589.5 31627.8 32501.7 43612.6 44263.6 44368.1 44425.8 44922.3 7156.9 7197.7 7252.9 7352.2 7383.9 7331.6 8060.0 10860.2 11099.6 11284.6 8835.6 9518.7 9570.0 9643.8 9781.9 9505.9 9640.0 9645.4 9672.9 9681.6 5683.5 9544.2 9770.4 9828.4 10093.0 6964.4 7017.9 7048.5 7079.3 7136.5 7803.6 9585.7 9600.4 9600.7 9725.3 23:11:50 INFO - PROCESS | 25879 | 23:11:50 INFO - PROCESS | 25879 | [#3] mootools.html Cycles:180 Average:5162.10 Median:6229.33 stddev:2722.46 (43.7%) stddev-sans-first:2715.30 23:11:50 INFO - PROCESS | 25879 | Values: 1385.5 1392.9 1515.4 1729.9 1755.0 6280.3 6947.2 7013.3 7140.1 7179.0 7432.7 7467.8 7499.9 7505.5 7550.8 2162.9 2189.1 2192.0 2195.9 2197.3 2105.9 2154.4 2181.5 2182.7 2189.8 2177.3 2193.0 2211.2 2215.5 2225.7 2171.5 2203.0 2203.1 2208.4 2210.7 2114.7 2140.5 2156.3 2161.8 2171.0 7597.8 7677.7 7680.0 7682.4 7693.4 4402.7 4501.1 4502.8 4517.9 4520.9 2797.0 2866.7 2909.7 2913.8 2922.1 938.4 950.9 952.2 952.7 969.1 10467.4 10508.6 10530.2 10560.8 10577.7 3963.5 4016.4 4115.8 4152.3 4173.1 8734.1 8735.9 8752.7 8801.1 8829.5 4421.5 4447.8 4468.6 4477.5 4486.1 3387.3 3997.0 4036.1 4043.5 4060.1 3487.2 3565.5 3567.0 3596.2 3609.0 1140.7 1143.7 1150.1 1150.8 1151.0 909.2 929.0 930.9 967.2 1226.1 7221.3 7229.6 7245.5 7268.6 7311.4 459.3 459.7 461.3 462.8 469.6 5495.8 5522.8 5572.8 5588.3 5615.5 8837.5 9113.8 9167.4 9169.2 9195.0 8917.9 8964.6 8983.9 9001.1 9061.0 6491.2 6624.2 6627.4 6679.3 6711.5 6590.1 6685.7 6700.9 6704.0 6708.4 7671.9 7729.7 7914.9 7961.9 8042.0 7992.6 8001.5 8008.0 8054.8 8194.4 6049.8 6151.5 6168.5 6199.3 6206.5 6884.8 6912.8 6913.8 6926.9 6959.3 6147.8 6370.4 6421.7 6462.7 6617.8 6122.0 6252.2 6369.7 6374.4 6400.8 6498.2 6522.7 6525.3 6527.7 6545.4 6088.1 6137.9 6162.2 6351.8 6352.0 6404.9 6429.5 6430.0 6432.5 6439.4 23:11:50 INFO - PROCESS | 25879 | 23:11:50 INFO - PROCESS | 25879 | [#4] prototype.html Cycles:180 Average:4884.56 Median:5695.27 stddev:1483.26 (26.0%) stddev-sans-first:1447.04 23:11:50 INFO - PROCESS | 25879 | Values: 305.2 306.3 312.8 314.4 317.1 5582.9 5626.0 5768.9 5774.1 5783.0 5571.1 5661.7 5677.1 5684.5 5706.1 4045.6 4121.8 4201.9 4261.6 4271.2 4188.5 4189.8 4192.7 4203.7 4207.6 4161.0 4172.0 4192.9 4209.6 4223.6 4214.1 4221.9 4224.2 4233.2 4239.3 3642.3 3645.1 3647.9 3648.1 3656.1 5408.4 5415.2 5426.1 5450.8 5461.4 4685.6 4856.8 4861.8 4885.1 4902.9 5885.7 5886.2 5892.3 5895.5 5919.3 3984.7 3988.8 3995.1 3995.4 3995.9 6127.8 6169.7 6222.3 6225.9 6232.5 4114.2 4115.9 4123.6 4128.3 4139.7 4167.7 4173.4 4190.9 4197.8 4200.2 4626.7 4744.2 4751.9 4821.4 4859.9 5870.3 5900.4 5922.3 5950.3 5977.1 1441.3 1460.9 1461.3 1461.5 1462.6 958.2 969.6 977.6 985.9 988.6 5139.2 5148.6 5163.2 5165.1 5186.9 6143.7 6144.0 6151.3 6162.0 6170.2 4973.5 5145.3 5159.3 5167.7 5176.4 3221.9 3320.8 3335.3 3339.2 3343.1 5815.7 5833.9 5844.7 5851.8 5853.4 6391.0 6396.0 6410.4 6411.6 6434.3 5796.6 5824.7 5833.1 5848.2 5887.8 6018.5 6196.7 6208.4 6215.2 6225.6 5969.4 6024.6 6050.7 6051.9 6078.1 5804.4 5810.6 5843.8 5854.9 5868.1 4145.1 4159.5 4167.7 4176.0 4176.4 6163.3 6198.6 6202.8 6215.3 6217.6 5798.3 5970.2 5976.9 5987.5 5990.2 5948.8 5962.5 5972.1 5980.1 5988.8 5875.5 5899.9 5909.9 5916.6 5924.4 6006.5 6014.2 6020.4 6024.9 6030.9 5729.1 5870.7 5883.8 5887.9 5895.2 23:11:50 INFO - PROCESS | 25879 | 23:11:50 INFO - PROCESS | 25879 | [#5] yui.html Cycles:180 Average:12103.53 Median:21651.12 stddev:13409.36 (61.9%) stddev-sans-first:13419.70 23:11:50 INFO - PROCESS | 25879 | Values: 713.2 716.5 721.5 723.6 746.8 11727.7 11910.6 11992.1 12140.6 12166.1 11530.4 11649.9 12153.1 12975.3 13011.7 785.4 795.2 796.8 798.3 801.2 776.8 779.0 784.2 784.4 785.9 826.8 829.3 829.4 832.0 833.1 819.0 819.4 820.5 822.1 822.6 609.0 612.5 613.2 614.9 615.6 11661.6 11677.1 11724.2 11757.3 11764.6 12166.4 12181.0 12234.1 12282.7 12304.2 9471.9 9476.4 9538.5 9612.0 9717.9 3218.0 3251.2 3273.7 3299.6 3315.4 35995.0 38259.8 41165.8 42065.4 42073.6 9378.4 9519.8 9564.4 9629.3 9705.6 16083.8 16087.2 16140.2 16145.9 16185.4 6708.4 6797.8 6803.6 6914.2 7115.4 3512.2 3629.4 3676.8 3723.5 3755.2 2554.8 2563.3 2582.3 2587.6 2588.2 499.3 507.4 507.9 508.5 512.9 432.9 459.0 469.6 485.2 496.9 7229.4 7279.6 7347.0 7368.1 7413.1 560.6 568.6 569.5 583.0 590.5 3308.0 3526.7 3582.1 3586.5 3593.3 45843.1 45951.8 46030.5 46588.8 46636.8 42826.6 42869.0 42869.4 43504.6 43620.1 39728.0 40825.0 40837.8 40901.6 42344.6 8176.6 8183.3 8367.6 8412.7 8431.3 30574.7 30789.0 30808.8 30815.0 31846.5 36778.0 39388.6 39390.2 39714.0 39993.8 9897.8 10130.7 10399.9 10430.7 10522.5 10810.7 10955.5 10984.4 10995.5 11026.4 10536.3 10645.2 10745.0 10773.1 10861.5 9988.7 10029.4 10030.4 10273.7 10501.1 10352.1 10388.4 10453.3 10534.4 10594.4 8675.5 8921.2 8930.4 8968.9 8998.4 8806.9 8860.9 8976.6 9032.5 9043.3 23:11:50 INFO - PROCESS | 25879 | -------- Summary: end -------- 23:11:50 INFO - PROCESS | 25879 | 23:11:51 INFO - TEST-INFO | 25879: exit 0 23:11:51 INFO - TEST-OK | dromaeo_css | took 1115358ms 23:11:51 INFO - TEST-START | kraken 23:11:51 INFO - operating with platform_type : linux_ 23:11:51 INFO - Initialising browser for kraken test... 23:11:51 INFO - TEST-INFO | started process 26115 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7YFYFP/profile http://localhost:51819/getInfo.html) 23:11:55 INFO - PROCESS | 26115 | 23:11:55 INFO - PROCESS | 26115 | (process:26184): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:11:56 INFO - PROCESS | 26115 | __metrics Screen width/height:1600/1200 23:11:56 INFO - PROCESS | 26115 | colorDepth:24 23:11:56 INFO - PROCESS | 26115 | Browser inner width/height: 1024/697 23:11:56 INFO - PROCESS | 26115 | __metrics 23:11:57 ERROR - PROCESS | 26115 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 23:11:58 INFO - TEST-INFO | 26115: exit 0 23:11:58 INFO - Browser initialized. 23:11:58 INFO - Running cycle 1/1 for kraken test... 23:11:58 INFO - TEST-INFO | started process 26235 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7YFYFP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:12:00 INFO - PROCESS | 26235 | 23:12:00 INFO - PROCESS | 26235 | (process:26297): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:12:10 INFO - PROCESS | 26235 | RSS: Main: 165912576 23:12:10 INFO - PROCESS | 26235 | 23:12:12 INFO - PROCESS | 26235 | Cycle 1(1): loaded http://localhost:51819/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51819/tests/kraken/driver.html?testName=audio-beat-detection) 23:12:13 INFO - PROCESS | 26235 | RSS: Main: 170737664 23:12:13 INFO - PROCESS | 26235 | 23:12:16 INFO - PROCESS | 26235 | Cycle 1(1): loaded http://localhost:51819/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51819/tests/kraken/driver.html?testName=audio-dft) 23:12:16 INFO - PROCESS | 26235 | RSS: Main: 172081152 23:12:16 INFO - PROCESS | 26235 | 23:12:19 INFO - PROCESS | 26235 | Cycle 1(1): loaded http://localhost:51819/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51819/tests/kraken/driver.html?testName=audio-fft) 23:12:20 INFO - PROCESS | 26235 | RSS: Main: 166207488 23:12:20 INFO - PROCESS | 26235 | 23:12:22 INFO - PROCESS | 26235 | Cycle 1(1): loaded http://localhost:51819/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51819/tests/kraken/driver.html?testName=audio-oscillator) 23:12:23 INFO - PROCESS | 26235 | RSS: Main: 165085184 23:12:23 INFO - PROCESS | 26235 | 23:12:25 INFO - PROCESS | 26235 | Cycle 1(1): loaded http://localhost:51819/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51819/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:12:25 INFO - PROCESS | 26235 | RSS: Main: 168656896 23:12:25 INFO - PROCESS | 26235 | 23:12:29 INFO - PROCESS | 26235 | Cycle 1(1): loaded http://localhost:51819/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51819/tests/kraken/driver.html?testName=imaging-darkroom) 23:12:29 INFO - PROCESS | 26235 | RSS: Main: 167591936 23:12:29 INFO - PROCESS | 26235 | 23:12:33 INFO - PROCESS | 26235 | Cycle 1(1): loaded http://localhost:51819/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51819/tests/kraken/driver.html?testName=imaging-desaturate) 23:12:33 INFO - PROCESS | 26235 | RSS: Main: 167063552 23:12:33 INFO - PROCESS | 26235 | 23:12:36 INFO - PROCESS | 26235 | Cycle 1(1): loaded http://localhost:51819/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51819/tests/kraken/driver.html?testName=json-parse-financial) 23:12:37 INFO - PROCESS | 26235 | RSS: Main: 168194048 23:12:37 INFO - PROCESS | 26235 | 23:12:39 INFO - PROCESS | 26235 | Cycle 1(1): loaded http://localhost:51819/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51819/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:12:39 INFO - PROCESS | 26235 | RSS: Main: 169545728 23:12:39 INFO - PROCESS | 26235 | 23:12:41 INFO - PROCESS | 26235 | Cycle 1(1): loaded http://localhost:51819/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51819/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:12:42 INFO - PROCESS | 26235 | RSS: Main: 168886272 23:12:42 INFO - PROCESS | 26235 | 23:12:44 INFO - PROCESS | 26235 | Cycle 1(1): loaded http://localhost:51819/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51819/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:12:45 INFO - PROCESS | 26235 | RSS: Main: 167759872 23:12:45 INFO - PROCESS | 26235 | 23:12:47 INFO - PROCESS | 26235 | Cycle 1(1): loaded http://localhost:51819/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51819/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:12:48 INFO - PROCESS | 26235 | RSS: Main: 167952384 23:12:48 INFO - PROCESS | 26235 | 23:12:51 INFO - PROCESS | 26235 | Cycle 1(1): loaded http://localhost:51819/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51819/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:12:51 INFO - PROCESS | 26235 | RSS: Main: 168034304 23:12:51 INFO - PROCESS | 26235 | 23:12:53 INFO - PROCESS | 26235 | Cycle 1(1): loaded http://localhost:51819/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51819/tests/kraken/driver.html?testName=ai-astar) 23:12:53 INFO - PROCESS | 26235 | RSS: Main: 171429888 23:12:53 INFO - PROCESS | 26235 | 23:12:53 INFO - PROCESS | 26235 | __start_tp_report 23:12:53 INFO - PROCESS | 26235 | _x_x_mozilla_page_load 23:12:53 INFO - PROCESS | 26235 | _x_x_mozilla_page_load_details 23:12:53 INFO - PROCESS | 26235 | |i|pagename|runs| 23:12:53 INFO - PROCESS | 26235 | |0;ai-astar;113;110;114;113;113;126;113;113;114;113 23:12:53 INFO - PROCESS | 26235 | |1;audio-beat-detection;162;134;154;168;139;157;155;134;182;134 23:12:53 INFO - PROCESS | 26235 | |2;audio-dft;163;168;162;162;166;164;165;161;163;163 23:12:53 INFO - PROCESS | 26235 | |3;audio-fft;74;74;75;74;74;74;74;136;74;76 23:12:53 INFO - PROCESS | 26235 | |4;audio-oscillator;95;94;135;96;96;96;130;95;96;128 23:12:53 INFO - PROCESS | 26235 | |5;imaging-gaussian-blur;118;117;117;119;119;117;118;118;117;118 23:12:53 INFO - PROCESS | 26235 | |6;imaging-darkroom;149;148;148;154;151;151;148;149;149;147 23:12:53 INFO - PROCESS | 26235 | |7;imaging-desaturate;98;97;97;97;96;97;97;96;96;95 23:12:53 INFO - PROCESS | 26235 | |8;json-parse-financial;68;68;68;68;68;69;68;68;71;68 23:12:53 INFO - PROCESS | 26235 | |9;json-stringify-tinderbox;71;71;69;71;71;70;69;69;70;69 23:12:53 INFO - PROCESS | 26235 | |10;stanford-crypto-aes;83;84;92;84;82;85;84;83;87;85 23:12:53 INFO - PROCESS | 26235 | |11;stanford-crypto-ccm;128;126;139;130;128;130;125;135;127;131 23:12:53 INFO - PROCESS | 26235 | |12;stanford-crypto-pbkdf2;141;152;151;154;151;140;155;150;151;139 23:12:53 INFO - PROCESS | 26235 | |13;stanford-crypto-sha256-iterative;72;76;72;72;72;74;70;72;73;74 23:12:53 INFO - PROCESS | 26235 | __end_tp_report 23:12:53 INFO - PROCESS | 26235 | __start_cc_report 23:12:53 INFO - PROCESS | 26235 | _x_x_mozilla_cycle_collect,920 23:12:53 INFO - PROCESS | 26235 | __end_cc_report 23:12:53 INFO - PROCESS | 26235 | __startTimestamp1457421173705__endTimestamp 23:12:53 INFO - PROCESS | 26235 | 23:12:53 INFO - PROCESS | 26235 | ------- Summary: start ------- 23:12:53 INFO - PROCESS | 26235 | Number of tests: 14 23:12:53 INFO - PROCESS | 26235 | 23:12:53 INFO - PROCESS | 26235 | [#0] ai-astar Cycles:10 Average:114.20 Median:113.00 stddev:4.29 (3.8%) stddev-sans-first:4.53 23:12:53 INFO - PROCESS | 26235 | Values: 113.0 110.0 114.0 113.0 113.0 126.0 113.0 113.0 114.0 113.0 23:12:53 INFO - PROCESS | 26235 | 23:12:53 INFO - PROCESS | 26235 | [#1] audio-beat-detection Cycles:10 Average:151.90 Median:156.00 stddev:16.45 (10.5%) stddev-sans-first:17.04 23:12:53 INFO - PROCESS | 26235 | Values: 162.0 134.0 154.0 168.0 139.0 157.0 155.0 134.0 182.0 134.0 23:12:53 INFO - PROCESS | 26235 | 23:12:53 INFO - PROCESS | 26235 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.50 stddev:2.11 (1.3%) stddev-sans-first:2.22 23:12:53 INFO - PROCESS | 26235 | Values: 163.0 168.0 162.0 162.0 166.0 164.0 165.0 161.0 163.0 163.0 23:12:53 INFO - PROCESS | 26235 | 23:12:53 INFO - PROCESS | 26235 | [#3] audio-fft Cycles:10 Average:80.50 Median:74.00 stddev:19.51 (26.4%) stddev-sans-first:20.55 23:12:53 INFO - PROCESS | 26235 | Values: 74.0 74.0 75.0 74.0 74.0 74.0 74.0 136.0 74.0 76.0 23:12:53 INFO - PROCESS | 26235 | 23:12:53 INFO - PROCESS | 26235 | [#4] audio-oscillator Cycles:10 Average:106.10 Median:95.50 stddev:17.28 (18.1%) stddev-sans-first:17.85 23:12:53 INFO - PROCESS | 26235 | Values: 95.0 94.0 135.0 96.0 96.0 96.0 130.0 95.0 96.0 128.0 23:12:53 INFO - PROCESS | 26235 | 23:12:53 INFO - PROCESS | 26235 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 23:12:53 INFO - PROCESS | 26235 | Values: 118.0 117.0 117.0 119.0 119.0 117.0 118.0 118.0 117.0 118.0 23:12:53 INFO - PROCESS | 26235 | 23:12:53 INFO - PROCESS | 26235 | [#6] imaging-darkroom Cycles:10 Average:149.40 Median:149.00 stddev:2.07 (1.4%) stddev-sans-first:2.19 23:12:53 INFO - PROCESS | 26235 | Values: 149.0 148.0 148.0 154.0 151.0 151.0 148.0 149.0 149.0 147.0 23:12:53 INFO - PROCESS | 26235 | 23:12:53 INFO - PROCESS | 26235 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.84 (0.9%) stddev-sans-first:0.73 23:12:53 INFO - PROCESS | 26235 | Values: 98.0 97.0 97.0 97.0 96.0 97.0 97.0 96.0 96.0 95.0 23:12:53 INFO - PROCESS | 26235 | 23:12:53 INFO - PROCESS | 26235 | [#8] json-parse-financial Cycles:10 Average:68.40 Median:68.00 stddev:0.97 (1.4%) stddev-sans-first:1.01 23:12:53 INFO - PROCESS | 26235 | Values: 68.0 68.0 68.0 68.0 68.0 69.0 68.0 68.0 71.0 68.0 23:12:53 INFO - PROCESS | 26235 | 23:12:53 INFO - PROCESS | 26235 | [#9] json-stringify-tinderbox Cycles:10 Average:70.00 Median:70.50 stddev:0.94 (1.3%) stddev-sans-first:0.93 23:12:53 INFO - PROCESS | 26235 | Values: 71.0 71.0 69.0 71.0 71.0 70.0 69.0 69.0 70.0 69.0 23:12:53 INFO - PROCESS | 26235 | 23:12:53 INFO - PROCESS | 26235 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:84.50 stddev:2.85 (3.4%) stddev-sans-first:2.93 23:12:53 INFO - PROCESS | 26235 | Values: 83.0 84.0 92.0 84.0 82.0 85.0 84.0 83.0 87.0 85.0 23:12:53 INFO - PROCESS | 26235 | 23:12:53 INFO - PROCESS | 26235 | [#11] stanford-crypto-ccm Cycles:10 Average:129.90 Median:130.00 stddev:4.28 (3.3%) stddev-sans-first:4.48 23:12:53 INFO - PROCESS | 26235 | Values: 128.0 126.0 139.0 130.0 128.0 130.0 125.0 135.0 127.0 131.0 23:12:53 INFO - PROCESS | 26235 | 23:12:53 INFO - PROCESS | 26235 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.40 Median:151.00 stddev:6.00 (4.0%) stddev-sans-first:5.74 23:12:53 INFO - PROCESS | 26235 | Values: 141.0 152.0 151.0 154.0 151.0 140.0 155.0 150.0 151.0 139.0 23:12:53 INFO - PROCESS | 26235 | 23:12:53 INFO - PROCESS | 26235 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.70 Median:72.50 stddev:1.64 (2.3%) stddev-sans-first:1.72 23:12:53 INFO - PROCESS | 26235 | Values: 72.0 76.0 72.0 72.0 72.0 74.0 70.0 72.0 73.0 74.0 23:12:53 INFO - PROCESS | 26235 | -------- Summary: end -------- 23:12:53 INFO - PROCESS | 26235 | 23:12:54 INFO - TEST-INFO | 26235: exit 0 23:12:54 INFO - TEST-OK | kraken | took 63159ms 23:12:54 INFO - SUITE-END | took 1178s 23:12:54 INFO - Completed test suite (00:19:38) 23:12:54 INFO - javascript benchmark 23:12:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2609.060738134272, 2639.709631940487, 2664.3205982474465, 2678.3304173956512, 2685.6777186737595, 4601.355810186572, 4634.884127896804, 4636.4899861015265, 4673.9065218695605, 4679.906401871961, 4558.111168322179, 4625.791839367228, 4647.442306923165, 4658.60401865841, 4708.152532544149, 4260.70175087744, 4296.505901821283, 4342.869713908588, 4354.738715677054, 4412.889677758049, 4245.214635292481, 4245.681573881971, 4321.611055005049, 4324.6107850293465, 4378.321360189176, 4229.027323715547, 4276.0, 4292.699511034229, 4294.463192100988, 4343.457067866517, 4246.808893599796, 4252.617264446215, 4260.169266992938, 4280.058387154821, 4289.378040184187, 4110.403991421257, 4187.20443115807, 4197.18154959783, 4201.831926722927, 4232.9153416931795, 4536.183486972343, 4546.636269098464, 4560.840370587013, 4612.976935115336, 4613.1696294666945, 4935.037667654773, 4948.331975183341, 4956.182229932093, 4972.154733695281, 4972.179590367585, 4869.245266983623, 4986.326845875797, 5002.399712034543, 5043.470435604246, 5051.87370315745, 4605.631549476034, 4622.214223581999, 4636.907261854744, 4659.0, 4665.860024199212, 5080.745962701924, 5088.389393272831, 5095.8726031848755, 5103.923441148386, 5145.742712864342, 4790.616750659939, 4864.708117512961, 4888.6577939543895, 4890.462049174588, 4933.309336692794, 4834.274858771212, 4963.280324353021, 4974.37820272466, 5031.069252188357, 5101.0818052750865, 4935.703857768545, 4936.506349365107, 4946.703197808071, 4958.281049247911, 5001.549860512571, 4724.763761811964, 4779.354787103696, 4824.204006338985, 4880.585150262267, 4892.975535122301, 4135.441715368387, 4135.813888375031, 4138.358554424069, 4140.068484590943, 4182.163567286494, 3612.7897154453026, 3616.746827722087, 3623.673869351718, 3651.9817400912825, 3668.6514781095752, 4294.699371044059, 4318.050028993616, 4335.523092459827, 4337.934930976038, 4358.411614432074, 4929.088118698052, 4948.505149485023, 4952.207646776498, 4974.626902982219, 4988.80044798204, 4211.36829475575, 4255.425517555091, 4256.914861702749, 4279.229738647074, 4298.054428025829, 4418.337249412614, 4431.290993441034, 4436.0906014267, 4458.242098843204, 4473.373727678128, 4704.553067458586, 4736.976315118402, 4752.192127338291, 4758.571728544448, 4810.254410566367, 4863.513648635249, 4972.055309491185, 5001.374828146481, 5005.77474013663, 5041.294218809443, 4664.650151238603, 4689.366935463669, 4753.334533165429, 4777.689450185727, 4778.402699662543, 4921.926171107365, 4931.6301277405055, 4934.235193545006, 4935.210366341368, 4988.12707776145, 4872.049950259665, 4957.578605818546, 5018.121828679893, 5038.0, 5070.112730272114, 4695.201815691273, 4784.641151913551, 4836.322914792002, 4849.95150048495, 4876.073546026244, 4865.051314993542, 4866.8053277868485, 4875.512448755097, 4891.26631005352, 4914.508549145057, 4608.055348653585, 4685.484596694293, 4767.904641907073, 4780.569748722632, 4796.37647105874, 4907.141250281258, 4907.386576677915, 4908.656394052525, 4909.116359055404, 4936.3089167515855, 4774.594159496482, 4780.402449693788, 4786.856394308176, 4799.328094066903, 4852.175130227799], "unit": "score", "name": "dojo.html", "value": 4561.116995467554}, {"lowerIsBetter": false, "replicates": [491.5723320710982, 497.57705949942533, 511.7083262540351, 533.2774091106551, 535.5073332534067, 32652.67347326529, 33194.50208246872, 33244.0, 33262.16844578884, 33307.66692333082, 36203.275934481295, 36586.63413365872, 36893.631063689354, 36936.630633693654, 36950.630493695055, 7655.8468830623215, 7779.144294127642, 7822.960885195566, 7825.726099586515, 7845.450818442711, 7366.963165184166, 7475.887861682079, 7770.0, 7914.0, 7916.0, 7505.362044226247, 7510.061242344707, 7511.6995320187125, 7517.323440890319, 7536.246375362474, 7431.145418276913, 7458.813529661747, 7484.288992545699, 7489.213632568556, 7492.962535187344, 7337.816554586178, 7381.114266288027, 7413.036305280333, 7450.96274518624, 7455.254474552556, 37939.24121517582, 38476.615233847864, 38542.807285963674, 38553.80723096366, 38599.8070009651, 2371.774681405264, 2799.398129402168, 2808.9859550702117, 2890.2918784897624, 2931.1353150820346, 26115.869420652965, 27257.454850902872, 27289.317767055785, 27587.0, 27968.580471292946, 3461.5153878457036, 3517.6306487818924, 3517.7537572369943, 3585.74035867324, 3633.128049268183, 145925.0, 145940.27029864784, 146078.0, 146631.0, 147018.52981470156, 52102.478975209764, 52512.212316815276, 52792.0, 52831.735841320544, 52899.73550132302, 54511.45488545143, 54617.726911365186, 60302.0, 60765.392346075976, 61677.38322616806, 11982.64052078439, 12036.217645852992, 12056.0, 12096.697582560506, 12129.332886691316, 9629.085236902483, 9671.854922176173, 9734.659286924923, 9745.951270243746, 9848.458334791656, 18722.15750291213, 18889.0, 18927.716084258747, 18951.90524047371, 18979.62040759177, 7708.845823083507, 7981.441299109123, 8048.5975701215875, 8098.149694282133, 8120.147384524658, 738.5605564689001, 767.6814122139361, 807.7051876065194, 882.0121463960277, 943.9528023598739, 25758.48483030329, 25948.962041518505, 26068.34829129287, 26200.8689956549, 26221.868890655423, 887.8179973105498, 888.4092078767676, 916.6745805239044, 920.1396694091046, 976.4824642939253, 13621.318934053455, 13926.860731392759, 13993.3702983366, 14157.221352825487, 14165.71668566623, 330068.0, 381225.0, 387759.0, 391074.0, 391676.0, 44234.77882610566, 44641.55358446374, 45335.546644533795, 45416.77291613521, 45536.77231613821, 1173.700706319883, 1179.899708524785, 1206.3304865799566, 1208.6494916474123, 1231.310466138965, 25846.095386661378, 26720.52633157677, 27124.0, 27273.0, 27420.725792741818, 40658.1868362637, 41189.382159268236, 41346.0, 41430.1713965725, 41578.168436631706, 239946.0, 242946.0, 243627.0, 244085.0, 246878.0, 29396.706032939397, 29548.852255738584, 29715.702842971292, 30096.0, 30125.0, 39885.401718973655, 40008.0, 40582.39126413165, 40729.59270407258, 40884.79557602193, 34457.0, 34713.479297810045, 35045.64954350526, 35127.29745405026, 35154.47268291029, 33574.66425335715, 33637.663623363456, 33958.001129701144, 34006.14984625404, 34219.31561368709, 34465.48301775425, 34612.0, 36453.45319820258, 37073.629263707015, 37161.256774864894, 27106.186814395598, 28319.0, 28554.85722571374, 28645.856770716015, 29164.70835291705, 23759.64360534628, 23834.284971450885, 23836.761632383455, 23972.0, 24196.87901560481], "unit": "score", "name": "ext.html", "value": 16497.693786022122}, {"lowerIsBetter": false, "replicates": [320.9021248519201, 339.97450191235646, 342.3068286719393, 343.82980424689765, 352.57514694792775, 14622.70754584909, 15099.547013589596, 15635.296411661475, 15646.139462329567, 15654.921725391385, 14434.42262309509, 14664.266786660677, 14666.706665866675, 15408.152551609657, 15498.767518487204, 4789.42526896772, 4994.200927851544, 5011.599072074226, 5034.471380505049, 5037.395512538482, 4772.856814295559, 4931.358923339961, 4968.0, 4970.801167953296, 4988.301637770715, 4896.510348965111, 4912.803487860481, 4938.506149385051, 4942.555170034696, 4945.604351651859, 4761.690490118166, 4811.855644330676, 4820.204666230068, 4915.975420122894, 4923.458419573844, 4325.351197320427, 4336.0, 4358.389825424443, 4364.018095928423, 4366.148601022802, 18479.445616631387, 18516.537086572807, 18653.906730466395, 18778.436646900616, 18811.52971175718, 1772.2822256985942, 1798.2537247042462, 1830.03922940456, 1872.586197420952, 2092.5187206942487, 12282.815757763641, 12459.688507787287, 12541.372931353395, 12627.0, 12739.61781146567, 1708.7180615198477, 1722.7846519185102, 1725.447856685861, 1773.3704534890187, 1792.2024699008946, 52576.2113568293, 54923.0, 56283.15575266374, 56562.717186414215, 56958.0, 8964.955175224082, 9006.86489702655, 9082.909170908339, 9163.404378715362, 9229.16937475617, 12387.690307742198, 12422.565210217599, 12503.624891253277, 12514.81227781584, 12531.18547294423, 6366.204224471941, 6446.323136070645, 6491.091247225392, 6528.673566321665, 6624.105745724266, 5846.970765146232, 5858.53131749459, 5898.085796701518, 5904.498117660047, 5930.673812940329, 4124.711270211056, 4128.8348466061025, 4160.993409944949, 4163.292240319153, 4169.791510424467, 1726.2490816494865, 1741.8084010758807, 1781.403229917966, 1781.8930864148192, 1786.937457188992, 752.6913965274321, 775.3370867907857, 789.0846617923181, 826.0747962282283, 865.8484765166071, 14891.627709307353, 15239.0, 15473.690526189414, 15632.218389080728, 15968.680626387639, 812.792737851844, 835.5446281776447, 836.3643630840605, 844.9746507604659, 849.1762989899787, 8739.60671769772, 8802.427842190236, 8951.731448056438, 8951.820963580822, 8990.100989900957, 387840.0, 390682.0, 396293.0, 398107.0, 400041.0, 43201.0, 48214.27678584824, 58993.70503147542, 60689.696551517845, 60917.69541152266, 909.6088681866728, 910.1853840812436, 937.723371605378, 940.6613619097257, 942.3733217410345, 14241.572752817432, 14311.642208944444, 14345.569632911029, 14369.712605747618, 14781.334839932013, 29549.852250738608, 31515.84242078775, 31589.52615710812, 31627.841860790548, 32501.67498325081, 43612.56387436085, 44263.55736442594, 44368.11263774771, 44425.77787111044, 44922.32616510821, 7156.892646610201, 7197.676104575202, 7252.891206631799, 7352.191258961403, 7383.926160738324, 7331.596762178131, 8059.952206213155, 10860.185486088418, 11099.611513596985, 11284.605038823602, 8835.602397891982, 9518.714438566854, 9570.042995700374, 9643.758906027406, 9781.85327220078, 9505.857412138685, 9640.0, 9645.37305075168, 9672.93597704238, 9681.612735490784, 5683.460071293221, 9544.236461083236, 9770.36492627977, 9828.4102953823, 10093.041161089684, 6964.442844572523, 7017.859642807218, 7048.541844780073, 7079.2566780487305, 7136.536125151849, 7803.648835802289, 9585.664501742405, 9600.423974561549, 9600.66397676078, 9725.31922765428], "unit": "score", "name": "jquery.html", "value": 7532.586898264827}, {"lowerIsBetter": false, "replicates": [1385.4665953607862, 1392.8676775706308, 1515.3786947351582, 1729.878908476407, 1754.9561260968483, 6280.309165991749, 6947.166340039203, 7013.263607321228, 7140.071790667213, 7179.0, 7432.702691892331, 7467.813304667372, 7499.887501687479, 7505.474616776828, 7550.773476795691, 2162.8753048414815, 2189.1462329691353, 2191.9890400547974, 2195.879226642534, 2197.3407977606653, 2105.9262925797602, 2154.4183070570934, 2181.4873504726456, 2182.7489838668516, 2189.813865821407, 2177.292379976514, 2192.9780702192934, 2211.1708109458955, 2215.4572129828216, 2225.744039435461, 2171.533120379126, 2203.030666506732, 2203.0967303405605, 2208.3706143749114, 2210.668399740036, 2114.693369461435, 2140.4541841830232, 2156.3315372234656, 2161.794629510194, 2171.0230396321563, 7597.848043039108, 7677.692892284302, 7680.0, 7682.4238182136005, 7693.384529237704, 4402.691811573191, 4501.0547784964865, 4502.774861256957, 4517.909641807146, 4520.86437406875, 2796.986015069932, 2866.698996605368, 2909.7090290970946, 2913.766898648103, 2922.1233629911153, 938.3525367496405, 950.8763860698134, 952.2382094324513, 952.7284723853669, 969.0745338202071, 10467.424291663956, 10508.632197873038, 10530.210234232463, 10560.841587376195, 10577.735556611146, 3963.4649322341693, 4016.377461493473, 4115.794210289474, 4152.2525945330135, 4173.061061261253, 8734.082921293173, 8735.908011498563, 8752.737417877473, 8801.119888011148, 8829.514376709343, 4421.491528474202, 4447.844325448658, 4468.597826195658, 4477.462704475483, 4486.147631949919, 3387.3394688036087, 3997.0, 4036.1322315702264, 4043.474348334698, 4060.0864805418546, 3487.232808782064, 3565.5186549815444, 3566.982165089158, 3596.172880237508, 3609.007522931215, 1140.6977151054978, 1143.742657901982, 1150.1029197226178, 1150.804363258248, 1150.9539618415338, 909.1953621045423, 929.0338048429693, 930.9069093090773, 967.2213867836459, 1226.068188176992, 7221.277872212737, 7229.566226026455, 7245.529040612343, 7268.636568171571, 7311.378532824663, 459.25371271683514, 459.73105733145815, 461.2988257848052, 462.79868257307504, 469.60553135365774, 5495.780168793203, 5522.834314970557, 5572.804951826666, 5588.329400471969, 5615.494605485526, 8837.469751814911, 9113.77215569616, 9167.449953002708, 9169.174774270348, 9194.954025229965, 8917.910820891708, 8964.596593153194, 8983.910160898438, 9001.144891235323, 9061.0, 6491.188601424822, 6624.238212605515, 6627.436667883284, 6679.265280819009, 6711.4966377520905, 6590.143281373391, 6685.699143538455, 6700.932990670226, 6704.027915952062, 6708.42978346846, 7671.884921726067, 7729.690812367668, 7914.881276780968, 7961.920380796118, 8041.959790201012, 7992.560409177318, 8001.519908805491, 8008.039035315799, 8054.83890322202, 8194.385421093322, 6049.78825741097, 6151.5386346025125, 6168.475679567107, 6199.256089269316, 6206.503479721521, 6884.827879302858, 6912.827179320558, 6913.75801846933, 6926.9307306926285, 6959.304069593, 6147.84630384244, 6370.394812492806, 6421.678916054272, 6462.741490340334, 6617.8014659560295, 6122.0, 6252.155958945484, 6369.7452101915405, 6374.362563743589, 6400.839979000376, 6498.187726534184, 6522.739090436329, 6525.282218956006, 6527.706253218522, 6545.443637290693, 6088.056351265561, 6137.938620613915, 6162.168107305636, 6351.777687780906, 6352.0, 6404.871902562016, 6429.4856411486035, 6429.9678501607195, 6432.453241474527, 6439.420452159328], "unit": "score", "name": "mootools.html", "value": 4159.102296756897}, {"lowerIsBetter": false, "replicates": [305.15928616661097, 306.2741303111627, 312.8107494965546, 314.42303373309977, 317.05043395031885, 5582.916256256154, 5626.043572592659, 5768.884622307556, 5774.105013722879, 5782.971085144579, 5571.13647384655, 5661.716914154286, 5677.091665333547, 5684.459976302255, 5706.087026075828, 4045.63589276965, 4121.814518346667, 4201.936970945439, 4261.595148460891, 4271.1671224111315, 4188.518320393163, 4189.79051047448, 4192.748435093904, 4203.726757760751, 4207.600277973587, 4161.0429601191745, 4171.979140104295, 4192.895177620553, 4209.6421804146685, 4223.556526564697, 4214.115035842477, 4221.894452638693, 4224.176285624305, 4233.153369326147, 4239.342901850218, 3642.3261696586214, 3645.052286405527, 3647.908802279938, 3648.1244501319757, 3656.104254457675, 5408.378036525811, 5415.187721841716, 5426.050441172779, 5450.781968721247, 5461.371942226615, 4685.6485763567525, 4856.781444834991, 4861.781219845116, 4885.071836351118, 4902.926456103161, 5885.735141918624, 5886.20536227608, 5892.263467066617, 5895.469407753323, 5919.3192782829665, 3984.7011474139554, 3988.80055997199, 3995.06116062725, 3995.440638310639, 3995.9200815983518, 6127.816165515042, 6169.691515424211, 6222.284437289724, 6225.87548249037, 6232.501399888043, 4114.19773144234, 4115.938260926028, 4123.567025462343, 4128.298189307765, 4139.668826493873, 4167.729097608646, 4173.373993900939, 4190.916181676411, 4197.790110494463, 4200.159968006411, 4626.699264547794, 4744.240921452551, 4751.928721069186, 4821.373221481185, 4859.878503037452, 5870.3249126350165, 5900.350961394243, 5922.289325280994, 5950.345461999176, 5977.103434484862, 1441.2793603198402, 1460.9415623374946, 1461.283970854295, 1461.4884790323515, 1462.641652795072, 958.2477754962321, 969.5927710361665, 977.5796407544682, 985.9260555458369, 988.5502096546054, 5139.229115632685, 5148.588112950955, 5163.199704045804, 5165.147750621106, 5186.948130518646, 6143.723532441051, 6143.96928015357, 6151.292601350812, 6162.0, 6170.197874276315, 4973.502649734997, 5145.305383773218, 5159.25190847325, 5167.741612919339, 5176.352955880515, 3221.8872339468007, 3320.817355045496, 3335.266241426882, 3339.2486690494443, 3343.0639420961684, 5815.651060936273, 5833.912491312633, 5844.736986835603, 5851.829634073202, 5853.44392282741, 6391.0, 6395.968020159869, 6410.391012853772, 6411.647359395185, 6434.292227854932, 5796.623219490804, 5824.650520968756, 5833.125031245348, 5848.210491583667, 5887.764489420375, 6018.548608854266, 6196.690165491797, 6208.379162083756, 6215.192025036717, 6225.626462412089, 5969.432903874125, 6024.638521688713, 6050.727717252822, 6051.939480605138, 6078.149059131813, 5804.419558044331, 5810.564207684356, 5843.766249349978, 5854.853628659318, 5868.061110222344, 4145.1295228002455, 4159.521655009713, 4167.708260421741, 4175.97912010438, 4176.415301857682, 6163.291221509584, 6198.628082314895, 6202.751889924533, 6215.34738852414, 6217.595856269328, 5798.275215598051, 5970.164177015135, 5976.880462390641, 5987.491063259672, 5990.2212712348855, 5948.821535353946, 5962.4633782959745, 5972.13404056418, 5980.073088671263, 5988.820335389945, 5875.471207591338, 5899.852503687271, 5909.852253693692, 5916.615419997686, 5924.377940316204, 6006.489448396936, 6014.1580178775885, 6020.4280593343565, 6024.939750602438, 6030.939690603038, 5729.083346664514, 5870.677112758839, 5883.794067207627, 5887.882242355044, 5895.20414744004], "unit": "score", "name": "prototype.html", "value": 4401.836446299314}, {"lowerIsBetter": false, "replicates": [713.1655962523848, 716.4698123388694, 721.5273995532928, 723.5550136665952, 746.76103646833, 11727.706807329821, 11910.583129590466, 11992.10059245558, 12140.635780926576, 12166.087543434245, 11530.423478826067, 11649.941750291237, 12153.088518361114, 12975.286359250238, 13011.73976520469, 785.4148659248854, 795.1690483444785, 796.8207153390499, 798.2974982015818, 801.1507801730155, 776.7708525984848, 778.9805254868617, 784.2432053068787, 784.419529548136, 785.9096203936534, 826.7726375246795, 829.2536716954759, 829.4276948905266, 831.9750407487785, 833.0669649992018, 819.0499021135485, 819.4141189049828, 820.4830956497428, 822.0792712162356, 822.6257053040912, 608.9695515224265, 612.5344737999153, 613.2242712968099, 614.8647297594522, 615.6213928433981, 11661.591844285409, 11677.065834733286, 11724.237924534964, 11757.294562326288, 11764.647060588197, 12166.391680415943, 12181.025517958542, 12234.143609947307, 12282.692932676666, 12304.200226985216, 9471.857922131105, 9476.431414115175, 9538.52307384628, 9611.951940240255, 9717.854232186452, 3217.9839100804347, 3251.1872031992, 3273.705366517001, 3299.5875515560556, 3315.4032274190636, 35995.0, 38259.80870095632, 41165.79417102895, 42065.369019464735, 42073.579264207576, 9378.390404623678, 9519.762005949906, 9564.378315409476, 9629.277804164716, 9705.563249653642, 16083.839161608468, 16087.195640217942, 16140.192990350435, 16145.919270403807, 16185.4335098271, 6708.429783468362, 6797.762078327235, 6803.625800580917, 6914.1702995639835, 7115.430765538745, 3512.2097528056493, 3629.4374371972385, 3676.8345424455965, 3723.4600982857874, 3755.173861750465, 2554.757298056719, 2563.3207200091992, 2582.2769624505167, 2587.637730717701, 2588.2494076717917, 499.32744663003086, 507.3505912432093, 507.90349833531513, 508.5016683650044, 512.943576206617, 432.89177705573604, 458.95410458954507, 469.5603072945294, 485.22121994199506, 496.86584622151815, 7229.385502232369, 7279.636018199175, 7347.0, 7368.0846176126415, 7413.1104267488245, 560.5683623609879, 568.6275489554348, 569.5102212097593, 582.9621074630136, 590.4862769390572, 3307.9503807442907, 3526.7354948378975, 3582.1044738815294, 3586.5158203642172, 3593.2813437312643, 45843.083138337046, 45951.77024114925, 46030.53969460262, 46588.7670561645, 46636.7668161657, 42826.57173428226, 42869.0, 42869.35695964563, 43504.564954350055, 43620.12759744787, 39728.0, 40825.0, 40837.795811020755, 40901.59098409038, 42344.57655423468, 8176.591170441335, 8183.263506284463, 8367.62345694433, 8412.747617571482, 8431.28334091609, 30574.694253057183, 30789.0, 30808.845955770077, 30815.0, 31846.52230216595, 36778.0, 39388.60611393849, 39390.21219575535, 39714.0, 39993.80003100082, 9897.752556186153, 10130.696079117639, 10399.94800025995, 10430.68707938763, 10522.526486307981, 10810.67567972962, 10955.45222738844, 10984.395858227554, 10995.450227488434, 11026.44867756625, 10536.262461627612, 10645.201609879136, 10745.0, 10773.138148948223, 10861.456927153453, 9988.700338989842, 10029.398236105857, 10030.448325342177, 10273.691789246335, 10501.107405870282, 10352.120069793851, 10388.428636424767, 10453.320534165256, 10534.36793792375, 10594.364338139736, 8675.522846243517, 8921.15249051339, 8930.419522731001, 8968.865467018131, 8998.370114091951, 8806.911930880866, 8860.911390886009, 8976.640934362813, 9032.503212323385, 9043.32175086858], "unit": "score", "name": "yui.html", "value": 5684.213702352687}], "name": "dromaeo_css", "value": 6239.224151070379}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 110.0, 114.0, 113.0, 113.0, 126.0, 113.0, 113.0, 114.0, 113.0], "unit": "score", "name": "ai-astar", "value": 114.2}, {"lowerIsBetter": true, "replicates": [162.0, 134.0, 154.0, 168.0, 139.0, 157.0, 155.0, 134.0, 182.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 151.9}, {"lowerIsBetter": true, "replicates": [163.0, 168.0, 162.0, 162.0, 166.0, 164.0, 165.0, 161.0, 163.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.7}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 75.0, 74.0, 74.0, 74.0, 74.0, 136.0, 74.0, 76.0], "unit": "score", "name": "audio-fft", "value": 80.5}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 135.0, 96.0, 96.0, 96.0, 130.0, 95.0, 96.0, 128.0], "unit": "score", "name": "audio-oscillator", "value": 106.1}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 117.0, 119.0, 119.0, 117.0, 118.0, 118.0, 117.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.8}, {"lowerIsBetter": true, "replicates": [149.0, 148.0, 148.0, 154.0, 151.0, 151.0, 148.0, 149.0, 149.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 149.4}, {"lowerIsBetter": true, "replicates": [98.0, 97.0, 97.0, 97.0, 96.0, 97.0, 97.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0, 71.0, 68.0], "unit": "score", "name": "json-parse-financial", "value": 68.4}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 69.0, 71.0, 71.0, 70.0, 69.0, 69.0, 70.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.0}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 92.0, 84.0, 82.0, 85.0, 84.0, 83.0, 87.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.9}, {"lowerIsBetter": true, "replicates": [128.0, 126.0, 139.0, 130.0, 128.0, 130.0, 125.0, 135.0, 127.0, 131.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.9}, {"lowerIsBetter": true, "replicates": [141.0, 152.0, 151.0, 154.0, 151.0, 140.0, 155.0, 150.0, 151.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.4}, {"lowerIsBetter": true, "replicates": [72.0, 76.0, 72.0, 72.0, 72.0, 74.0, 70.0, 72.0, 73.0, 74.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.7}], "name": "kraken", "value": 1554.5000000000002}]} 23:12:54 INFO - Return code: 0 23:12:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:12:54 ERROR - # TBPL SUCCESS # 23:12:54 INFO - Running post-action listener: _resource_record_post_action 23:12:54 INFO - Running post-run listener: _resource_record_post_run 23:12:56 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 12288; Write bytes: 523345920; Read time: 420; Write time: 484328 23:12:56 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 233623552; Read time: 224; Write time: 284496 23:12:56 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 8192; Write bytes: 289468416; Read time: 196; Write time: 199780 23:12:56 INFO - Running post-run listener: _upload_blobber_files 23:12:56 INFO - Blob upload gear active. 23:12:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:12:56 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 23:12:56 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'] 23:12:56 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 23:12:56 INFO - (blobuploader) - INFO - Open directory for files ... 23:12:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:12:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:12:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:12:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:12:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:12:57 INFO - (blobuploader) - INFO - Done attempting. 23:12:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:12:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:12:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:12:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:12:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:12:58 INFO - (blobuploader) - INFO - Done attempting. 23:12:58 INFO - (blobuploader) - INFO - Iteration through files over. 23:12:58 INFO - Return code: 0 23:12:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:12:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:12:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ef66e0a5a66a3c0e270771c020314d8c8703cf729dd51156949f97fb98c6c208ca5efb6f6320aa845dc4cc413d6b44e89b4491cbbe69c9d48e44b849bdaa6d09", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/157561da80e07d1c2c891d2f03ff82f30cbca52deca7c3feec2462085db197febbe6dc2c3564d1f5bc6b9848f7742b696636ca3d9ecdbdc4c20be1d4c56fe031"} 23:12:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:12:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:12:58 INFO - Contents: 23:12:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ef66e0a5a66a3c0e270771c020314d8c8703cf729dd51156949f97fb98c6c208ca5efb6f6320aa845dc4cc413d6b44e89b4491cbbe69c9d48e44b849bdaa6d09", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/157561da80e07d1c2c891d2f03ff82f30cbca52deca7c3feec2462085db197febbe6dc2c3564d1f5bc6b9848f7742b696636ca3d9ecdbdc4c20be1d4c56fe031"} 23:12:58 INFO - Running post-run listener: copy_logs_to_upload_dir 23:12:58 INFO - Copying logs to upload dir... 23:12:58 INFO - mkdir: /builds/slave/test/build/upload/logs 23:12:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.769968 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-03-07 23:12:57.728518) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-07 23:12:57.731626) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1457418317.89644-1415155459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ef66e0a5a66a3c0e270771c020314d8c8703cf729dd51156949f97fb98c6c208ca5efb6f6320aa845dc4cc413d6b44e89b4491cbbe69c9d48e44b849bdaa6d09", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/157561da80e07d1c2c891d2f03ff82f30cbca52deca7c3feec2462085db197febbe6dc2c3564d1f5bc6b9848f7742b696636ca3d9ecdbdc4c20be1d4c56fe031"} build_url:https://queue.taskcluster.net/v1/task/L0ZTin4pTeimAVyL1Cw1NQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011206 build_url: 'https://queue.taskcluster.net/v1/task/L0ZTin4pTeimAVyL1Cw1NQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ef66e0a5a66a3c0e270771c020314d8c8703cf729dd51156949f97fb98c6c208ca5efb6f6320aa845dc4cc413d6b44e89b4491cbbe69c9d48e44b849bdaa6d09", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/157561da80e07d1c2c891d2f03ff82f30cbca52deca7c3feec2462085db197febbe6dc2c3564d1f5bc6b9848f7742b696636ca3d9ecdbdc4c20be1d4c56fe031"}' ========= master_lag: 0.05 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-07 23:12:57.790643) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 23:12:57.791009) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1457418317.89644-1415155459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004595 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 23:12:57.840047) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-07 23:12:57.840413) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-07 23:12:57.840730) ========= ========= Total master_lag: 0.80 =========