builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-018 starttime: 1459547653.37 results: success (0) buildid: 20160401142339 builduid: 98d505a5d7534830bc25aa94c3117c37 revision: 43f2fc45eaf759727dfed6893a8c2efc8c35ddf9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 14:54:13.370644) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 14:54:13.371145) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-01 14:54:13.371430) ========= 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=62c568580acbfdaac3eec7be000001dc-1459546268.50556-728832269 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006389 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-01 14:54:13.405000) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 14:54:13.405268) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 14:54:13.431554) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 14:54:13.431852) ========= 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=62c568580acbfdaac3eec7be000001dc-1459546268.50556-728832269 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004565 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 14:54:13.480033) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 14:54:13.480298) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 14:54:13.480636) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 14:54:13.480917) ========= 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=62c568580acbfdaac3eec7be000001dc-1459546268.50556-728832269 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-01 14:54:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 48.6K=0.2s 2016-04-01 14:54:14 (48.6 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.405859 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 14:54:13.898822) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 14:54:13.899100) ========= 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=62c568580acbfdaac3eec7be000001dc-1459546268.50556-728832269 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013996 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 14:54:13.949101) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 14:54:13.949420) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 43f2fc45eaf759727dfed6893a8c2efc8c35ddf9 --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 43f2fc45eaf759727dfed6893a8c2efc8c35ddf9 --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=62c568580acbfdaac3eec7be000001dc-1459546268.50556-728832269 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-01 14:54:14,120 truncating revision to first 12 chars 2016-04-01 14:54:14,120 Setting DEBUG logging. 2016-04-01 14:54:14,120 attempt 1/10 2016-04-01 14:54:14,120 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/43f2fc45eaf7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-01 14:54:14,383 unpacking tar archive at: fx-team-43f2fc45eaf7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.527139 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 14:54:14.489984) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 14:54:14.490327) ========= echo 43f2fc45eaf759727dfed6893a8c2efc8c35ddf9 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'43f2fc45eaf759727dfed6893a8c2efc8c35ddf9'] 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=62c568580acbfdaac3eec7be000001dc-1459546268.50556-728832269 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 43f2fc45eaf759727dfed6893a8c2efc8c35ddf9 program finished with exit code 0 elapsedTime=0.003350 script_repo_revision: '43f2fc45eaf759727dfed6893a8c2efc8c35ddf9' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 14:54:14.538429) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 14:54:14.538753) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 14:54:14.548799) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-04-01 14:54:14.549141) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1459546268.50556-728832269 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:54:14 INFO - MultiFileLogger online at 20160401 14:54:14 in /builds/slave/test 14:54:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 14:54:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:54:14 INFO - {'append_to_log': False, 14:54:14 INFO - 'base_work_dir': '/builds/slave/test', 14:54:14 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:54:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:54:14 INFO - 'branch': 'Fx-Team-Non-PGO', 14:54:14 INFO - 'buildbot_json_path': 'buildprops.json', 14:54:14 INFO - 'config_files': ('talos/linux_config.py',), 14:54:14 INFO - 'default_actions': ('clobber', 14:54:14 INFO - 'read-buildbot-config', 14:54:14 INFO - 'download-and-extract', 14:54:14 INFO - 'populate-webroot', 14:54:14 INFO - 'create-virtualenv', 14:54:14 INFO - 'install', 14:54:14 INFO - 'run-tests'), 14:54:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:54:14 INFO - 'download_minidump_stackwalk': True, 14:54:14 INFO - 'download_symbols': 'ondemand', 14:54:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:54:14 INFO - 'tooltool.py': '/tools/tooltool.py', 14:54:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:54:14 INFO - '/tools/misc-python/virtualenv.py')}, 14:54:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:54:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:54:14 INFO - 'installer_path': 'installer.exe', 14:54:14 INFO - 'log_level': 'info', 14:54:14 INFO - 'log_name': 'talos', 14:54:14 INFO - 'log_to_console': True, 14:54:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:54:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:54:14 INFO - 'opt_config_files': (), 14:54:14 INFO - 'pip_index': False, 14:54:14 INFO - 'sps_profile': False, 14:54:14 INFO - 'sps_profile_interval': 0, 14:54:14 INFO - 'suite': 'dromaeojs', 14:54:14 INFO - 'system_bits': '32', 14:54:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:54:14 INFO - 'title': 'talos-linux64-ix-018', 14:54:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:54:14 INFO - 'use_talos_json': True, 14:54:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:54:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:54:14 INFO - 'work_dir': 'build'} 14:54:14 INFO - ##### 14:54:14 INFO - ##### Running clobber step. 14:54:14 INFO - ##### 14:54:14 INFO - Running pre-action listener: _resource_record_pre_action 14:54:14 INFO - Running main action method: clobber 14:54:14 INFO - rmtree: /builds/slave/test/build 14:54:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:54:15 INFO - Running post-action listener: _resource_record_post_action 14:54:15 INFO - ##### 14:54:15 INFO - ##### Running read-buildbot-config step. 14:54:15 INFO - ##### 14:54:15 INFO - Running pre-action listener: _resource_record_pre_action 14:54:15 INFO - Running main action method: read_buildbot_config 14:54:15 INFO - Using buildbot properties: 14:54:15 INFO - { 14:54:15 INFO - "project": "", 14:54:15 INFO - "product": "firefox", 14:54:15 INFO - "script_repo_revision": "production", 14:54:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:54:15 INFO - "repository": "", 14:54:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 14:54:15 INFO - "buildid": "20160401142339", 14:54:15 INFO - "pgo_build": "False", 14:54:15 INFO - "basedir": "/builds/slave/test", 14:54:15 INFO - "buildnumber": 2741, 14:54:15 INFO - "slavename": "talos-linux64-ix-018", 14:54:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:54:15 INFO - "platform": "ubuntu64_hw", 14:54:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:54:15 INFO - "branch": "fx-team", 14:54:15 INFO - "repo_path": "integration/fx-team", 14:54:15 INFO - "revision": "43f2fc45eaf759727dfed6893a8c2efc8c35ddf9", 14:54:15 INFO - "stage_platform": "linux64", 14:54:15 INFO - "builduid": "98d505a5d7534830bc25aa94c3117c37", 14:54:15 INFO - "slavebuilddir": "test" 14:54:15 INFO - } 14:54:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/GPfgLUCbQ0KvOQxN-3zOKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 14:54:15 INFO - Running post-action listener: _resource_record_post_action 14:54:15 INFO - ##### 14:54:15 INFO - ##### Running download-and-extract step. 14:54:15 INFO - ##### 14:54:15 INFO - Running pre-action listener: _resource_record_pre_action 14:54:15 INFO - Running main action method: download_and_extract 14:54:15 INFO - mkdir: /builds/slave/test/build/tests 14:54:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:54:15 INFO - https://queue.taskcluster.net/v1/task/GPfgLUCbQ0KvOQxN-3zOKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:54:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GPfgLUCbQ0KvOQxN-3zOKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:54:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GPfgLUCbQ0KvOQxN-3zOKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:54:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GPfgLUCbQ0KvOQxN-3zOKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:54:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GPfgLUCbQ0KvOQxN-3zOKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:54:27 INFO - Downloaded 1361 bytes. 14:54:27 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:54:27 INFO - Using the following test package requirements: 14:54:27 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 14:54:27 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:54:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:54:27 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:54:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:54:27 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:54:27 INFO - u'jsshell-linux-x86_64.zip'], 14:54:27 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:54:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:54:27 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 14:54:27 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:54:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:54:27 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:54:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:54:27 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:54:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:54:27 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:54:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:54:27 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:54:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:54:27 INFO - https://queue.taskcluster.net/v1/task/GPfgLUCbQ0KvOQxN-3zOKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:54:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GPfgLUCbQ0KvOQxN-3zOKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:54:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GPfgLUCbQ0KvOQxN-3zOKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:54:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GPfgLUCbQ0KvOQxN-3zOKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:54:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GPfgLUCbQ0KvOQxN-3zOKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:54:36 INFO - Downloaded 22112239 bytes. 14:54:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:54:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:54:37 INFO - Return code: 0 14:54:37 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:54: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')]} 14:54:37 INFO - https://queue.taskcluster.net/v1/task/GPfgLUCbQ0KvOQxN-3zOKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:54:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GPfgLUCbQ0KvOQxN-3zOKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:54:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GPfgLUCbQ0KvOQxN-3zOKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:54:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GPfgLUCbQ0KvOQxN-3zOKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:54:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GPfgLUCbQ0KvOQxN-3zOKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:54:38 INFO - Downloaded 22112239 bytes. 14:54:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:54:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:54:39 INFO - Return code: 0 14:54:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:54:39 INFO - https://queue.taskcluster.net/v1/task/GPfgLUCbQ0KvOQxN-3zOKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:54:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GPfgLUCbQ0KvOQxN-3zOKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:54:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GPfgLUCbQ0KvOQxN-3zOKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:54:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GPfgLUCbQ0KvOQxN-3zOKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:54:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GPfgLUCbQ0KvOQxN-3zOKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:54:41 INFO - Downloaded 10847534 bytes. 14:54:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:54:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:54:41 INFO - Return code: 0 14:54:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:54:41 INFO - https://queue.taskcluster.net/v1/task/GPfgLUCbQ0KvOQxN-3zOKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:54:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GPfgLUCbQ0KvOQxN-3zOKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:54:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GPfgLUCbQ0KvOQxN-3zOKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:54:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GPfgLUCbQ0KvOQxN-3zOKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:54:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GPfgLUCbQ0KvOQxN-3zOKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:54:43 INFO - Downloaded 54218758 bytes. 14:54:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GPfgLUCbQ0KvOQxN-3zOKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:54:43 INFO - mkdir: /builds/slave/test/properties 14:54:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:54:43 INFO - Writing to file /builds/slave/test/properties/build_url 14:54:43 INFO - Contents: 14:54:43 INFO - build_url:https://queue.taskcluster.net/v1/task/GPfgLUCbQ0KvOQxN-3zOKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:54:43 INFO - Running post-action listener: _resource_record_post_action 14:54:43 INFO - Running post-action listener: set_extra_try_arguments 14:54:43 INFO - ##### 14:54:43 INFO - ##### Running populate-webroot step. 14:54:43 INFO - ##### 14:54:43 INFO - Running pre-action listener: _resource_record_pre_action 14:54:43 INFO - Running main action method: populate_webroot 14:54:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:54:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:54:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:54:43 INFO - '--tppagecycles', 14:54:43 INFO - '7'], 14:54:43 INFO - 'tests': ['tsvgm']}}, 14:54:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:54:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:54:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:54:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:54:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:54:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:54:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:54:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:54:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:54:43 INFO - 'talos_options': ['--e10s'], 14:54:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:54:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:54:43 INFO - 'tests': ['damp', 'tps']}, 14:54:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:54:43 INFO - 'talos_options': ['--e10s'], 14:54:43 INFO - 'tests': ['damp', 'tps']}, 14:54:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:54:43 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 14:54:43 INFO - 'tests': ['dromaeo_dom']}, 14:54:43 INFO - 'other': {'tests': ['a11yr', 14:54:43 INFO - 'ts_paint', 14:54:43 INFO - 'tpaint', 14:54:43 INFO - 'sessionrestore', 14:54:43 INFO - 'sessionrestore_no_auto_restore', 14:54:43 INFO - 'tabpaint']}, 14:54:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:54:43 INFO - 'tests': ['a11yr', 14:54:43 INFO - 'ts_paint', 14:54:43 INFO - 'tpaint', 14:54:43 INFO - 'sessionrestore', 14:54:43 INFO - 'sessionrestore_no_auto_restore', 14:54:43 INFO - 'tabpaint']}, 14:54:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:54:43 INFO - 'tests': ['a11yr', 14:54:43 INFO - 'ts_paint', 14:54:43 INFO - 'tpaint', 14:54:43 INFO - 'sessionrestore', 14:54:43 INFO - 'sessionrestore_no_auto_restore', 14:54:43 INFO - 'tabpaint']}, 14:54:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:54:43 INFO - 'tests': ['a11yr', 14:54:43 INFO - 'ts_paint', 14:54:43 INFO - 'tpaint', 14:54:43 INFO - 'sessionrestore', 14:54:43 INFO - 'sessionrestore_no_auto_restore', 14:54:43 INFO - 'tabpaint']}, 14:54:43 INFO - 'other_l64': {'tests': ['a11yr', 14:54:43 INFO - 'ts_paint', 14:54:43 INFO - 'tpaint', 14:54:43 INFO - 'sessionrestore', 14:54:43 INFO - 'sessionrestore_no_auto_restore', 14:54:43 INFO - 'tabpaint']}, 14:54:43 INFO - 'other_nol64': {'tests': ['a11yr', 14:54:43 INFO - 'ts_paint', 14:54:43 INFO - 'tpaint', 14:54:43 INFO - 'sessionrestore', 14:54:43 INFO - 'sessionrestore_no_auto_restore', 14:54:43 INFO - 'tabpaint']}, 14:54:43 INFO - 'svgr': {'tests': ['tsvgx', 14:54:43 INFO - 'tsvgr_opacity', 14:54:43 INFO - 'tart', 14:54:43 INFO - 'tscrollx', 14:54:43 INFO - 'cart']}, 14:54:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:54:43 INFO - 'tests': ['tsvgx', 14:54:43 INFO - 'tsvgr_opacity', 14:54:43 INFO - 'tart', 14:54:43 INFO - 'tscrollx', 14:54:43 INFO - 'cart']}, 14:54:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:54:43 INFO - 'tests': ['tp5o']}, 14:54:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:54:43 INFO - 'talos_options': ['--e10s'], 14:54:43 INFO - 'tests': ['tp5o']}, 14:54:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:54:43 INFO - 'talos_options': ['--xperf_path', 14:54:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:54:43 INFO - 'tests': ['tp5n']}, 14:54:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:54:43 INFO - 'talos_options': ['--e10s', 14:54:43 INFO - '--xperf_path', 14:54:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:54:43 INFO - 'tests': ['tp5n']}}, 14:54:43 INFO - 'talos.zip': {'path': '', 14:54:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:54:43 INFO - Running post-action listener: _resource_record_post_action 14:54:43 INFO - ##### 14:54:43 INFO - ##### Running create-virtualenv step. 14:54:43 INFO - ##### 14:54:43 INFO - Running pre-action listener: _resource_record_pre_action 14:54:43 INFO - Running main action method: create_virtualenv 14:54:43 INFO - Creating virtualenv /builds/slave/test/build/venv 14:54:43 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 14:54:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:54:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:54:43 INFO - Using real prefix '/usr' 14:54:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:54:44 INFO - Installing distribute.............................................................................................................................................................................................done. 14:54:46 INFO - Installing pip.................done. 14:54:46 INFO - Return code: 0 14:54:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:54: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')]} 14:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54: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')]} 14:54:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:46 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 0x7fb83e475f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22237d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b2640>, '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 0x22b3540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22b39d0>, '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': '62c568580acbfdaac3eec7be000001dc-1459546268.50556-728832269', '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 14:54:46 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 14:54:46 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 14:54:46 INFO - Using env: {'DISPLAY': ':0', 14:54:46 INFO - 'HOME': '/home/cltbld', 14:54:46 INFO - 'LANG': 'en_US.UTF-8', 14:54:46 INFO - 'LANGUAGE': 'en_US:en', 14:54:46 INFO - 'LOGNAME': 'cltbld', 14:54:46 INFO - 'MAIL': '/var/mail/cltbld', 14:54:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:46 INFO - 'MOZ_NO_REMOTE': '1', 14:54:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:46 INFO - 'NO_EM_RESTART': '1', 14:54:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:46 INFO - 'PWD': '/builds/slave/test', 14:54:46 INFO - 'SHELL': '/bin/bash', 14:54:46 INFO - 'SHLVL': '1', 14:54:46 INFO - 'TERM': 'linux', 14:54:46 INFO - 'TMOUT': '86400', 14:54:46 INFO - 'USER': 'cltbld', 14:54:46 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1459546268.50556-728832269', 14:54:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:46 INFO - '_': '/tools/buildbot/bin/python'} 14:54:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:46 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 14:54:46 INFO - Cleaning up... 14:54:46 INFO - Return code: 0 14:54:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:54: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')]} 14:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54: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')]} 14:54:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:46 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 0x7fb83e475f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22237d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b2640>, '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 0x22b3540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22b39d0>, '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': '62c568580acbfdaac3eec7be000001dc-1459546268.50556-728832269', '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 14:54:46 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 14:54:46 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 14:54:46 INFO - Using env: {'DISPLAY': ':0', 14:54:46 INFO - 'HOME': '/home/cltbld', 14:54:46 INFO - 'LANG': 'en_US.UTF-8', 14:54:46 INFO - 'LANGUAGE': 'en_US:en', 14:54:46 INFO - 'LOGNAME': 'cltbld', 14:54:46 INFO - 'MAIL': '/var/mail/cltbld', 14:54:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:46 INFO - 'MOZ_NO_REMOTE': '1', 14:54:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:46 INFO - 'NO_EM_RESTART': '1', 14:54:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:46 INFO - 'PWD': '/builds/slave/test', 14:54:46 INFO - 'SHELL': '/bin/bash', 14:54:46 INFO - 'SHLVL': '1', 14:54:46 INFO - 'TERM': 'linux', 14:54:46 INFO - 'TMOUT': '86400', 14:54:46 INFO - 'USER': 'cltbld', 14:54:46 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1459546268.50556-728832269', 14:54:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:46 INFO - '_': '/tools/buildbot/bin/python'} 14:54:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:46 INFO - Downloading/unpacking psutil>=0.7.1 14:54:46 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 14:54:46 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 14:54:46 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 14:54:46 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 14:54:46 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 14:54:46 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 14:54:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:54:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:54:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:54:48 INFO - Installing collected packages: psutil 14:54:48 INFO - Running setup.py install for psutil 14:54:48 INFO - building 'psutil._psutil_linux' extension 14:54:48 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 14:54:49 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 14:54:49 INFO - building 'psutil._psutil_posix' extension 14:54:49 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 14:54:49 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 14:54:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:54:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:54:49 INFO - Successfully installed psutil 14:54:49 INFO - Cleaning up... 14:54:49 INFO - Return code: 0 14:54:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:54: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')]} 14:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54: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')]} 14:54:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:49 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 0x7fb83e475f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22237d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b2640>, '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 0x22b3540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22b39d0>, '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': '62c568580acbfdaac3eec7be000001dc-1459546268.50556-728832269', '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 14:54:49 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 14:54:49 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 14:54:49 INFO - Using env: {'DISPLAY': ':0', 14:54:49 INFO - 'HOME': '/home/cltbld', 14:54:49 INFO - 'LANG': 'en_US.UTF-8', 14:54:49 INFO - 'LANGUAGE': 'en_US:en', 14:54:49 INFO - 'LOGNAME': 'cltbld', 14:54:49 INFO - 'MAIL': '/var/mail/cltbld', 14:54:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:49 INFO - 'MOZ_NO_REMOTE': '1', 14:54:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:49 INFO - 'NO_EM_RESTART': '1', 14:54:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:49 INFO - 'PWD': '/builds/slave/test', 14:54:49 INFO - 'SHELL': '/bin/bash', 14:54:49 INFO - 'SHLVL': '1', 14:54:49 INFO - 'TERM': 'linux', 14:54:49 INFO - 'TMOUT': '86400', 14:54:49 INFO - 'USER': 'cltbld', 14:54:49 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1459546268.50556-728832269', 14:54:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:49 INFO - '_': '/tools/buildbot/bin/python'} 14:54:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:54:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:54:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:54:51 INFO - Installing collected packages: mozsystemmonitor 14:54:51 INFO - Running setup.py install for mozsystemmonitor 14:54:51 INFO - Successfully installed mozsystemmonitor 14:54:51 INFO - Cleaning up... 14:54:51 INFO - Return code: 0 14:54:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:54:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb83e475f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22237d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b2640>, '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 0x22b3540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22b39d0>, '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': '62c568580acbfdaac3eec7be000001dc-1459546268.50556-728832269', '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 14:54:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:54:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:54:51 INFO - Using env: {'DISPLAY': ':0', 14:54:51 INFO - 'HOME': '/home/cltbld', 14:54:51 INFO - 'LANG': 'en_US.UTF-8', 14:54:51 INFO - 'LANGUAGE': 'en_US:en', 14:54:51 INFO - 'LOGNAME': 'cltbld', 14:54:51 INFO - 'MAIL': '/var/mail/cltbld', 14:54:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:51 INFO - 'MOZ_NO_REMOTE': '1', 14:54:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:51 INFO - 'NO_EM_RESTART': '1', 14:54:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:51 INFO - 'PWD': '/builds/slave/test', 14:54:51 INFO - 'SHELL': '/bin/bash', 14:54:51 INFO - 'SHLVL': '1', 14:54:51 INFO - 'TERM': 'linux', 14:54:51 INFO - 'TMOUT': '86400', 14:54:51 INFO - 'USER': 'cltbld', 14:54:51 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1459546268.50556-728832269', 14:54:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:51 INFO - '_': '/tools/buildbot/bin/python'} 14:54:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:51 INFO - Downloading/unpacking blobuploader==1.2.4 14:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:53 INFO - Downloading blobuploader-1.2.4.tar.gz 14:54:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:54:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:54: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 14:54: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 14:54: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 14:54: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 14:54: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 14:54: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 14:54:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:54:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:54 INFO - Downloading docopt-0.6.1.tar.gz 14:54:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:54:54 INFO - Installing collected packages: blobuploader, requests, docopt 14:54:54 INFO - Running setup.py install for blobuploader 14:54:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:54:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:54:54 INFO - Running setup.py install for requests 14:54:54 INFO - Running setup.py install for docopt 14:54:55 INFO - Successfully installed blobuploader requests docopt 14:54:55 INFO - Cleaning up... 14:54:55 INFO - Return code: 0 14:54:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:54: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')]} 14:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54: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')]} 14:54:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:55 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 0x7fb83e475f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22237d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b2640>, '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 0x22b3540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22b39d0>, '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': '62c568580acbfdaac3eec7be000001dc-1459546268.50556-728832269', '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 14:54:55 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 14:54:55 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 14:54:55 INFO - Using env: {'DISPLAY': ':0', 14:54:55 INFO - 'HOME': '/home/cltbld', 14:54:55 INFO - 'LANG': 'en_US.UTF-8', 14:54:55 INFO - 'LANGUAGE': 'en_US:en', 14:54:55 INFO - 'LOGNAME': 'cltbld', 14:54:55 INFO - 'MAIL': '/var/mail/cltbld', 14:54:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:55 INFO - 'MOZ_NO_REMOTE': '1', 14:54:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:55 INFO - 'NO_EM_RESTART': '1', 14:54:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:55 INFO - 'PWD': '/builds/slave/test', 14:54:55 INFO - 'SHELL': '/bin/bash', 14:54:55 INFO - 'SHLVL': '1', 14:54:55 INFO - 'TERM': 'linux', 14:54:55 INFO - 'TMOUT': '86400', 14:54:55 INFO - 'USER': 'cltbld', 14:54:55 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1459546268.50556-728832269', 14:54:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:55 INFO - '_': '/tools/buildbot/bin/python'} 14:54:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:54:55 INFO - Running setup.py (path:/tmp/pip-2KBhpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:54:55 INFO - Running setup.py (path:/tmp/pip-U0HUp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:54:55 INFO - Running setup.py (path:/tmp/pip-ZQpvlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:54:55 INFO - Running setup.py (path:/tmp/pip-9W6w5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:54:55 INFO - Running setup.py (path:/tmp/pip-WLeLel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:54:55 INFO - Running setup.py (path:/tmp/pip-aiV_8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:54:55 INFO - Running setup.py (path:/tmp/pip-G66DKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:54:55 INFO - Running setup.py (path:/tmp/pip-4o96mu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:54:55 INFO - Running setup.py (path:/tmp/pip-B0gAm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:54:55 INFO - Running setup.py (path:/tmp/pip-sJYwvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:54:56 INFO - Running setup.py (path:/tmp/pip-yLLmSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:54:56 INFO - Running setup.py (path:/tmp/pip-oYRdZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:54:56 INFO - Running setup.py (path:/tmp/pip-8X07bL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:54:56 INFO - Running setup.py (path:/tmp/pip-ljJ3_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:54:56 INFO - Running setup.py (path:/tmp/pip-QMCkrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:54:56 INFO - Running setup.py (path:/tmp/pip-CLUeHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:54:56 INFO - Running setup.py (path:/tmp/pip-qCA5uy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:54:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:54:56 INFO - Running setup.py install for manifestparser 14:54:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:54:56 INFO - Running setup.py install for mozcrash 14:54:56 INFO - Running setup.py install for mozdebug 14:54:56 INFO - Running setup.py install for mozdevice 14:54:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:54:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:54:56 INFO - Running setup.py install for mozfile 14:54:57 INFO - Running setup.py install for mozhttpd 14:54:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:54:57 INFO - Running setup.py install for mozinfo 14:54:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:54:57 INFO - Running setup.py install for mozInstall 14:54:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:54:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:54:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:54:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:54:57 INFO - Running setup.py install for mozleak 14:54:57 INFO - Running setup.py install for mozlog 14:54:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:54:57 INFO - Running setup.py install for moznetwork 14:54:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:54:57 INFO - Running setup.py install for mozprocess 14:54:57 INFO - Running setup.py install for mozprofile 14:54:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:54:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:54:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:54:57 INFO - Running setup.py install for mozrunner 14:54:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:54:58 INFO - Running setup.py install for mozscreenshot 14:54:58 INFO - Running setup.py install for moztest 14:54:58 INFO - Running setup.py install for mozversion 14:54:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:54:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:54:58 INFO - Cleaning up... 14:54:58 INFO - Return code: 0 14:54:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:54:58 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')]} 14:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:58 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')]} 14:54:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:58 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 0x7fb83e475f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22237d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b2640>, '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 0x22b3540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22b39d0>, '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': '62c568580acbfdaac3eec7be000001dc-1459546268.50556-728832269', '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 14:54:58 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 14:54:58 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 14:54:58 INFO - Using env: {'DISPLAY': ':0', 14:54:58 INFO - 'HOME': '/home/cltbld', 14:54:58 INFO - 'LANG': 'en_US.UTF-8', 14:54:58 INFO - 'LANGUAGE': 'en_US:en', 14:54:58 INFO - 'LOGNAME': 'cltbld', 14:54:58 INFO - 'MAIL': '/var/mail/cltbld', 14:54:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:58 INFO - 'MOZ_NO_REMOTE': '1', 14:54:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:58 INFO - 'NO_EM_RESTART': '1', 14:54:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:58 INFO - 'PWD': '/builds/slave/test', 14:54:58 INFO - 'SHELL': '/bin/bash', 14:54:58 INFO - 'SHLVL': '1', 14:54:58 INFO - 'TERM': 'linux', 14:54:58 INFO - 'TMOUT': '86400', 14:54:58 INFO - 'USER': 'cltbld', 14:54:58 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1459546268.50556-728832269', 14:54:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:58 INFO - '_': '/tools/buildbot/bin/python'} 14:54:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:54:58 INFO - Running setup.py (path:/tmp/pip-NEr5nP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:54:58 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)) 14:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:54:58 INFO - Running setup.py (path:/tmp/pip-csyt3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:54:58 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)) 14:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:54:58 INFO - Running setup.py (path:/tmp/pip-S4HrRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:54:58 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)) 14:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:54:58 INFO - Running setup.py (path:/tmp/pip-nD1iVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:54:58 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)) 14:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:54:58 INFO - Running setup.py (path:/tmp/pip-JebvJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:54:58 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)) 14:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:54:58 INFO - Running setup.py (path:/tmp/pip-l0zBGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:54:58 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)) 14:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:54:58 INFO - Running setup.py (path:/tmp/pip-70ZXiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:54:59 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)) 14:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:54:59 INFO - Running setup.py (path:/tmp/pip-T4_kUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:54:59 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)) 14:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:54:59 INFO - Running setup.py (path:/tmp/pip-gWTGwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:54:59 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)) 14:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:54:59 INFO - Running setup.py (path:/tmp/pip-gSZxpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:54:59 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)) 14:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:54:59 INFO - Running setup.py (path:/tmp/pip-mQGSZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:54:59 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)) 14:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:54:59 INFO - Running setup.py (path:/tmp/pip-5JCjQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:54:59 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)) 14:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:54:59 INFO - Running setup.py (path:/tmp/pip-eub6tM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:54:59 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)) 14:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:54:59 INFO - Running setup.py (path:/tmp/pip-ZQA7ZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:54:59 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)) 14:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:54:59 INFO - Running setup.py (path:/tmp/pip-2oAOTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:54:59 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)) 14:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:54:59 INFO - Running setup.py (path:/tmp/pip-VOIMXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:54:59 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)) 14:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:54:59 INFO - Running setup.py (path:/tmp/pip-1ndVOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:54:59 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)) 14:54:59 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)) 14:54:59 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)) 14:54:59 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)) 14:54:59 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)) 14:54:59 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)) 14:54:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:54:59 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 14:54:59 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 14:54:59 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 14:54:59 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 14:54:59 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 14:54:59 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 14:55:01 INFO - Downloading blessings-1.6.tar.gz 14:55:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:55:01 INFO - Installing collected packages: blessings 14:55:01 INFO - Running setup.py install for blessings 14:55:01 INFO - Successfully installed blessings 14:55:01 INFO - Cleaning up... 14:55:01 INFO - Return code: 0 14:55:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:55:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:55:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:55:02 INFO - Reading from file tmpfile_stdout 14:55:02 INFO - Current package versions: 14:55:02 INFO - argparse == 1.2.1 14:55:02 INFO - blessings == 1.6 14:55:02 INFO - blobuploader == 1.2.4 14:55:02 INFO - docopt == 0.6.1 14:55:02 INFO - manifestparser == 1.1 14:55:02 INFO - mozInstall == 1.12 14:55:02 INFO - mozcrash == 0.17 14:55:02 INFO - mozdebug == 0.1 14:55:02 INFO - mozdevice == 0.48 14:55:02 INFO - mozfile == 1.2 14:55:02 INFO - mozhttpd == 0.7 14:55:02 INFO - mozinfo == 0.9 14:55:02 INFO - mozleak == 0.1 14:55:02 INFO - mozlog == 3.1 14:55:02 INFO - moznetwork == 0.27 14:55:02 INFO - mozprocess == 0.22 14:55:02 INFO - mozprofile == 0.28 14:55:02 INFO - mozrunner == 6.11 14:55:02 INFO - mozscreenshot == 0.1 14:55:02 INFO - mozsystemmonitor == 0.0 14:55:02 INFO - moztest == 0.7 14:55:02 INFO - mozversion == 1.4 14:55:02 INFO - psutil == 3.1.1 14:55:02 INFO - requests == 1.2.3 14:55:02 INFO - wsgiref == 0.1.2 14:55:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:55:02 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')]} 14:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:02 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')]} 14:55:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:02 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 0x7fb83e475f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22237d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b2640>, '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 0x22b3540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22b39d0>, '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': '62c568580acbfdaac3eec7be000001dc-1459546268.50556-728832269', '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 14:55:02 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 14:55:02 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 14:55:02 INFO - Using env: {'DISPLAY': ':0', 14:55:02 INFO - 'HOME': '/home/cltbld', 14:55:02 INFO - 'LANG': 'en_US.UTF-8', 14:55:02 INFO - 'LANGUAGE': 'en_US:en', 14:55:02 INFO - 'LOGNAME': 'cltbld', 14:55:02 INFO - 'MAIL': '/var/mail/cltbld', 14:55:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:02 INFO - 'MOZ_NO_REMOTE': '1', 14:55:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:55:02 INFO - 'NO_EM_RESTART': '1', 14:55:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:55:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:02 INFO - 'PWD': '/builds/slave/test', 14:55:02 INFO - 'SHELL': '/bin/bash', 14:55:02 INFO - 'SHLVL': '1', 14:55:02 INFO - 'TERM': 'linux', 14:55:02 INFO - 'TMOUT': '86400', 14:55:02 INFO - 'USER': 'cltbld', 14:55:02 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1459546268.50556-728832269', 14:55:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:02 INFO - '_': '/tools/buildbot/bin/python'} 14:55:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:02 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)) 14:55:02 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)) 14:55:02 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)) 14:55:02 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)) 14:55:02 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)) 14:55:02 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)) 14:55:02 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)) 14:55:02 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)) 14:55:02 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)) 14:55:02 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)) 14:55:02 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)) 14:55:02 INFO - Cleaning up... 14:55:02 INFO - Return code: 0 14:55:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:55:02 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')]} 14:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:02 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')]} 14:55:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:02 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 0x7fb83e475f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22237d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b2640>, '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 0x22b3540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22b39d0>, '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': '62c568580acbfdaac3eec7be000001dc-1459546268.50556-728832269', '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 14:55:02 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 14:55:02 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 14:55:02 INFO - Using env: {'DISPLAY': ':0', 14:55:02 INFO - 'HOME': '/home/cltbld', 14:55:02 INFO - 'LANG': 'en_US.UTF-8', 14:55:02 INFO - 'LANGUAGE': 'en_US:en', 14:55:02 INFO - 'LOGNAME': 'cltbld', 14:55:02 INFO - 'MAIL': '/var/mail/cltbld', 14:55:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:02 INFO - 'MOZ_NO_REMOTE': '1', 14:55:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:55:02 INFO - 'NO_EM_RESTART': '1', 14:55:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:55:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:02 INFO - 'PWD': '/builds/slave/test', 14:55:02 INFO - 'SHELL': '/bin/bash', 14:55:02 INFO - 'SHLVL': '1', 14:55:02 INFO - 'TERM': 'linux', 14:55:02 INFO - 'TMOUT': '86400', 14:55:02 INFO - 'USER': 'cltbld', 14:55:02 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1459546268.50556-728832269', 14:55:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:02 INFO - '_': '/tools/buildbot/bin/python'} 14:55:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:02 INFO - Downloading/unpacking jsonschema 14:55:02 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 14:55:02 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 14:55:02 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 14:55:02 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 14:55:02 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 14:55:02 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 14:55:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:55:04 INFO - Downloading/unpacking functools32 (from jsonschema) 14:55:04 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 14:55:04 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 14:55:04 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 14:55:04 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 14:55:04 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 14:55:04 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 14:55:04 INFO - Downloading functools32-3.2.3-2.tar.gz 14:55:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:55:04 INFO - warning: no files found matching '*.txt' 14:55:04 INFO - no previously-included directories found matching 'build' 14:55:04 INFO - no previously-included directories found matching 'dist' 14:55:04 INFO - no previously-included directories found matching '.git*' 14:55:04 INFO - Installing collected packages: jsonschema, functools32 14:55:04 INFO - Running setup.py install for functools32 14:55:04 INFO - warning: no files found matching '*.txt' 14:55:05 INFO - no previously-included directories found matching 'build' 14:55:05 INFO - no previously-included directories found matching 'dist' 14:55:05 INFO - no previously-included directories found matching '.git*' 14:55:05 INFO - Successfully installed jsonschema functools32 14:55:05 INFO - Cleaning up... 14:55:05 INFO - Return code: 0 14:55:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:55:05 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')]} 14:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:05 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')]} 14:55:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:05 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 0x7fb83e475f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22237d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b2640>, '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 0x22b3540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22b39d0>, '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': '62c568580acbfdaac3eec7be000001dc-1459546268.50556-728832269', '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 14:55:05 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 14:55:05 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 14:55:05 INFO - Using env: {'DISPLAY': ':0', 14:55:05 INFO - 'HOME': '/home/cltbld', 14:55:05 INFO - 'LANG': 'en_US.UTF-8', 14:55:05 INFO - 'LANGUAGE': 'en_US:en', 14:55:05 INFO - 'LOGNAME': 'cltbld', 14:55:05 INFO - 'MAIL': '/var/mail/cltbld', 14:55:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:05 INFO - 'MOZ_NO_REMOTE': '1', 14:55:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:55:05 INFO - 'NO_EM_RESTART': '1', 14:55:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:55:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:05 INFO - 'PWD': '/builds/slave/test', 14:55:05 INFO - 'SHELL': '/bin/bash', 14:55:05 INFO - 'SHLVL': '1', 14:55:05 INFO - 'TERM': 'linux', 14:55:05 INFO - 'TMOUT': '86400', 14:55:05 INFO - 'USER': 'cltbld', 14:55:05 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1459546268.50556-728832269', 14:55:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:05 INFO - '_': '/tools/buildbot/bin/python'} 14:55:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:05 INFO - Downloading/unpacking flake8 14:55:05 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 14:55:05 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 14:55:05 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 14:55:05 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 14:55:05 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 14:55:05 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 14:55:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:55:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:55:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:55:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:55:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:55:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:55:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:55:08 INFO - no previously-included directories found matching 'docs/_build' 14:55:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:55:08 INFO - Running setup.py install for pep8 14:55:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:55:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:55:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:55:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:55:08 INFO - no previously-included directories found matching 'docs/_build' 14:55:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:55:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:55:08 INFO - Cleaning up... 14:55:08 INFO - Return code: 0 14:55:08 INFO - Running post-action listener: _resource_record_post_action 14:55:08 INFO - Running post-action listener: _start_resource_monitoring 14:55:08 INFO - Starting resource monitoring. 14:55:08 INFO - ##### 14:55:08 INFO - ##### Running install step. 14:55:08 INFO - ##### 14:55:08 INFO - Running pre-action listener: _resource_record_pre_action 14:55:08 INFO - Running main action method: install 14:55:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:55:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:55:08 INFO - Reading from file tmpfile_stdout 14:55:08 INFO - Detecting whether we're running mozinstall >=1.0... 14:55:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:55:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:55:08 INFO - Reading from file tmpfile_stdout 14:55:08 INFO - Output received: 14:55:08 INFO - Usage: mozinstall [options] installer 14:55:08 INFO - Options: 14:55:08 INFO - -h, --help show this help message and exit 14:55:08 INFO - -d DEST, --destination=DEST 14:55:08 INFO - Directory to install application into. [default: 14:55:08 INFO - "/builds/slave/test"] 14:55:08 INFO - --app=APP Application being installed. [default: firefox] 14:55:08 INFO - mkdir: /builds/slave/test/build/application 14:55:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:55:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:55:24 INFO - Reading from file tmpfile_stdout 14:55:24 INFO - Output received: 14:55:24 INFO - /builds/slave/test/build/application/firefox/firefox 14:55:24 INFO - Running post-action listener: _resource_record_post_action 14:55:24 INFO - ##### 14:55:24 INFO - ##### Running run-tests step. 14:55:24 INFO - ##### 14:55:24 INFO - Running pre-action listener: _resource_record_pre_action 14:55:24 INFO - Running main action method: run_tests 14:55:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:55:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:55:24 INFO - Python 2.7.3 14:55:24 INFO - Return code: 0 14:55:24 INFO - grabbing minidump binary from tooltool 14:55:24 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')]} 14:55:24 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 0x22b2640>, '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 0x22b3540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22b39d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:55:24 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 14:55:24 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 14:55:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:55:24 INFO - Return code: 0 14:55:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:55:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:55:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:55:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:55:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:55:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:55:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:55:25 INFO - Return code: 0 14:55:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GPfgLUCbQ0KvOQxN-3zOKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:55:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GPfgLUCbQ0KvOQxN-3zOKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:55:25 INFO - Using env: {'DISPLAY': ':0', 14:55:25 INFO - 'HOME': '/home/cltbld', 14:55:25 INFO - 'LANG': 'en_US.UTF-8', 14:55:25 INFO - 'LANGUAGE': 'en_US:en', 14:55:25 INFO - 'LOGNAME': 'cltbld', 14:55:25 INFO - 'MAIL': '/var/mail/cltbld', 14:55:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:55:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:55:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:25 INFO - 'MOZ_NO_REMOTE': '1', 14:55:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:55:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:55:25 INFO - 'NO_EM_RESTART': '1', 14:55:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:55:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:25 INFO - 'PWD': '/builds/slave/test', 14:55:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:55:25 INFO - 'SHELL': '/bin/bash', 14:55:25 INFO - 'SHLVL': '1', 14:55:25 INFO - 'TERM': 'linux', 14:55:25 INFO - 'TMOUT': '86400', 14:55:25 INFO - 'USER': 'cltbld', 14:55:25 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1459546268.50556-728832269', 14:55:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:25 INFO - '_': '/tools/buildbot/bin/python'} 14:55:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GPfgLUCbQ0KvOQxN-3zOKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:55:25 INFO - mozversion application_buildid: 20160401142339 14:55:25 INFO - mozversion application_changeset: 43f2fc45eaf759727dfed6893a8c2efc8c35ddf9 14:55:25 INFO - mozversion application_display_name: Nightly 14:55:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:55:25 INFO - mozversion application_name: Firefox 14:55:25 INFO - mozversion application_remotingname: firefox 14:55:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:55:25 INFO - mozversion application_vendor: Mozilla 14:55:25 INFO - mozversion application_version: 48.0a1 14:55:25 INFO - mozversion platform_buildid: 20160401142339 14:55:25 INFO - mozversion platform_changeset: 43f2fc45eaf759727dfed6893a8c2efc8c35ddf9 14:55:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:55:25 INFO - mozversion platform_version: 48.0a1 14:55:25 INFO - using testdate: 1459547725 14:55:25 INFO - actual date: 1459547725 14:55:25 INFO - starting webserver on 'localhost:51410' 14:55:25 INFO - SUITE-START | Running 2 tests 14:55:25 INFO - TEST-START | dromaeo_css 14:55:25 INFO - operating with platform_type : linux_ 14:55:25 INFO - Initialising browser for dromaeo_css test... 14:55:25 INFO - TEST-INFO | started process 15970 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8iIgT_/profile http://localhost:51410/getInfo.html) 14:55:29 INFO - PROCESS | 15970 | __metrics Screen width/height:1600/1200 14:55:29 INFO - PROCESS | 15970 | colorDepth:24 14:55:29 INFO - PROCESS | 15970 | Browser inner width/height: 1024/697 14:55:29 INFO - PROCESS | 15970 | __metrics 14:55:31 ERROR - PROCESS | 15970 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:55:32 INFO - TEST-INFO | 15970: exit 0 14:55:32 INFO - Browser initialized. 14:55:32 INFO - Running cycle 1/1 for dromaeo_css test... 14:55:32 INFO - TEST-INFO | started process 16052 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8iIgT_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:55:44 INFO - PROCESS | 16052 | RSS: Main: 154849280 14:55:44 INFO - PROCESS | 16052 | 14:56:35 INFO - PROCESS | 16052 | 1459547795751 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] 14:58:47 INFO - PROCESS | 16052 | Cycle 1(1): loaded http://localhost:51410/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51410/tests/dromaeo/cssquery-ext.html) 14:58:48 INFO - PROCESS | 16052 | RSS: Main: 264540160 14:58:48 INFO - PROCESS | 16052 | 15:01:51 INFO - PROCESS | 16052 | Cycle 1(1): loaded http://localhost:51410/tests/dromaeo/cssquery-ext.html (next: http://localhost:51410/tests/dromaeo/cssquery-jquery.html) 15:01:51 INFO - PROCESS | 16052 | RSS: Main: 239558656 15:01:51 INFO - PROCESS | 16052 | 15:04:53 INFO - PROCESS | 16052 | Cycle 1(1): loaded http://localhost:51410/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51410/tests/dromaeo/cssquery-mootools.html) 15:04:54 INFO - PROCESS | 16052 | RSS: Main: 238555136 15:04:54 INFO - PROCESS | 16052 | 15:07:56 INFO - PROCESS | 16052 | Cycle 1(1): loaded http://localhost:51410/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51410/tests/dromaeo/cssquery-prototype.html) 15:07:57 INFO - PROCESS | 16052 | RSS: Main: 207953920 15:07:57 INFO - PROCESS | 16052 | 15:10:59 INFO - PROCESS | 16052 | Cycle 1(1): loaded http://localhost:51410/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51410/tests/dromaeo/cssquery-yui.html) 15:11:00 INFO - PROCESS | 16052 | RSS: Main: 202424320 15:11:00 INFO - PROCESS | 16052 | 15:14:02 INFO - PROCESS | 16052 | Cycle 1(1): loaded http://localhost:51410/tests/dromaeo/cssquery-yui.html (next: http://localhost:51410/tests/dromaeo/cssquery-dojo.html) 15:14:03 INFO - PROCESS | 16052 | RSS: Main: 264863744 15:14:03 INFO - PROCESS | 16052 | 15:14:03 INFO - PROCESS | 16052 | __start_tp_report 15:14:03 INFO - PROCESS | 16052 | _x_x_mozilla_page_load 15:14:03 INFO - PROCESS | 16052 | _x_x_mozilla_page_load_details 15:14:03 INFO - PROCESS | 16052 | |i|pagename|runs| 15:14:03 INFO - PROCESS | 16052 | |0;dojo.html;2641.1284276188853;2670.6394636724035;2678.74551917568;2687.596860470928;2714.2400127964165;4556.977215113928;4658.7204767713965;4680.13417517759;4680.180968330541;4696.624270058395;4642.303654451834;4663.790129444174;4664.207084795585;4723.763811809405;4746.477887432388;4280.400743895857;4305.526392096866;4329.047609525899;4373.1909596724545;4437.2013037653205;4427.756473393962;4463.241248987663;4482.305242687388;4490.887727806815;4523.434570678665;4237.364395340693;4321.870343889688;4323.740575565476;4394.516603173648;4404.8458303959205;4352.347147927804;4367.912641747147;4385.56144385562;4391.407160033386;4421.823127074913;4332.891677708051;4353.499347575006;4357.150355680644;4369.650427965787;4400.933985990213;4470.173017991682;4548.545145485425;4570.474395444533;4620.584147426748;4659.324397962277;4929.531694489017;4935.136351138536;4941.827036053721;4945.357103576512;4994.425641051289;4951.306817045616;4954.504549545017;4957.851264462072;4975.5522003019905;5008.824691135793;4557.840475583339;4629.930551041737;4636.44362676481;4751.358566593465;4769.57073863354;5153.2785410042625;5168.250603662523;5175.585953123741;5179.663321884065;5184.533391994663;4950.381202349707;4951.876203094951;4956.4547899731;4959.677620954626;5006.724630145304;4926.33494478248;5031.094403007421;5076.898462030813;5109.821156259513;5125.589952803767;4917.704937703749;4939.604831613462;4948.505149485095;4949.678270912379;5000.424951130593;4851.320815085891;4887.804487820447;4889.804407823647;4898.755062246873;4943.184374578154;4200.7479551227025;4237.343211802176;4258.318669012943;4329.6969212154845;4336.696431249846;3664.2305115925956;3687.6681098701247;3690.095926498025;3727.7763334200035;3731.7014638828828;4279.807408666556;4280.850170244026;4283.721558098714;4290.935635965463;4322.524522302544;4916.852494425173;4992.650514464025;5078.949210507922;5117.437081920985;5138.3833939927445;4284.057507348379;4300.075483771005;4302.82788688449;4303.935440968388;4345.413369195118;4434.379186913835;4502.919299368194;4506.526814684411;4518.412606361152;4552.430946131733;4765.928511072337;4805.687630304019;4847.466778654275;4849.95150048495;4852.44196917359;4987.226979818134;5029.899402011866;5035.16919708244;5036.6726162799305;5083.957788653391;4633.2818413146015;4750.334953106499;4761.9285710713675;4766.308885211555;4812.903741925212;4929.260610908249;4949.208126699711;4977.427595826382;5008.2738002988635;5024;4978.975105124596;4985.700857948535;4987.650864439454;4992.650514463952;5043.193089105725;4736.8578942631775;4752.667313288175;4846.660733748604;4859.0039041997015;4900.215965445512;4801.615870730403;4820.035992801384;4822.662413631012;4866;4875.317455556154;4749.097671442415;4749.715017098985;4766.523347665345;4769;4794;4755.405574303212;4842.709437433765;4927.1131196384995;4927.334809800631;4944.53026962438;4780.282957556395;4806.255030470283;4808.6153107752;4828.444728856227;4846.418429788307 15:14:03 INFO - PROCESS | 16052 | |1;ext.html;526.5340173946059;550.8127236739508;555.1533910786048;557.534458726963;560.1457776890242;27254;34103.829480852626;34872.3025539489;34900.82549587249;34953;37362;37771;37803.05492362692;37811;37855;7782.221777822215;7982.161873003338;7986;7987.800304992364;7988.880166797503;7816.843663126734;7951.204879512032;7954.562499062549;7958.204179582053;7962.0843602985815;7896.644650990719;7987.840243195133;7989.6005199740075;7990.12108668046;7993.400494962872;7869.842603147934;7908.406869484783;7928.445008849383;7944.364450843918;7946.205379462065;7819.765407037798;7955.124936257007;7961.1242763295995;7963.283304502623;7965.8805117923275;37566;37896.810515947516;37913.241735165146;37938.9133597652;38001.429978550346;2946.3665311958034;3006.3085490337344;3242.3839470500766;3366.882159124419;3482.703970162514;27740.861295693594;27793;28268.575971360446;28361.290967725767;28485.71514284872;3442.5180474733556;3454.1537323355687;3455.36075825973;3474.3398754236614;3488.8778892738633;183826;188702;188802;188811;189194;42864.78567607142;43539;55219.171712424344;61438.692806535684;61776.69111654413;43421.78289108534;43439;43652.56347436549;43686.7815660926;43725.562744372786;12171.817422738666;12332.753344933051;12364.690882727824;12367.505299788088;12367.69080772988;9067.365284430158;9143.13140251675;9145.314101442418;9146.954265228764;9151.17639412456;14359.497417590333;14367.066140700821;14379.568612941419;14805.925970370079;14833.851661483463;5994;6077.665728384893;6112.144299798032;6194.969025154845;6289.182406287154;807.9596020199084;893.8882639670041;928.9024652411399;956.6699488676395;999.2855108597388;26254.868725656248;26507;26602.866985664947;28649.427011459655;29060.273493162418;810.7365106340345;959.203860795538;995.9402435853872;1002.1388934591636;1074.4949873559415;12868.356582171042;13180;13458.394372253271;13475.19148851072;13526.25605591702;272840;277127;278166;278207;278477;47230;47749;47797.28304075442;47877;47894.76052619715;1078.6548304542628;1095.3920574081462;1214.0348423003734;1228.6580501037165;1245.9626211213679;24327;24660;24965.500689985736;24977.50044999126;25824.741752582235;38771.806140969114;39192.804035979636;39232.607673922896;39265.607343926196;39369.60630393659;178040.10979945018;178923.10538447744;180098;192582;195399;26619.60070598904;27078;30498.390032199677;31399.686003139675;31788.364232715678;33764.83117584397;34607.82696086504;34651.65348346585;34714.30571388609;34895;35995.46006809952;37845.43231851469;40014.59985400225;40741.59258407378;40958;33061.66938330682;33226.5016024755;33230.83384583062;33287.66712332846;33705;32979;33403.665963340056;33448;33736.83131584425;33741.66258337385;28328;31166.844165779024;32345.353092937537;35731.821340893126;35747.46378804372;23854.88072559626;24203.636945446186;24216.757832422154;24509.38726531851;24565.263042108767 15:14:03 INFO - PROCESS | 16052 | |2;jquery.html;352.6508756331231;356.10439744043737;359.922616637423;361.86249225294387;365.30409569769597;15470.458533951314;15775;15842.60393490162;16307.91846040771;16310.510684679479;16055.357785688588;16459;16711.916440417812;16734.079625620587;16735.66528669429;5013.799448022084;5079.644424890259;5173.456787037363;5194.428612852583;5307.495787900143;3533.487644291589;4985.775640096204;5172.534471897528;5173.3533308336455;5182.818601348954;5162.974185129069;5167.612429067816;5173.922391164136;5175.87060323493;5181.0674078665825;5134.7432628368615;5562.916556251659;5737.483626473638;5892.204552385416;5929.14027466015;5218.817341393033;5233.947660523384;5247;5251.501107394792;5262.342207224097;12087.395630218454;20504.794952050437;20823.16707331705;21190.576188476145;21204.575908481744;1993.312307253995;2009.8090681385245;2010.6280338137344;2017.2334512885157;2630.671166104237;12611.243325400505;13584.864151358459;13931.30343482832;13945.721085578232;14329.211893345862;1807.1837803008025;1888.9055547222583;1898.781640111391;1943.2615606069744;1963.6563601369703;68275.3172468274;71432.64283678548;71636.6418167911;71673.64163179151;72679.27320726778;14780.891433142557;14849.183294918883;15018.249087545579;15027.849721502864;15032.17323047221;24941.376465588506;25091.4981700365;25099;25137;25183.748162518506;7710.730124445618;7755;7787.182345853717;7798.961005194938;7970.561619111005;6362.77730279438;6602.2407423146;6669.7332106715185;6685.76599819004;6740.865182696319;7454.316446079407;7496.287852653989;7599.440335798477;7603.885941710879;7650.273224043707;2509.5984642457483;2900.419271497039;2978.5916843072373;3005.4317437494883;3142.4972004479173;407.9102597428561;408.6261071119892;419.6789456066112;791.7347688524409;934.8924873639619;9843.163331116792;9878.654247101316;9886;9894.060064294024;10194.031567001122;424.4270235182479;428.83704192406685;445.3698017305541;446.76544813972924;451.9457665080146;5609.467100625434;5654.349749778746;5666.801661941895;5687.800926967537;5734.283214598176;366197;372057;374234;379895;382704;69967;70836.64581677162;70881.64559177274;71496.64251678812;71998;450.5787089071728;454.7362529732747;456.6118799020872;456.79444250087596;458.95639914208095;9629.56666950003;9681.515924203903;9782.75543111428;9904.653337133166;10056.949715251378;32066.679333206368;35529;36524;36626;36657.816710916275;43095.56904431041;48543;50583.74708126436;50911.23633145432;51138.232926505385;7569.5079819811535;7791.376689864684;7799.181085986117;7812.726554570563;7897.68409263623;8554.443961142506;9335.439873607334;9996.700098997042;12112.333821639542;12158;9770.333839525509;9917.45454000037;9981.750456238653;10343.27597068198;10499.527521261409;9843.507824608883;9935.403875767477;10052.748681283027;10301.227407944285;10656.14750819917;9919.900800991898;9998.300118991892;10205.438700871226;10243.692689219335;10369.066783989478;7404.814879628052;7447.255274472509;7476.140243872024;7555.244475552401;7616.5810880399895;9180.770480738034;10065.798684026426;10339.741506462398;10388.480575971322;10497.10774584169 15:14:03 INFO - PROCESS | 16052 | |3;mootools.html;1304.4130141436356;1430.199088510434;1439.4530078570142;1607.493639503557;1799.8110198429165;7449.068866391701;7622.504537205078;7648.464607477465;7649.579273139975;7654.387648988081;7481.700731970728;7641.579713115791;7644.694212231504;7656.846863062736;7659.885101723478;1926.6917293233087;1987.1058023889236;1987.840972722186;2268.8184945204343;2285.5885940530698;2253.526759380532;2323.6514522821544;2325.8953347099336;2328.8951997160084;2329.6505524171425;2235.7093577834858;2270.386995511211;2284.132029828663;2288.0275882749847;2299.482616411311;2212.314182603398;2269.965950510735;2270.8069814065825;2275.6472746724203;2279;2291.255342013852;2302.873341966191;2303.6314189729565;2304.6543018547354;2306.0890948075416;7830.099538553025;7855.921440785576;7865.842683146305;7866.252705992922;7871.409644276702;4505.256632655641;4602.171609110359;4626.930596041028;4633.0733853229485;4646.651501137429;2853.9001134960176;2967.540031295153;2971.628546431696;2986.089242780951;3000.8649610767566;905.3210092430677;934.7102398256562;939.7133874168376;959.8320293948531;967.5549247346229;10455.634052808191;10466.84299735497;10470.42412667303;10479.161667066692;10514.842277365846;4225.852095176654;4286.164197981364;4353.608175264241;4373.715708478939;4379.934300985487;8879.467231966102;8916.06381329964;8923.196912277795;8932.776680583038;8958.68644597436;4639.8144074237325;4655.255159174516;4665.743384113906;4665.766711664403;4668.11305851887;3674.7243956703355;4109.671226301889;4219.894502637398;4225.68307376948;4227.704060715781;3585.15748799032;3622.1487950331652;3632.1282892105705;3642.745007849478;3691.427828686558;1212.8120141378101;1231.6243545718462;1235.4872727817856;1238.0652607281445;1255.6986323282347;906.4334790755778;947.6114792935001;1161;1179.7817403780327;1187.1927089578996;7062.611556364346;7089.964550177217;7092.078029856086;7105.111861017373;7115.964420177866;1028.804527139841;1058.9470526473644;1067.6636859389268;1078.7087486378634;1080.1574771678104;5547.362053363915;5603.691796951207;5607.186957891083;5659.292588426447;5669.177969194526;8983.865242021375;9580.66467673628;9694.17599504036;9711.66009189675;9762.121409073217;9307.953460232655;9458.810823783624;9465.479398633004;9506.429614223169;9525.618975241052;7150.7497237596435;7343.1555371131935;7348.265173482716;7399.889001664979;7435.1821299656995;6860.4168645663685;6953.826154346182;7009.1589009319205;7017.578945263301;7029.0862187915245;8342.916570834213;8468.237858592756;8512.40413171072;8606.182412670787;8608.569571521524;8577.95711021441;8686.565671716262;8781.824363512822;8797.736067917973;8828.073052329413;5660.971695141663;5935.109733540004;6089.1779609753885;6347.746090156526;6413.35866413355;7183.640817958976;7211.8557628848175;7230.204677485367;7254.6735396908325;7269.382102521134;6277.529185311211;6441.1626488556185;6470.547061705635;6499.252585952676;6570.11303474044;6281.937180628135;6331.968340158454;6512.609243445219;6556.901646475211;6628.370304821035;6729.1924969002075;6860.794176174722;6880.518363714692;6902.689378977858;6922.169339679271;6131.325554188947;6290.937090629035;6300.936990630218;6447.2263328400895;6499;6382.393672601095;6407.871842563216;6418.518611104279;6430.131932189094;6462.903056454251 15:14:03 INFO - PROCESS | 16052 | |4;prototype.html;312.67481818908334;318.3299155278141;318.43477826857327;325.1513549635451;332.1960854731549;5269.73651317434;5417.756200970956;5432.158015507598;5432.483914028171;5491.945080549193;5339.439358867321;5347.572194224463;5349.197620356948;5357.705326207057;5363.865903352408;4005.5193376794828;4067.2272268268935;4170.145120250357;4194.5805419457965;4210.221109094819;4163.500379954395;4182.477190351206;4184.686148538856;4185.246655601991;4186.623203911648;4140.254754144253;4154.854580089697;4155.729877557964;4156.127213285214;4166.375043743433;3995.4606128172613;4085.2850751118585;4183.853565125206;4191.559886211965;4200.873973780792;3703.611120832301;3704.1665625234377;3709.091272638194;3714.7771133731794;3723.0320116769562;5042.193249080129;5046.7224302663335;5059.114654935408;5061.721605311706;5065.822696205615;4816.710997340171;4819.44576373718;4823.20417131173;4832.130216561018;4833.226683730586;5611.298587676541;5616.550675945955;5619.241402410704;5622.550195984311;5644.802431914904;4066.8983275418054;4068.572799856032;4075.0831063010587;4076.8980775480554;4077.755334679899;5678.886422271573;5885.117232415172;5887.705614719247;5890.528757699374;5891.145783861359;3950.9209815804097;3970.0273433009097;3973.1259122992897;3973.2252210819192;3975.105601239698;4012.799360031987;4016.658584020391;4018.0758425562285;4019.8392064317686;4022.4368588397647;4657.022025374641;4658.254679251304;4661.813527458931;4666.300054991779;4669.229577119737;5652.378238393773;5652.547796176296;5654.660720356792;5658.151277308354;5666.206731057655;1427.3719563392074;1450.5430789301336;1451.5137428961416;1453.0119518727367;1454.120257244373;903.2457897655399;952.3048174832411;952.6046690623452;977.3891317926297;979.4123525884555;4876.366072410635;4900.803967841318;4919.729414882144;4929.408470983505;4930.087933732271;5796.768129274866;5801.332846722681;5801.593888427854;5806.738696758656;5818.796342128006;4893.363862697897;4909.70541767488;4912.6561140719805;4918.1393256180745;4918.778654960535;3084.383123375334;3107.0678796361003;3130.765192610563;3134.514150306706;3136.54520094585;5488.286522752097;5501.889962200734;5502.2296878437055;5504.504594586507;5507.504324610804;5774.769009239583;6007.429294217042;6016.338202797689;6029.065494848305;6036;5444.618876678674;5460.5085542301385;5486.286782718221;5491.780328786884;5497.615166938276;5780.739866705924;5786.392428794916;5787.884242315215;5790.276215473066;5799.159121927381;5646.971765141148;5670.234518339971;5670.971645141748;5679.630823996592;5680.7443665036;5436.211749296409;5460.945390546202;5471.945280547303;5482.917756233739;5482.917756233739;3943.802809859553;4041.9797901010306;4057.5739547348285;4061.6750659947725;4064.837406503825;5721.370649228665;5724.8282551523525;5727.284089488814;5761.625494342854;5766.336871259691;5560.471755183251;5580.079286917613;5580.190872323409;5581.330240371019;5584.888302234014;5579;5584.190292407497;5586.888262234651;5587.385387607441;5589.580781441489;5346.732663366738;5477.616566840283;5492.1212605982855;5493.6978466183145;5499.065158922913;5609.747561359667;5610.747516361856;5612.85967850807;5616.326040875121;5622.634528755618;5465.59008074388;5486.423925487926;5490.478404551562;5494.945050549443;5498.615096943176 15:14:03 INFO - PROCESS | 16052 | |5;yui.html;611.6146827498676;739.7115125101211;746.4774657739583;761.0486891385764;765.5674543882706;11956.282623042613;12079.335636539987;12128.332941688204;12129.818052729217;12173.269603823777;11653;11667.708307292321;11667.941660291708;11722.7655446891;11745.119116066286;647.58230941043;660.5607271164694;660.8546119853648;661.3683931845077;803.0483876606211;811.4238890387832;814.8533264012475;814.9429539932207;816.073756286616;816.4407380944043;850.2560259772699;856.7001549457672;857.5583574459158;858.0647094666812;858.3305022082785;666.6866572710842;824.2458150792019;838.2162677896187;842.6334544473143;847.2967437027253;624.9468795152372;626.6522080245462;627.9748810047593;629.4743888852813;629.6945981199115;11232.21374503785;11271.098312135091;11288.266262692981;11340.886591134065;11411.48648310828;11824.172307938448;12662.746745065138;12764.87235127646;13061.412236449383;13156.736865262737;9472.22896670647;9645.951770241174;9746.415215087047;9792.265580081452;9805.950970245174;3304.074859039473;3326.434506133963;3331.5002749587516;3432.2792213635166;3462.272922686239;41961.37057944103;42038;42226;42999.785001075106;43965.560344396465;10057;10105.908000219462;10225.079742823033;10372.844407333896;10515;16415.343386264416;16453.58866028335;16456.753148702777;16457.835421645632;16498.75251871223;6706.497012724065;6814.93185068143;6861.759838405632;6865.27914568973;7003.404710599554;3777.206786574795;3810.9618903810606;3817;3848.4804551385205;3927.626875446885;2778.6943436222;2786.066667666314;2816.9859150704524;2864.4127953769425;2865.7277558631895;487.92193249079975;510.24993259907876;522.8222404382528;526.1712802336335;527.4646234072419;509.2844553402475;513.7071869034614;546.0716781471515;551.2007588995972;639.1148259660404;7892.565908874953;7967.601619918981;8237.46456480327;8250;8300.626471808782;510.6042816816922;592.2537602620729;630.7886857902562;636.1983900285674;639.6418005916702;3845.538535375717;3946.6842652587725;3949.111449923744;3989.2023081304983;4069.8575549855614;50792;51357.22964155541;51399.22901156486;51573.48426515762;51623;44135.77932110319;44886.77556612196;44943.32585011228;44968.77515612401;45432.3185152223;40571.391429128584;40926.38610420846;41358.79320603378;41506.79246603748;41815.37276940848;7740.535567865946;7816.452848300564;7873.212678732081;7965.601719913865;8003.079645840803;31860.681393185772;32112.518312225802;32547.34905301928;32678.934765111444;33241;38522.22955540817;38547.614523855525;40980.79509602433;41699.7915010423;41699.7915010423;9558.856617150888;9663.178629816544;9676.576829634974;9692.85460718104;9837.458939758382;10485.737856553647;10552.78894422092;10554.208434367607;10567.63013294531;10657.893421066;8669.566521673765;10369.118624916966;11438.771224575295;11565.479553420284;11598.2461140029;10934.671959841218;11235.438228088726;11263.436828158396;11398.316101033965;11414.714632134263;11093.33439993603;11116;11172.106231501622;11187.216894817284;11405.54377824911;9621.56702948383;9715.174210192214;9846.60613575449;9925.702228933143;10089.596416143566;9715.514224288898;10075.848862266925;10115.949420252851;10122.44326562046;10129.493525323851 15:14:03 INFO - PROCESS | 16052 | __end_tp_report 15:14:03 INFO - PROCESS | 16052 | __start_cc_report 15:14:03 INFO - PROCESS | 16052 | _x_x_mozilla_cycle_collect,1072 15:14:03 INFO - PROCESS | 16052 | __end_cc_report 15:14:03 INFO - PROCESS | 16052 | __startTimestamp1459548843063__endTimestamp 15:14:03 INFO - PROCESS | 16052 | 15:14:03 INFO - PROCESS | 16052 | ------- Summary: start ------- 15:14:03 INFO - PROCESS | 16052 | Number of tests: 6 15:14:03 INFO - PROCESS | 16052 | 15:14:03 INFO - PROCESS | 16052 | [#0] dojo.html Cycles:165 Average:4634.64 Median:4765.93 stddev:469.96 (9.9%) stddev-sans-first:444.62 15:14:03 INFO - PROCESS | 16052 | Values: 2641.1 2670.6 2678.7 2687.6 2714.2 4557.0 4658.7 4680.1 4680.2 4696.6 4642.3 4663.8 4664.2 4723.8 4746.5 4280.4 4305.5 4329.0 4373.2 4437.2 4427.8 4463.2 4482.3 4490.9 4523.4 4237.4 4321.9 4323.7 4394.5 4404.8 4352.3 4367.9 4385.6 4391.4 4421.8 4332.9 4353.5 4357.2 4369.7 4400.9 4470.2 4548.5 4570.5 4620.6 4659.3 4929.5 4935.1 4941.8 4945.4 4994.4 4951.3 4954.5 4957.9 4975.6 5008.8 4557.8 4629.9 4636.4 4751.4 4769.6 5153.3 5168.3 5175.6 5179.7 5184.5 4950.4 4951.9 4956.5 4959.7 5006.7 4926.3 5031.1 5076.9 5109.8 5125.6 4917.7 4939.6 4948.5 4949.7 5000.4 4851.3 4887.8 4889.8 4898.8 4943.2 4200.7 4237.3 4258.3 4329.7 4336.7 3664.2 3687.7 3690.1 3727.8 3731.7 4279.8 4280.9 4283.7 4290.9 4322.5 4916.9 4992.7 5078.9 5117.4 5138.4 4284.1 4300.1 4302.8 4303.9 4345.4 4434.4 4502.9 4506.5 4518.4 4552.4 4765.9 4805.7 4847.5 4850.0 4852.4 4987.2 5029.9 5035.2 5036.7 5084.0 4633.3 4750.3 4761.9 4766.3 4812.9 4929.3 4949.2 4977.4 5008.3 5024.0 4979.0 4985.7 4987.7 4992.7 5043.2 4736.9 4752.7 4846.7 4859.0 4900.2 4801.6 4820.0 4822.7 4866.0 4875.3 4749.1 4749.7 4766.5 4769.0 4794.0 4755.4 4842.7 4927.1 4927.3 4944.5 4780.3 4806.3 4808.6 4828.4 4846.4 15:14:03 INFO - PROCESS | 16052 | 15:14:03 INFO - PROCESS | 16052 | [#1] ext.html Cycles:180 Average:37633.08 Median:19180.59 stddev:57539.12 (300.0%) stddev-sans-first:57633.07 15:14:03 INFO - PROCESS | 16052 | Values: 526.5 550.8 555.2 557.5 560.1 27254.0 34103.8 34872.3 34900.8 34953.0 37362.0 37771.0 37803.1 37811.0 37855.0 7782.2 7982.2 7986.0 7987.8 7988.9 7816.8 7951.2 7954.6 7958.2 7962.1 7896.6 7987.8 7989.6 7990.1 7993.4 7869.8 7908.4 7928.4 7944.4 7946.2 7819.8 7955.1 7961.1 7963.3 7965.9 37566.0 37896.8 37913.2 37938.9 38001.4 2946.4 3006.3 3242.4 3366.9 3482.7 27740.9 27793.0 28268.6 28361.3 28485.7 3442.5 3454.2 3455.4 3474.3 3488.9 183826.0 188702.0 188802.0 188811.0 189194.0 42864.8 43539.0 55219.2 61438.7 61776.7 43421.8 43439.0 43652.6 43686.8 43725.6 12171.8 12332.8 12364.7 12367.5 12367.7 9067.4 9143.1 9145.3 9147.0 9151.2 14359.5 14367.1 14379.6 14805.9 14833.9 5994.0 6077.7 6112.1 6195.0 6289.2 808.0 893.9 928.9 956.7 999.3 26254.9 26507.0 26602.9 28649.4 29060.3 810.7 959.2 995.9 1002.1 1074.5 12868.4 13180.0 13458.4 13475.2 13526.3 272840.0 277127.0 278166.0 278207.0 278477.0 47230.0 47749.0 47797.3 47877.0 47894.8 1078.7 1095.4 1214.0 1228.7 1246.0 24327.0 24660.0 24965.5 24977.5 25824.7 38771.8 39192.8 39232.6 39265.6 39369.6 178040.1 178923.1 180098.0 192582.0 195399.0 26619.6 27078.0 30498.4 31399.7 31788.4 33764.8 34607.8 34651.7 34714.3 34895.0 35995.5 37845.4 40014.6 40741.6 40958.0 33061.7 33226.5 33230.8 33287.7 33705.0 32979.0 33403.7 33448.0 33736.8 33741.7 28328.0 31166.8 32345.4 35731.8 35747.5 23854.9 24203.6 24216.8 24509.4 24565.3 15:14:03 INFO - PROCESS | 16052 | 15:14:03 INFO - PROCESS | 16052 | [#2] jquery.html Cycles:180 Average:23758.48 Median:24500.98 stddev:61917.23 (252.7%) stddev-sans-first:62065.98 15:14:03 INFO - PROCESS | 16052 | Values: 352.7 356.1 359.9 361.9 365.3 15470.5 15775.0 15842.6 16307.9 16310.5 16055.4 16459.0 16711.9 16734.1 16735.7 5013.8 5079.6 5173.5 5194.4 5307.5 3533.5 4985.8 5172.5 5173.4 5182.8 5163.0 5167.6 5173.9 5175.9 5181.1 5134.7 5562.9 5737.5 5892.2 5929.1 5218.8 5233.9 5247.0 5251.5 5262.3 12087.4 20504.8 20823.2 21190.6 21204.6 1993.3 2009.8 2010.6 2017.2 2630.7 12611.2 13584.9 13931.3 13945.7 14329.2 1807.2 1888.9 1898.8 1943.3 1963.7 68275.3 71432.6 71636.6 71673.6 72679.3 14780.9 14849.2 15018.2 15027.8 15032.2 24941.4 25091.5 25099.0 25137.0 25183.7 7710.7 7755.0 7787.2 7799.0 7970.6 6362.8 6602.2 6669.7 6685.8 6740.9 7454.3 7496.3 7599.4 7603.9 7650.3 2509.6 2900.4 2978.6 3005.4 3142.5 407.9 408.6 419.7 791.7 934.9 9843.2 9878.7 9886.0 9894.1 10194.0 424.4 428.8 445.4 446.8 451.9 5609.5 5654.3 5666.8 5687.8 5734.3 366197.0 372057.0 374234.0 379895.0 382704.0 69967.0 70836.6 70881.6 71496.6 71998.0 450.6 454.7 456.6 456.8 459.0 9629.6 9681.5 9782.8 9904.7 10056.9 32066.7 35529.0 36524.0 36626.0 36657.8 43095.6 48543.0 50583.7 50911.2 51138.2 7569.5 7791.4 7799.2 7812.7 7897.7 8554.4 9335.4 9996.7 12112.3 12158.0 9770.3 9917.5 9981.8 10343.3 10499.5 9843.5 9935.4 10052.7 10301.2 10656.1 9919.9 9998.3 10205.4 10243.7 10369.1 7404.8 7447.3 7476.1 7555.2 7616.6 9180.8 10065.8 10339.7 10388.5 10497.1 15:14:03 INFO - PROCESS | 16052 | 15:14:03 INFO - PROCESS | 16052 | [#3] mootools.html Cycles:180 Average:5359.14 Median:6316.45 stddev:2799.72 (44.3%) stddev-sans-first:2790.98 15:14:03 INFO - PROCESS | 16052 | Values: 1304.4 1430.2 1439.5 1607.5 1799.8 7449.1 7622.5 7648.5 7649.6 7654.4 7481.7 7641.6 7644.7 7656.8 7659.9 1926.7 1987.1 1987.8 2268.8 2285.6 2253.5 2323.7 2325.9 2328.9 2329.7 2235.7 2270.4 2284.1 2288.0 2299.5 2212.3 2270.0 2270.8 2275.6 2279.0 2291.3 2302.9 2303.6 2304.7 2306.1 7830.1 7855.9 7865.8 7866.3 7871.4 4505.3 4602.2 4626.9 4633.1 4646.7 2853.9 2967.5 2971.6 2986.1 3000.9 905.3 934.7 939.7 959.8 967.6 10455.6 10466.8 10470.4 10479.2 10514.8 4225.9 4286.2 4353.6 4373.7 4379.9 8879.5 8916.1 8923.2 8932.8 8958.7 4639.8 4655.3 4665.7 4665.8 4668.1 3674.7 4109.7 4219.9 4225.7 4227.7 3585.2 3622.1 3632.1 3642.7 3691.4 1212.8 1231.6 1235.5 1238.1 1255.7 906.4 947.6 1161.0 1179.8 1187.2 7062.6 7090.0 7092.1 7105.1 7116.0 1028.8 1058.9 1067.7 1078.7 1080.2 5547.4 5603.7 5607.2 5659.3 5669.2 8983.9 9580.7 9694.2 9711.7 9762.1 9308.0 9458.8 9465.5 9506.4 9525.6 7150.7 7343.2 7348.3 7399.9 7435.2 6860.4 6953.8 7009.2 7017.6 7029.1 8342.9 8468.2 8512.4 8606.2 8608.6 8578.0 8686.6 8781.8 8797.7 8828.1 5661.0 5935.1 6089.2 6347.7 6413.4 7183.6 7211.9 7230.2 7254.7 7269.4 6277.5 6441.2 6470.5 6499.3 6570.1 6281.9 6332.0 6512.6 6556.9 6628.4 6729.2 6860.8 6880.5 6902.7 6922.2 6131.3 6290.9 6300.9 6447.2 6499.0 6382.4 6407.9 6418.5 6430.1 6462.9 15:14:03 INFO - PROCESS | 16052 | 15:14:03 INFO - PROCESS | 16052 | [#4] prototype.html Cycles:180 Average:4656.64 Median:5360.79 stddev:1357.93 (25.3%) stddev-sans-first:1322.01 15:14:03 INFO - PROCESS | 16052 | Values: 312.7 318.3 318.4 325.2 332.2 5269.7 5417.8 5432.2 5432.5 5491.9 5339.4 5347.6 5349.2 5357.7 5363.9 4005.5 4067.2 4170.1 4194.6 4210.2 4163.5 4182.5 4184.7 4185.2 4186.6 4140.3 4154.9 4155.7 4156.1 4166.4 3995.5 4085.3 4183.9 4191.6 4200.9 3703.6 3704.2 3709.1 3714.8 3723.0 5042.2 5046.7 5059.1 5061.7 5065.8 4816.7 4819.4 4823.2 4832.1 4833.2 5611.3 5616.6 5619.2 5622.6 5644.8 4066.9 4068.6 4075.1 4076.9 4077.8 5678.9 5885.1 5887.7 5890.5 5891.1 3950.9 3970.0 3973.1 3973.2 3975.1 4012.8 4016.7 4018.1 4019.8 4022.4 4657.0 4658.3 4661.8 4666.3 4669.2 5652.4 5652.5 5654.7 5658.2 5666.2 1427.4 1450.5 1451.5 1453.0 1454.1 903.2 952.3 952.6 977.4 979.4 4876.4 4900.8 4919.7 4929.4 4930.1 5796.8 5801.3 5801.6 5806.7 5818.8 4893.4 4909.7 4912.7 4918.1 4918.8 3084.4 3107.1 3130.8 3134.5 3136.5 5488.3 5501.9 5502.2 5504.5 5507.5 5774.8 6007.4 6016.3 6029.1 6036.0 5444.6 5460.5 5486.3 5491.8 5497.6 5780.7 5786.4 5787.9 5790.3 5799.2 5647.0 5670.2 5671.0 5679.6 5680.7 5436.2 5460.9 5471.9 5482.9 5482.9 3943.8 4042.0 4057.6 4061.7 4064.8 5721.4 5724.8 5727.3 5761.6 5766.3 5560.5 5580.1 5580.2 5581.3 5584.9 5579.0 5584.2 5586.9 5587.4 5589.6 5346.7 5477.6 5492.1 5493.7 5499.1 5609.7 5610.7 5612.9 5616.3 5622.6 5465.6 5486.4 5490.5 5494.9 5498.6 15:14:03 INFO - PROCESS | 16052 | 15:14:03 INFO - PROCESS | 16052 | [#5] yui.html Cycles:180 Average:12594.22 Median:42132.00 stddev:14165.24 (33.6%) stddev-sans-first:14176.39 15:14:03 INFO - PROCESS | 16052 | Values: 611.6 739.7 746.5 761.0 765.6 11956.3 12079.3 12128.3 12129.8 12173.3 11653.0 11667.7 11667.9 11722.8 11745.1 647.6 660.6 660.9 661.4 803.0 811.4 814.9 814.9 816.1 816.4 850.3 856.7 857.6 858.1 858.3 666.7 824.2 838.2 842.6 847.3 624.9 626.7 628.0 629.5 629.7 11232.2 11271.1 11288.3 11340.9 11411.5 11824.2 12662.7 12764.9 13061.4 13156.7 9472.2 9646.0 9746.4 9792.3 9806.0 3304.1 3326.4 3331.5 3432.3 3462.3 41961.4 42038.0 42226.0 42999.8 43965.6 10057.0 10105.9 10225.1 10372.8 10515.0 16415.3 16453.6 16456.8 16457.8 16498.8 6706.5 6814.9 6861.8 6865.3 7003.4 3777.2 3811.0 3817.0 3848.5 3927.6 2778.7 2786.1 2817.0 2864.4 2865.7 487.9 510.2 522.8 526.2 527.5 509.3 513.7 546.1 551.2 639.1 7892.6 7967.6 8237.5 8250.0 8300.6 510.6 592.3 630.8 636.2 639.6 3845.5 3946.7 3949.1 3989.2 4069.9 50792.0 51357.2 51399.2 51573.5 51623.0 44135.8 44886.8 44943.3 44968.8 45432.3 40571.4 40926.4 41358.8 41506.8 41815.4 7740.5 7816.5 7873.2 7965.6 8003.1 31860.7 32112.5 32547.3 32678.9 33241.0 38522.2 38547.6 40980.8 41699.8 41699.8 9558.9 9663.2 9676.6 9692.9 9837.5 10485.7 10552.8 10554.2 10567.6 10657.9 8669.6 10369.1 11438.8 11565.5 11598.2 10934.7 11235.4 11263.4 11398.3 11414.7 11093.3 11116.0 11172.1 11187.2 11405.5 9621.6 9715.2 9846.6 9925.7 10089.6 9715.5 10075.8 10115.9 10122.4 10129.5 15:14:03 INFO - PROCESS | 16052 | -------- Summary: end -------- 15:14:03 INFO - PROCESS | 16052 | 15:14:03 INFO - TEST-INFO | 16052: exit 0 15:14:03 INFO - TEST-OK | dromaeo_css | took 1118093ms 15:14:03 INFO - TEST-START | kraken 15:14:03 INFO - operating with platform_type : linux_ 15:14:03 INFO - Initialising browser for kraken test... 15:14:03 INFO - TEST-INFO | started process 16231 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpytflZb/profile http://localhost:51410/getInfo.html) 15:14:07 INFO - PROCESS | 16231 | __metrics Screen width/height:1600/1200 15:14:07 INFO - PROCESS | 16231 | colorDepth:24 15:14:07 INFO - PROCESS | 16231 | Browser inner width/height: 1024/697 15:14:07 INFO - PROCESS | 16231 | __metrics 15:14:08 ERROR - PROCESS | 16231 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:14:09 INFO - TEST-INFO | 16231: exit 0 15:14:09 INFO - Browser initialized. 15:14:09 INFO - Running cycle 1/1 for kraken test... 15:14:09 INFO - TEST-INFO | started process 16310 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpytflZb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:14:21 INFO - PROCESS | 16310 | RSS: Main: 154472448 15:14:21 INFO - PROCESS | 16310 | 15:14:24 INFO - PROCESS | 16310 | Cycle 1(1): loaded http://localhost:51410/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51410/tests/kraken/driver.html?testName=audio-beat-detection) 15:14:24 INFO - PROCESS | 16310 | RSS: Main: 195993600 15:14:24 INFO - PROCESS | 16310 | 15:14:27 INFO - PROCESS | 16310 | Cycle 1(1): loaded http://localhost:51410/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51410/tests/kraken/driver.html?testName=audio-dft) 15:14:28 INFO - PROCESS | 16310 | RSS: Main: 185884672 15:14:28 INFO - PROCESS | 16310 | 15:14:31 INFO - PROCESS | 16310 | Cycle 1(1): loaded http://localhost:51410/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51410/tests/kraken/driver.html?testName=audio-fft) 15:14:31 INFO - PROCESS | 16310 | RSS: Main: 172130304 15:14:31 INFO - PROCESS | 16310 | 15:14:33 INFO - PROCESS | 16310 | Cycle 1(1): loaded http://localhost:51410/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51410/tests/kraken/driver.html?testName=audio-oscillator) 15:14:34 INFO - PROCESS | 16310 | RSS: Main: 172187648 15:14:34 INFO - PROCESS | 16310 | 15:14:36 INFO - PROCESS | 16310 | Cycle 1(1): loaded http://localhost:51410/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51410/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:14:37 INFO - PROCESS | 16310 | RSS: Main: 173625344 15:14:37 INFO - PROCESS | 16310 | 15:14:40 INFO - PROCESS | 16310 | Cycle 1(1): loaded http://localhost:51410/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51410/tests/kraken/driver.html?testName=imaging-darkroom) 15:14:41 INFO - PROCESS | 16310 | RSS: Main: 173297664 15:14:41 INFO - PROCESS | 16310 | 15:14:44 INFO - PROCESS | 16310 | Cycle 1(1): loaded http://localhost:51410/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51410/tests/kraken/driver.html?testName=imaging-desaturate) 15:14:45 INFO - PROCESS | 16310 | RSS: Main: 174424064 15:14:45 INFO - PROCESS | 16310 | 15:14:47 INFO - PROCESS | 16310 | Cycle 1(1): loaded http://localhost:51410/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51410/tests/kraken/driver.html?testName=json-parse-financial) 15:14:48 INFO - PROCESS | 16310 | RSS: Main: 174874624 15:14:48 INFO - PROCESS | 16310 | 15:14:50 INFO - PROCESS | 16310 | Cycle 1(1): loaded http://localhost:51410/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51410/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:14:50 INFO - PROCESS | 16310 | RSS: Main: 186335232 15:14:50 INFO - PROCESS | 16310 | 15:14:52 INFO - PROCESS | 16310 | Cycle 1(1): loaded http://localhost:51410/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51410/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:14:53 INFO - PROCESS | 16310 | RSS: Main: 185061376 15:14:53 INFO - PROCESS | 16310 | 15:14:55 INFO - PROCESS | 16310 | Cycle 1(1): loaded http://localhost:51410/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51410/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:14:55 INFO - PROCESS | 16310 | RSS: Main: 195715072 15:14:55 INFO - PROCESS | 16310 | 15:14:58 INFO - PROCESS | 16310 | Cycle 1(1): loaded http://localhost:51410/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51410/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:14:59 INFO - PROCESS | 16310 | RSS: Main: 198586368 15:14:59 INFO - PROCESS | 16310 | 15:15:01 INFO - PROCESS | 16310 | Cycle 1(1): loaded http://localhost:51410/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51410/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:15:02 INFO - PROCESS | 16310 | RSS: Main: 198852608 15:15:02 INFO - PROCESS | 16310 | 15:15:03 INFO - PROCESS | 16310 | Cycle 1(1): loaded http://localhost:51410/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51410/tests/kraken/driver.html?testName=ai-astar) 15:15:04 INFO - PROCESS | 16310 | RSS: Main: 260788224 15:15:04 INFO - PROCESS | 16310 | 15:15:04 INFO - PROCESS | 16310 | __start_tp_report 15:15:04 INFO - PROCESS | 16310 | _x_x_mozilla_page_load 15:15:04 INFO - PROCESS | 16310 | _x_x_mozilla_page_load_details 15:15:04 INFO - PROCESS | 16310 | |i|pagename|runs| 15:15:04 INFO - PROCESS | 16310 | |0;ai-astar;110;114;106;114;111;112;99;112;111;113 15:15:04 INFO - PROCESS | 16310 | |1;audio-beat-detection;162;132;162;177;133;166;172;133;175;135 15:15:04 INFO - PROCESS | 16310 | |2;audio-dft;162;162;162;163;162;162;162;164;161;163 15:15:04 INFO - PROCESS | 16310 | |3;audio-fft;77;74;102;99;77;74;75;129;100;79 15:15:04 INFO - PROCESS | 16310 | |4;audio-oscillator;94;95;136;94;95;95;147;95;95;153 15:15:04 INFO - PROCESS | 16310 | |5;imaging-gaussian-blur;117;117;117;116;116;117;117;117;118;117 15:15:04 INFO - PROCESS | 16310 | |6;imaging-darkroom;145;146;146;145;145;145;146;145;146;145 15:15:04 INFO - PROCESS | 16310 | |7;imaging-desaturate;95;95;96;95;95;95;95;95;95;94 15:15:04 INFO - PROCESS | 16310 | |8;json-parse-financial;64;64;64;64;64;64;65;74;62;74 15:15:04 INFO - PROCESS | 16310 | |9;json-stringify-tinderbox;63;64;63;63;63;66;64;74;67;64 15:15:04 INFO - PROCESS | 16310 | |10;stanford-crypto-aes;82;84;83;82;90;81;82;82;81;82 15:15:04 INFO - PROCESS | 16310 | |11;stanford-crypto-ccm;125;117;117;115;116;119;120;124;117;115 15:15:04 INFO - PROCESS | 16310 | |12;stanford-crypto-pbkdf2;141;151;140;140;141;129;141;146;144;156 15:15:04 INFO - PROCESS | 16310 | |13;stanford-crypto-sha256-iterative;71;68;70;68;68;67;68;70;66;66 15:15:04 INFO - PROCESS | 16310 | __end_tp_report 15:15:04 INFO - PROCESS | 16310 | __start_cc_report 15:15:04 INFO - PROCESS | 16310 | _x_x_mozilla_cycle_collect,1167 15:15:04 INFO - PROCESS | 16310 | __end_cc_report 15:15:04 INFO - PROCESS | 16310 | __startTimestamp1459548904248__endTimestamp 15:15:04 INFO - PROCESS | 16310 | 15:15:04 INFO - PROCESS | 16310 | ------- Summary: start ------- 15:15:04 INFO - PROCESS | 16310 | Number of tests: 14 15:15:04 INFO - PROCESS | 16310 | 15:15:04 INFO - PROCESS | 16310 | [#0] ai-astar Cycles:10 Average:110.20 Median:112.50 stddev:4.57 (4.1%) stddev-sans-first:4.84 15:15:04 INFO - PROCESS | 16310 | Values: 110.0 114.0 106.0 114.0 111.0 112.0 99.0 112.0 111.0 113.0 15:15:04 INFO - PROCESS | 16310 | 15:15:04 INFO - PROCESS | 16310 | [#1] audio-beat-detection Cycles:10 Average:154.70 Median:164.00 stddev:19.11 (11.7%) stddev-sans-first:20.09 15:15:04 INFO - PROCESS | 16310 | Values: 162.0 132.0 162.0 177.0 133.0 166.0 172.0 133.0 175.0 135.0 15:15:04 INFO - PROCESS | 16310 | 15:15:04 INFO - PROCESS | 16310 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 15:15:04 INFO - PROCESS | 16310 | Values: 162.0 162.0 162.0 163.0 162.0 162.0 162.0 164.0 161.0 163.0 15:15:04 INFO - PROCESS | 16310 | 15:15:04 INFO - PROCESS | 16310 | [#3] audio-fft Cycles:10 Average:88.60 Median:76.00 stddev:18.33 (24.1%) stddev-sans-first:18.95 15:15:04 INFO - PROCESS | 16310 | Values: 77.0 74.0 102.0 99.0 77.0 74.0 75.0 129.0 100.0 79.0 15:15:04 INFO - PROCESS | 16310 | 15:15:04 INFO - PROCESS | 16310 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:95.00 stddev:24.79 (26.1%) stddev-sans-first:25.62 15:15:04 INFO - PROCESS | 16310 | Values: 94.0 95.0 136.0 94.0 95.0 95.0 147.0 95.0 95.0 153.0 15:15:04 INFO - PROCESS | 16310 | 15:15:04 INFO - PROCESS | 16310 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 15:15:04 INFO - PROCESS | 16310 | Values: 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 118.0 117.0 15:15:04 INFO - PROCESS | 16310 | 15:15:04 INFO - PROCESS | 16310 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 15:15:04 INFO - PROCESS | 16310 | Values: 145.0 146.0 146.0 145.0 145.0 145.0 146.0 145.0 146.0 145.0 15:15:04 INFO - PROCESS | 16310 | 15:15:04 INFO - PROCESS | 16310 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 15:15:04 INFO - PROCESS | 16310 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 15:15:04 INFO - PROCESS | 16310 | 15:15:04 INFO - PROCESS | 16310 | [#8] json-parse-financial Cycles:10 Average:65.90 Median:64.00 stddev:4.33 (6.8%) stddev-sans-first:4.54 15:15:04 INFO - PROCESS | 16310 | Values: 64.0 64.0 64.0 64.0 64.0 64.0 65.0 74.0 62.0 74.0 15:15:04 INFO - PROCESS | 16310 | 15:15:04 INFO - PROCESS | 16310 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:64.00 stddev:3.41 (5.3%) stddev-sans-first:3.54 15:15:04 INFO - PROCESS | 16310 | Values: 63.0 64.0 63.0 63.0 63.0 66.0 64.0 74.0 67.0 64.0 15:15:04 INFO - PROCESS | 16310 | 15:15:04 INFO - PROCESS | 16310 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:82.00 stddev:2.64 (3.2%) stddev-sans-first:2.78 15:15:04 INFO - PROCESS | 16310 | Values: 82.0 84.0 83.0 82.0 90.0 81.0 82.0 82.0 81.0 82.0 15:15:04 INFO - PROCESS | 16310 | 15:15:04 INFO - PROCESS | 16310 | [#11] stanford-crypto-ccm Cycles:10 Average:118.50 Median:118.00 stddev:3.54 (3.0%) stddev-sans-first:2.86 15:15:04 INFO - PROCESS | 16310 | Values: 125.0 117.0 117.0 115.0 116.0 119.0 120.0 124.0 117.0 115.0 15:15:04 INFO - PROCESS | 16310 | 15:15:04 INFO - PROCESS | 16310 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.90 Median:142.50 stddev:7.22 (5.1%) stddev-sans-first:7.62 15:15:04 INFO - PROCESS | 16310 | Values: 141.0 151.0 140.0 140.0 141.0 129.0 141.0 146.0 144.0 156.0 15:15:04 INFO - PROCESS | 16310 | 15:15:04 INFO - PROCESS | 16310 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:1.69 (2.5%) stddev-sans-first:1.45 15:15:04 INFO - PROCESS | 16310 | Values: 71.0 68.0 70.0 68.0 68.0 67.0 68.0 70.0 66.0 66.0 15:15:04 INFO - PROCESS | 16310 | -------- Summary: end -------- 15:15:04 INFO - PROCESS | 16310 | 15:15:05 INFO - TEST-INFO | 16310: exit 0 15:15:05 INFO - TEST-OK | kraken | took 61604ms 15:15:05 INFO - SUITE-END | took 1179s 15:15:05 INFO - Completed test suite (00:19:39) 15:15:05 INFO - javascript benchmark 15:15:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2641.1284276188853, 2670.6394636724035, 2678.74551917568, 2687.596860470928, 2714.2400127964165, 4556.977215113928, 4658.7204767713965, 4680.13417517759, 4680.180968330541, 4696.624270058395, 4642.303654451834, 4663.790129444174, 4664.207084795585, 4723.763811809405, 4746.477887432388, 4280.400743895857, 4305.526392096866, 4329.047609525899, 4373.1909596724545, 4437.2013037653205, 4427.756473393962, 4463.241248987663, 4482.305242687388, 4490.887727806815, 4523.434570678665, 4237.364395340693, 4321.870343889688, 4323.740575565476, 4394.516603173648, 4404.8458303959205, 4352.347147927804, 4367.912641747147, 4385.56144385562, 4391.407160033386, 4421.823127074913, 4332.891677708051, 4353.499347575006, 4357.150355680644, 4369.650427965787, 4400.933985990213, 4470.173017991682, 4548.545145485425, 4570.474395444533, 4620.584147426748, 4659.324397962277, 4929.531694489017, 4935.136351138536, 4941.827036053721, 4945.357103576512, 4994.425641051289, 4951.306817045616, 4954.504549545017, 4957.851264462072, 4975.5522003019905, 5008.824691135793, 4557.840475583339, 4629.930551041737, 4636.44362676481, 4751.358566593465, 4769.57073863354, 5153.2785410042625, 5168.250603662523, 5175.585953123741, 5179.663321884065, 5184.533391994663, 4950.381202349707, 4951.876203094951, 4956.4547899731, 4959.677620954626, 5006.724630145304, 4926.33494478248, 5031.094403007421, 5076.898462030813, 5109.821156259513, 5125.589952803767, 4917.704937703749, 4939.604831613462, 4948.505149485095, 4949.678270912379, 5000.424951130593, 4851.320815085891, 4887.804487820447, 4889.804407823647, 4898.755062246873, 4943.184374578154, 4200.7479551227025, 4237.343211802176, 4258.318669012943, 4329.6969212154845, 4336.696431249846, 3664.2305115925956, 3687.6681098701247, 3690.095926498025, 3727.7763334200035, 3731.7014638828828, 4279.807408666556, 4280.850170244026, 4283.721558098714, 4290.935635965463, 4322.524522302544, 4916.852494425173, 4992.650514464025, 5078.949210507922, 5117.437081920985, 5138.3833939927445, 4284.057507348379, 4300.075483771005, 4302.82788688449, 4303.935440968388, 4345.413369195118, 4434.379186913835, 4502.919299368194, 4506.526814684411, 4518.412606361152, 4552.430946131733, 4765.928511072337, 4805.687630304019, 4847.466778654275, 4849.95150048495, 4852.44196917359, 4987.226979818134, 5029.899402011866, 5035.16919708244, 5036.6726162799305, 5083.957788653391, 4633.2818413146015, 4750.334953106499, 4761.9285710713675, 4766.308885211555, 4812.903741925212, 4929.260610908249, 4949.208126699711, 4977.427595826382, 5008.2738002988635, 5024.0, 4978.975105124596, 4985.700857948535, 4987.650864439454, 4992.650514463952, 5043.193089105725, 4736.8578942631775, 4752.667313288175, 4846.660733748604, 4859.0039041997015, 4900.215965445512, 4801.615870730403, 4820.035992801384, 4822.662413631012, 4866.0, 4875.317455556154, 4749.097671442415, 4749.715017098985, 4766.523347665345, 4769.0, 4794.0, 4755.405574303212, 4842.709437433765, 4927.1131196384995, 4927.334809800631, 4944.53026962438, 4780.282957556395, 4806.255030470283, 4808.6153107752, 4828.444728856227, 4846.418429788307], "unit": "score", "name": "dojo.html", "value": 4605.765792417183}, {"lowerIsBetter": false, "replicates": [526.5340173946059, 550.8127236739508, 555.1533910786048, 557.534458726963, 560.1457776890242, 27254.0, 34103.829480852626, 34872.3025539489, 34900.82549587249, 34953.0, 37362.0, 37771.0, 37803.05492362692, 37811.0, 37855.0, 7782.221777822215, 7982.161873003338, 7986.0, 7987.800304992364, 7988.880166797503, 7816.843663126734, 7951.204879512032, 7954.562499062549, 7958.204179582053, 7962.0843602985815, 7896.644650990719, 7987.840243195133, 7989.6005199740075, 7990.12108668046, 7993.400494962872, 7869.842603147934, 7908.406869484783, 7928.445008849383, 7944.364450843918, 7946.205379462065, 7819.765407037798, 7955.124936257007, 7961.1242763295995, 7963.283304502623, 7965.8805117923275, 37566.0, 37896.810515947516, 37913.241735165146, 37938.9133597652, 38001.429978550346, 2946.3665311958034, 3006.3085490337344, 3242.3839470500766, 3366.882159124419, 3482.703970162514, 27740.861295693594, 27793.0, 28268.575971360446, 28361.290967725767, 28485.71514284872, 3442.5180474733556, 3454.1537323355687, 3455.36075825973, 3474.3398754236614, 3488.8778892738633, 183826.0, 188702.0, 188802.0, 188811.0, 189194.0, 42864.78567607142, 43539.0, 55219.171712424344, 61438.692806535684, 61776.69111654413, 43421.78289108534, 43439.0, 43652.56347436549, 43686.7815660926, 43725.562744372786, 12171.817422738666, 12332.753344933051, 12364.690882727824, 12367.505299788088, 12367.69080772988, 9067.365284430158, 9143.13140251675, 9145.314101442418, 9146.954265228764, 9151.17639412456, 14359.497417590333, 14367.066140700821, 14379.568612941419, 14805.925970370079, 14833.851661483463, 5994.0, 6077.665728384893, 6112.144299798032, 6194.969025154845, 6289.182406287154, 807.9596020199084, 893.8882639670041, 928.9024652411399, 956.6699488676395, 999.2855108597388, 26254.868725656248, 26507.0, 26602.866985664947, 28649.427011459655, 29060.273493162418, 810.7365106340345, 959.203860795538, 995.9402435853872, 1002.1388934591636, 1074.4949873559415, 12868.356582171042, 13180.0, 13458.394372253271, 13475.19148851072, 13526.25605591702, 272840.0, 277127.0, 278166.0, 278207.0, 278477.0, 47230.0, 47749.0, 47797.28304075442, 47877.0, 47894.76052619715, 1078.6548304542628, 1095.3920574081462, 1214.0348423003734, 1228.6580501037165, 1245.9626211213679, 24327.0, 24660.0, 24965.500689985736, 24977.50044999126, 25824.741752582235, 38771.806140969114, 39192.804035979636, 39232.607673922896, 39265.607343926196, 39369.60630393659, 178040.10979945018, 178923.10538447744, 180098.0, 192582.0, 195399.0, 26619.60070598904, 27078.0, 30498.390032199677, 31399.686003139675, 31788.364232715678, 33764.83117584397, 34607.82696086504, 34651.65348346585, 34714.30571388609, 34895.0, 35995.46006809952, 37845.43231851469, 40014.59985400225, 40741.59258407378, 40958.0, 33061.66938330682, 33226.5016024755, 33230.83384583062, 33287.66712332846, 33705.0, 32979.0, 33403.665963340056, 33448.0, 33736.83131584425, 33741.66258337385, 28328.0, 31166.844165779024, 32345.353092937537, 35731.821340893126, 35747.46378804372, 23854.88072559626, 24203.636945446186, 24216.757832422154, 24509.38726531851, 24565.263042108767], "unit": "score", "name": "ext.html", "value": 16213.415791637017}, {"lowerIsBetter": false, "replicates": [352.6508756331231, 356.10439744043737, 359.922616637423, 361.86249225294387, 365.30409569769597, 15470.458533951314, 15775.0, 15842.60393490162, 16307.91846040771, 16310.510684679479, 16055.357785688588, 16459.0, 16711.916440417812, 16734.079625620587, 16735.66528669429, 5013.799448022084, 5079.644424890259, 5173.456787037363, 5194.428612852583, 5307.495787900143, 3533.487644291589, 4985.775640096204, 5172.534471897528, 5173.3533308336455, 5182.818601348954, 5162.974185129069, 5167.612429067816, 5173.922391164136, 5175.87060323493, 5181.0674078665825, 5134.7432628368615, 5562.916556251659, 5737.483626473638, 5892.204552385416, 5929.14027466015, 5218.817341393033, 5233.947660523384, 5247.0, 5251.501107394792, 5262.342207224097, 12087.395630218454, 20504.794952050437, 20823.16707331705, 21190.576188476145, 21204.575908481744, 1993.312307253995, 2009.8090681385245, 2010.6280338137344, 2017.2334512885157, 2630.671166104237, 12611.243325400505, 13584.864151358459, 13931.30343482832, 13945.721085578232, 14329.211893345862, 1807.1837803008025, 1888.9055547222583, 1898.781640111391, 1943.2615606069744, 1963.6563601369703, 68275.3172468274, 71432.64283678548, 71636.6418167911, 71673.64163179151, 72679.27320726778, 14780.891433142557, 14849.183294918883, 15018.249087545579, 15027.849721502864, 15032.17323047221, 24941.376465588506, 25091.4981700365, 25099.0, 25137.0, 25183.748162518506, 7710.730124445618, 7755.0, 7787.182345853717, 7798.961005194938, 7970.561619111005, 6362.77730279438, 6602.2407423146, 6669.7332106715185, 6685.76599819004, 6740.865182696319, 7454.316446079407, 7496.287852653989, 7599.440335798477, 7603.885941710879, 7650.273224043707, 2509.5984642457483, 2900.419271497039, 2978.5916843072373, 3005.4317437494883, 3142.4972004479173, 407.9102597428561, 408.6261071119892, 419.6789456066112, 791.7347688524409, 934.8924873639619, 9843.163331116792, 9878.654247101316, 9886.0, 9894.060064294024, 10194.031567001122, 424.4270235182479, 428.83704192406685, 445.3698017305541, 446.76544813972924, 451.9457665080146, 5609.467100625434, 5654.349749778746, 5666.801661941895, 5687.800926967537, 5734.283214598176, 366197.0, 372057.0, 374234.0, 379895.0, 382704.0, 69967.0, 70836.64581677162, 70881.64559177274, 71496.64251678812, 71998.0, 450.5787089071728, 454.7362529732747, 456.6118799020872, 456.79444250087596, 458.95639914208095, 9629.56666950003, 9681.515924203903, 9782.75543111428, 9904.653337133166, 10056.949715251378, 32066.679333206368, 35529.0, 36524.0, 36626.0, 36657.816710916275, 43095.56904431041, 48543.0, 50583.74708126436, 50911.23633145432, 51138.232926505385, 7569.5079819811535, 7791.376689864684, 7799.181085986117, 7812.726554570563, 7897.68409263623, 8554.443961142506, 9335.439873607334, 9996.700098997042, 12112.333821639542, 12158.0, 9770.333839525509, 9917.45454000037, 9981.750456238653, 10343.27597068198, 10499.527521261409, 9843.507824608883, 9935.403875767477, 10052.748681283027, 10301.227407944285, 10656.14750819917, 9919.900800991898, 9998.300118991892, 10205.438700871226, 10243.692689219335, 10369.066783989478, 7404.814879628052, 7447.255274472509, 7476.140243872024, 7555.244475552401, 7616.5810880399895, 9180.770480738034, 10065.798684026426, 10339.741506462398, 10388.480575971322, 10497.10774584169], "unit": "score", "name": "jquery.html", "value": 7919.8187847095205}, {"lowerIsBetter": false, "replicates": [1304.4130141436356, 1430.199088510434, 1439.4530078570142, 1607.493639503557, 1799.8110198429165, 7449.068866391701, 7622.504537205078, 7648.464607477465, 7649.579273139975, 7654.387648988081, 7481.700731970728, 7641.579713115791, 7644.694212231504, 7656.846863062736, 7659.885101723478, 1926.6917293233087, 1987.1058023889236, 1987.840972722186, 2268.8184945204343, 2285.5885940530698, 2253.526759380532, 2323.6514522821544, 2325.8953347099336, 2328.8951997160084, 2329.6505524171425, 2235.7093577834858, 2270.386995511211, 2284.132029828663, 2288.0275882749847, 2299.482616411311, 2212.314182603398, 2269.965950510735, 2270.8069814065825, 2275.6472746724203, 2279.0, 2291.255342013852, 2302.873341966191, 2303.6314189729565, 2304.6543018547354, 2306.0890948075416, 7830.099538553025, 7855.921440785576, 7865.842683146305, 7866.252705992922, 7871.409644276702, 4505.256632655641, 4602.171609110359, 4626.930596041028, 4633.0733853229485, 4646.651501137429, 2853.9001134960176, 2967.540031295153, 2971.628546431696, 2986.089242780951, 3000.8649610767566, 905.3210092430677, 934.7102398256562, 939.7133874168376, 959.8320293948531, 967.5549247346229, 10455.634052808191, 10466.84299735497, 10470.42412667303, 10479.161667066692, 10514.842277365846, 4225.852095176654, 4286.164197981364, 4353.608175264241, 4373.715708478939, 4379.934300985487, 8879.467231966102, 8916.06381329964, 8923.196912277795, 8932.776680583038, 8958.68644597436, 4639.8144074237325, 4655.255159174516, 4665.743384113906, 4665.766711664403, 4668.11305851887, 3674.7243956703355, 4109.671226301889, 4219.894502637398, 4225.68307376948, 4227.704060715781, 3585.15748799032, 3622.1487950331652, 3632.1282892105705, 3642.745007849478, 3691.427828686558, 1212.8120141378101, 1231.6243545718462, 1235.4872727817856, 1238.0652607281445, 1255.6986323282347, 906.4334790755778, 947.6114792935001, 1161.0, 1179.7817403780327, 1187.1927089578996, 7062.611556364346, 7089.964550177217, 7092.078029856086, 7105.111861017373, 7115.964420177866, 1028.804527139841, 1058.9470526473644, 1067.6636859389268, 1078.7087486378634, 1080.1574771678104, 5547.362053363915, 5603.691796951207, 5607.186957891083, 5659.292588426447, 5669.177969194526, 8983.865242021375, 9580.66467673628, 9694.17599504036, 9711.66009189675, 9762.121409073217, 9307.953460232655, 9458.810823783624, 9465.479398633004, 9506.429614223169, 9525.618975241052, 7150.7497237596435, 7343.1555371131935, 7348.265173482716, 7399.889001664979, 7435.1821299656995, 6860.4168645663685, 6953.826154346182, 7009.1589009319205, 7017.578945263301, 7029.0862187915245, 8342.916570834213, 8468.237858592756, 8512.40413171072, 8606.182412670787, 8608.569571521524, 8577.95711021441, 8686.565671716262, 8781.824363512822, 8797.736067917973, 8828.073052329413, 5660.971695141663, 5935.109733540004, 6089.1779609753885, 6347.746090156526, 6413.35866413355, 7183.640817958976, 7211.8557628848175, 7230.204677485367, 7254.6735396908325, 7269.382102521134, 6277.529185311211, 6441.1626488556185, 6470.547061705635, 6499.252585952676, 6570.11303474044, 6281.937180628135, 6331.968340158454, 6512.609243445219, 6556.901646475211, 6628.370304821035, 6729.1924969002075, 6860.794176174722, 6880.518363714692, 6902.689378977858, 6922.169339679271, 6131.325554188947, 6290.937090629035, 6300.936990630218, 6447.2263328400895, 6499.0, 6382.393672601095, 6407.871842563216, 6418.518611104279, 6430.131932189094, 6462.903056454251], "unit": "score", "name": "mootools.html", "value": 4395.377844356312}, {"lowerIsBetter": false, "replicates": [312.67481818908334, 318.3299155278141, 318.43477826857327, 325.1513549635451, 332.1960854731549, 5269.73651317434, 5417.756200970956, 5432.158015507598, 5432.483914028171, 5491.945080549193, 5339.439358867321, 5347.572194224463, 5349.197620356948, 5357.705326207057, 5363.865903352408, 4005.5193376794828, 4067.2272268268935, 4170.145120250357, 4194.5805419457965, 4210.221109094819, 4163.500379954395, 4182.477190351206, 4184.686148538856, 4185.246655601991, 4186.623203911648, 4140.254754144253, 4154.854580089697, 4155.729877557964, 4156.127213285214, 4166.375043743433, 3995.4606128172613, 4085.2850751118585, 4183.853565125206, 4191.559886211965, 4200.873973780792, 3703.611120832301, 3704.1665625234377, 3709.091272638194, 3714.7771133731794, 3723.0320116769562, 5042.193249080129, 5046.7224302663335, 5059.114654935408, 5061.721605311706, 5065.822696205615, 4816.710997340171, 4819.44576373718, 4823.20417131173, 4832.130216561018, 4833.226683730586, 5611.298587676541, 5616.550675945955, 5619.241402410704, 5622.550195984311, 5644.802431914904, 4066.8983275418054, 4068.572799856032, 4075.0831063010587, 4076.8980775480554, 4077.755334679899, 5678.886422271573, 5885.117232415172, 5887.705614719247, 5890.528757699374, 5891.145783861359, 3950.9209815804097, 3970.0273433009097, 3973.1259122992897, 3973.2252210819192, 3975.105601239698, 4012.799360031987, 4016.658584020391, 4018.0758425562285, 4019.8392064317686, 4022.4368588397647, 4657.022025374641, 4658.254679251304, 4661.813527458931, 4666.300054991779, 4669.229577119737, 5652.378238393773, 5652.547796176296, 5654.660720356792, 5658.151277308354, 5666.206731057655, 1427.3719563392074, 1450.5430789301336, 1451.5137428961416, 1453.0119518727367, 1454.120257244373, 903.2457897655399, 952.3048174832411, 952.6046690623452, 977.3891317926297, 979.4123525884555, 4876.366072410635, 4900.803967841318, 4919.729414882144, 4929.408470983505, 4930.087933732271, 5796.768129274866, 5801.332846722681, 5801.593888427854, 5806.738696758656, 5818.796342128006, 4893.363862697897, 4909.70541767488, 4912.6561140719805, 4918.1393256180745, 4918.778654960535, 3084.383123375334, 3107.0678796361003, 3130.765192610563, 3134.514150306706, 3136.54520094585, 5488.286522752097, 5501.889962200734, 5502.2296878437055, 5504.504594586507, 5507.504324610804, 5774.769009239583, 6007.429294217042, 6016.338202797689, 6029.065494848305, 6036.0, 5444.618876678674, 5460.5085542301385, 5486.286782718221, 5491.780328786884, 5497.615166938276, 5780.739866705924, 5786.392428794916, 5787.884242315215, 5790.276215473066, 5799.159121927381, 5646.971765141148, 5670.234518339971, 5670.971645141748, 5679.630823996592, 5680.7443665036, 5436.211749296409, 5460.945390546202, 5471.945280547303, 5482.917756233739, 5482.917756233739, 3943.802809859553, 4041.9797901010306, 4057.5739547348285, 4061.6750659947725, 4064.837406503825, 5721.370649228665, 5724.8282551523525, 5727.284089488814, 5761.625494342854, 5766.336871259691, 5560.471755183251, 5580.079286917613, 5580.190872323409, 5581.330240371019, 5584.888302234014, 5579.0, 5584.190292407497, 5586.888262234651, 5587.385387607441, 5589.580781441489, 5346.732663366738, 5477.616566840283, 5492.1212605982855, 5493.6978466183145, 5499.065158922913, 5609.747561359667, 5610.747516361856, 5612.85967850807, 5616.326040875121, 5622.634528755618, 5465.59008074388, 5486.423925487926, 5490.478404551562, 5494.945050549443, 5498.615096943176], "unit": "score", "name": "prototype.html", "value": 4222.871821868506}, {"lowerIsBetter": false, "replicates": [611.6146827498676, 739.7115125101211, 746.4774657739583, 761.0486891385764, 765.5674543882706, 11956.282623042613, 12079.335636539987, 12128.332941688204, 12129.818052729217, 12173.269603823777, 11653.0, 11667.708307292321, 11667.941660291708, 11722.7655446891, 11745.119116066286, 647.58230941043, 660.5607271164694, 660.8546119853648, 661.3683931845077, 803.0483876606211, 811.4238890387832, 814.8533264012475, 814.9429539932207, 816.073756286616, 816.4407380944043, 850.2560259772699, 856.7001549457672, 857.5583574459158, 858.0647094666812, 858.3305022082785, 666.6866572710842, 824.2458150792019, 838.2162677896187, 842.6334544473143, 847.2967437027253, 624.9468795152372, 626.6522080245462, 627.9748810047593, 629.4743888852813, 629.6945981199115, 11232.21374503785, 11271.098312135091, 11288.266262692981, 11340.886591134065, 11411.48648310828, 11824.172307938448, 12662.746745065138, 12764.87235127646, 13061.412236449383, 13156.736865262737, 9472.22896670647, 9645.951770241174, 9746.415215087047, 9792.265580081452, 9805.950970245174, 3304.074859039473, 3326.434506133963, 3331.5002749587516, 3432.2792213635166, 3462.272922686239, 41961.37057944103, 42038.0, 42226.0, 42999.785001075106, 43965.560344396465, 10057.0, 10105.908000219462, 10225.079742823033, 10372.844407333896, 10515.0, 16415.343386264416, 16453.58866028335, 16456.753148702777, 16457.835421645632, 16498.75251871223, 6706.497012724065, 6814.93185068143, 6861.759838405632, 6865.27914568973, 7003.404710599554, 3777.206786574795, 3810.9618903810606, 3817.0, 3848.4804551385205, 3927.626875446885, 2778.6943436222, 2786.066667666314, 2816.9859150704524, 2864.4127953769425, 2865.7277558631895, 487.92193249079975, 510.24993259907876, 522.8222404382528, 526.1712802336335, 527.4646234072419, 509.2844553402475, 513.7071869034614, 546.0716781471515, 551.2007588995972, 639.1148259660404, 7892.565908874953, 7967.601619918981, 8237.46456480327, 8250.0, 8300.626471808782, 510.6042816816922, 592.2537602620729, 630.7886857902562, 636.1983900285674, 639.6418005916702, 3845.538535375717, 3946.6842652587725, 3949.111449923744, 3989.2023081304983, 4069.8575549855614, 50792.0, 51357.22964155541, 51399.22901156486, 51573.48426515762, 51623.0, 44135.77932110319, 44886.77556612196, 44943.32585011228, 44968.77515612401, 45432.3185152223, 40571.391429128584, 40926.38610420846, 41358.79320603378, 41506.79246603748, 41815.37276940848, 7740.535567865946, 7816.452848300564, 7873.212678732081, 7965.601719913865, 8003.079645840803, 31860.681393185772, 32112.518312225802, 32547.34905301928, 32678.934765111444, 33241.0, 38522.22955540817, 38547.614523855525, 40980.79509602433, 41699.7915010423, 41699.7915010423, 9558.856617150888, 9663.178629816544, 9676.576829634974, 9692.85460718104, 9837.458939758382, 10485.737856553647, 10552.78894422092, 10554.208434367607, 10567.63013294531, 10657.893421066, 8669.566521673765, 10369.118624916966, 11438.771224575295, 11565.479553420284, 11598.2461140029, 10934.671959841218, 11235.438228088726, 11263.436828158396, 11398.316101033965, 11414.714632134263, 11093.33439993603, 11116.0, 11172.106231501622, 11187.216894817284, 11405.54377824911, 9621.56702948383, 9715.174210192214, 9846.60613575449, 9925.702228933143, 10089.596416143566, 9715.514224288898, 10075.848862266925, 10115.949420252851, 10122.44326562046, 10129.493525323851], "unit": "score", "name": "yui.html", "value": 5867.425040285184}], "name": "dromaeo_css", "value": 6331.363007632135}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 114.0, 106.0, 114.0, 111.0, 112.0, 99.0, 112.0, 111.0, 113.0], "unit": "score", "name": "ai-astar", "value": 110.2}, {"lowerIsBetter": true, "replicates": [162.0, 132.0, 162.0, 177.0, 133.0, 166.0, 172.0, 133.0, 175.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 154.7}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 162.0, 163.0, 162.0, 162.0, 162.0, 164.0, 161.0, 163.0], "unit": "score", "name": "audio-dft", "value": 162.3}, {"lowerIsBetter": true, "replicates": [77.0, 74.0, 102.0, 99.0, 77.0, 74.0, 75.0, 129.0, 100.0, 79.0], "unit": "score", "name": "audio-fft", "value": 88.6}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 136.0, 94.0, 95.0, 95.0, 147.0, 95.0, 95.0, 153.0], "unit": "score", "name": "audio-oscillator", "value": 109.9}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 118.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "unit": "score", "name": "imaging-desaturate", "value": 95.0}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 65.0, 74.0, 62.0, 74.0], "unit": "score", "name": "json-parse-financial", "value": 65.9}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 63.0, 63.0, 63.0, 66.0, 64.0, 74.0, 67.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.1}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 83.0, 82.0, 90.0, 81.0, 82.0, 82.0, 81.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.9}, {"lowerIsBetter": true, "replicates": [125.0, 117.0, 117.0, 115.0, 116.0, 119.0, 120.0, 124.0, 117.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.5}, {"lowerIsBetter": true, "replicates": [141.0, 151.0, 140.0, 140.0, 141.0, 129.0, 141.0, 146.0, 144.0, 156.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.9}, {"lowerIsBetter": true, "replicates": [71.0, 68.0, 70.0, 68.0, 68.0, 67.0, 68.0, 70.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1526.5}]} 15:15:05 INFO - Return code: 0 15:15:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:15:05 ERROR - # TBPL SUCCESS # 15:15:05 INFO - Running post-action listener: _resource_record_post_action 15:15:05 INFO - Running post-run listener: _resource_record_post_run 15:15:06 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 520511488; Read time: 0; Write time: 672200 15:15:06 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 228151296; Read time: 0; Write time: 362336 15:15:06 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 287232000; Read time: 0; Write time: 308908 15:15:06 INFO - Running post-run listener: _upload_blobber_files 15:15:06 INFO - Blob upload gear active. 15:15:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:15:06 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 15:15:06 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'] 15:15:06 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 15:15:07 INFO - (blobuploader) - INFO - Open directory for files ... 15:15:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:15:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:15:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:15:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:15:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:15:07 INFO - (blobuploader) - INFO - Done attempting. 15:15:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:15:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:15:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:15:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:15:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:15:08 INFO - (blobuploader) - INFO - Done attempting. 15:15:08 INFO - (blobuploader) - INFO - Iteration through files over. 15:15:08 INFO - Return code: 0 15:15:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:15:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:15:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ecad92ae8c7b7d90e4f0fbe8cb6d54df7f3cff2b6ca440cb7c271ce5e6410a8ecddb9bd2273483d26bf24626478f9960a9528c13bf89b864492b11dacde6dcdb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6da3647ec3d854b0dc4574e8961d9e76b03f2d5da1d4502feb6a650e4b7c76751b4f456b9f5ccaa1703f2e5c8ab95373c9cf5ff9c0152b34f93a939ff9353e96"} 15:15:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:15:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:15:08 INFO - Contents: 15:15:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ecad92ae8c7b7d90e4f0fbe8cb6d54df7f3cff2b6ca440cb7c271ce5e6410a8ecddb9bd2273483d26bf24626478f9960a9528c13bf89b864492b11dacde6dcdb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6da3647ec3d854b0dc4574e8961d9e76b03f2d5da1d4502feb6a650e4b7c76751b4f456b9f5ccaa1703f2e5c8ab95373c9cf5ff9c0152b34f93a939ff9353e96"} 15:15:08 INFO - Running post-run listener: copy_logs_to_upload_dir 15:15:08 INFO - Copying logs to upload dir... 15:15:08 INFO - mkdir: /builds/slave/test/build/upload/logs 15:15:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.153883 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-04-01 15:15:08.738108) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-01 15:15:08.744125) ========= 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=62c568580acbfdaac3eec7be000001dc-1459546268.50556-728832269 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ecad92ae8c7b7d90e4f0fbe8cb6d54df7f3cff2b6ca440cb7c271ce5e6410a8ecddb9bd2273483d26bf24626478f9960a9528c13bf89b864492b11dacde6dcdb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6da3647ec3d854b0dc4574e8961d9e76b03f2d5da1d4502feb6a650e4b7c76751b4f456b9f5ccaa1703f2e5c8ab95373c9cf5ff9c0152b34f93a939ff9353e96"} build_url:https://queue.taskcluster.net/v1/task/GPfgLUCbQ0KvOQxN-3zOKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011299 build_url: 'https://queue.taskcluster.net/v1/task/GPfgLUCbQ0KvOQxN-3zOKQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ecad92ae8c7b7d90e4f0fbe8cb6d54df7f3cff2b6ca440cb7c271ce5e6410a8ecddb9bd2273483d26bf24626478f9960a9528c13bf89b864492b11dacde6dcdb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6da3647ec3d854b0dc4574e8961d9e76b03f2d5da1d4502feb6a650e4b7c76751b4f456b9f5ccaa1703f2e5c8ab95373c9cf5ff9c0152b34f93a939ff9353e96"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-01 15:15:08.774225) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 15:15:08.774961) ========= 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=62c568580acbfdaac3eec7be000001dc-1459546268.50556-728832269 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004496 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 15:15:08.856710) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-01 15:15:08.857458) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-01 15:15:08.857891) ========= ========= Total master_lag: 0.31 =========