builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-014 starttime: 1450354837.63 results: success (0) buildid: 20151217025634 builduid: e98b2a625d024ee8b13bd91b84b209e6 revision: 77ab820ce477438af4b32cea83f82fd55744cec7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 04:20:37.626757) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 04:20:37.627216) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 04:20:37.627497) ========= 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=01deea79d00cc2c334834894000001d2-1450352449.235700-1628821057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006370 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 04:20:37.656670) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 04:20:37.656942) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 04:20:37.697727) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 04:20:37.698002) ========= 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=01deea79d00cc2c334834894000001d2-1450352449.235700-1628821057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004660 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 04:20:37.753413) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 04:20:37.753721) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 04:20:37.754097) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 04:20:37.754378) ========= 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=01deea79d00cc2c334834894000001d2-1450352449.235700-1628821057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-17 04:20:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.7M=0s 2015-12-17 04:20:38 (43.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.180912 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 04:20:37.962751) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 04:20:37.963036) ========= 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=01deea79d00cc2c334834894000001d2-1450352449.235700-1628821057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014288 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 04:20:38.030464) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-17 04:20:38.030808) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 77ab820ce477438af4b32cea83f82fd55744cec7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 77ab820ce477438af4b32cea83f82fd55744cec7 --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=01deea79d00cc2c334834894000001d2-1450352449.235700-1628821057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-17 04:20:38,393 truncating revision to first 12 chars 2015-12-17 04:20:38,393 Setting DEBUG logging. 2015-12-17 04:20:38,393 attempt 1/10 2015-12-17 04:20:38,393 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/77ab820ce477?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-17 04:20:39,344 unpacking tar archive at: mozilla-central-77ab820ce477/testing/mozharness/ program finished with exit code 0 elapsedTime=1.205978 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-17 04:20:39.253178) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 04:20:39.253481) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 04:20:39.260863) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 04:20:39.261123) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 04:20:39.261498) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-17 04:20:39.261777) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=01deea79d00cc2c334834894000001d2-1450352449.235700-1628821057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:20:39 INFO - MultiFileLogger online at 20151217 04:20:39 in /builds/slave/test 04:20:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:20:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:20:39 INFO - {'append_to_log': False, 04:20:39 INFO - 'base_work_dir': '/builds/slave/test', 04:20:39 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:20:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:20:39 INFO - 'branch': 'Firefox-Non-PGO', 04:20:39 INFO - 'buildbot_json_path': 'buildprops.json', 04:20:39 INFO - 'config_files': ('talos/linux_config.py',), 04:20:39 INFO - 'default_actions': ('clobber', 04:20:39 INFO - 'read-buildbot-config', 04:20:39 INFO - 'download-and-extract', 04:20:39 INFO - 'populate-webroot', 04:20:39 INFO - 'create-virtualenv', 04:20:39 INFO - 'install', 04:20:39 INFO - 'run-tests'), 04:20:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:20:39 INFO - 'download_minidump_stackwalk': True, 04:20:39 INFO - 'download_symbols': 'ondemand', 04:20:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:20:39 INFO - 'tooltool.py': '/tools/tooltool.py', 04:20:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:20:39 INFO - '/tools/misc-python/virtualenv.py')}, 04:20:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:20:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:20:39 INFO - 'installer_path': 'installer.exe', 04:20:39 INFO - 'log_level': 'info', 04:20:39 INFO - 'log_name': 'talos', 04:20:39 INFO - 'log_to_console': True, 04:20:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:20:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:20:39 INFO - 'opt_config_files': (), 04:20:39 INFO - 'pip_index': False, 04:20:39 INFO - 'sps_profile': False, 04:20:39 INFO - 'sps_profile_interval': 0, 04:20:39 INFO - 'suite': 'dromaeojs-e10s', 04:20:39 INFO - 'system_bits': '64', 04:20:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:20:39 INFO - 'title': 'talos-linux64-ix-014', 04:20:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:20:39 INFO - 'use_talos_json': True, 04:20:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:20:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:20:39 INFO - 'work_dir': 'build'} 04:20:39 INFO - ##### 04:20:39 INFO - ##### Running clobber step. 04:20:39 INFO - ##### 04:20:39 INFO - Running pre-action listener: _resource_record_pre_action 04:20:39 INFO - Running main action method: clobber 04:20:39 INFO - rmtree: /builds/slave/test/build 04:20:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:20:40 INFO - Running post-action listener: _resource_record_post_action 04:20:40 INFO - ##### 04:20:40 INFO - ##### Running read-buildbot-config step. 04:20:40 INFO - ##### 04:20:40 INFO - Running pre-action listener: _resource_record_pre_action 04:20:40 INFO - Running main action method: read_buildbot_config 04:20:40 INFO - Using buildbot properties: 04:20:40 INFO - { 04:20:40 INFO - "properties": { 04:20:40 INFO - "buildnumber": 177, 04:20:40 INFO - "product": "firefox", 04:20:40 INFO - "script_repo_revision": "production", 04:20:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:20:40 INFO - "repository": "", 04:20:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:20:40 INFO - "buildid": "20151217025634", 04:20:40 INFO - "slavename": "talos-linux64-ix-014", 04:20:40 INFO - "pgo_build": "False", 04:20:40 INFO - "basedir": "/builds/slave/test", 04:20:40 INFO - "project": "", 04:20:40 INFO - "platform": "ubuntu64_hw", 04:20:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:20:40 INFO - "slavebuilddir": "test", 04:20:40 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:20:40 INFO - "branch": "mozilla-central", 04:20:40 INFO - "repo_path": "mozilla-central", 04:20:40 INFO - "stage_platform": "linux64", 04:20:40 INFO - "builduid": "e98b2a625d024ee8b13bd91b84b209e6", 04:20:40 INFO - "revision": "77ab820ce477438af4b32cea83f82fd55744cec7" 04:20:40 INFO - }, 04:20:40 INFO - "sourcestamp": { 04:20:40 INFO - "repository": "", 04:20:40 INFO - "hasPatch": false, 04:20:40 INFO - "project": "", 04:20:40 INFO - "branch": "mozilla-central-linux64-talos", 04:20:40 INFO - "changes": [ 04:20:40 INFO - { 04:20:40 INFO - "category": null, 04:20:40 INFO - "files": [ 04:20:40 INFO - { 04:20:40 INFO - "url": null, 04:20:40 INFO - "name": "https://queue.taskcluster.net/v1/task/50imxasqTTO73CsoI4Gd_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 04:20:40 INFO - } 04:20:40 INFO - ], 04:20:40 INFO - "repository": "", 04:20:40 INFO - "rev": "77ab820ce477438af4b32cea83f82fd55744cec7", 04:20:40 INFO - "who": "cbook@mozilla.com", 04:20:40 INFO - "when": 1450354829, 04:20:40 INFO - "number": 7371378, 04:20:40 INFO - "comments": "Bug 1200928 - Part 2: [Taskcluster] Use correct busybox binary for x86/arm emulator when running xpcshell tests. r=garndt", 04:20:40 INFO - "project": "", 04:20:40 INFO - "at": "Thu 17 Dec 2015 04:20:29", 04:20:40 INFO - "branch": "mozilla-central-linux64-talos", 04:20:40 INFO - "revlink": "", 04:20:40 INFO - "properties": [ 04:20:40 INFO - [ 04:20:40 INFO - "buildid", 04:20:40 INFO - "20151217025634", 04:20:40 INFO - "Change" 04:20:40 INFO - ], 04:20:40 INFO - [ 04:20:40 INFO - "builduid", 04:20:40 INFO - "e98b2a625d024ee8b13bd91b84b209e6", 04:20:40 INFO - "Change" 04:20:40 INFO - ], 04:20:40 INFO - [ 04:20:40 INFO - "pgo_build", 04:20:40 INFO - "False", 04:20:40 INFO - "Change" 04:20:40 INFO - ] 04:20:40 INFO - ], 04:20:40 INFO - "revision": "77ab820ce477438af4b32cea83f82fd55744cec7" 04:20:40 INFO - } 04:20:40 INFO - ], 04:20:40 INFO - "revision": "77ab820ce477438af4b32cea83f82fd55744cec7" 04:20:40 INFO - } 04:20:40 INFO - } 04:20:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/50imxasqTTO73CsoI4Gd_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:20:40 INFO - Running post-action listener: _resource_record_post_action 04:20:40 INFO - ##### 04:20:40 INFO - ##### Running download-and-extract step. 04:20:40 INFO - ##### 04:20:40 INFO - Running pre-action listener: _resource_record_pre_action 04:20:40 INFO - Running main action method: download_and_extract 04:20:40 INFO - mkdir: /builds/slave/test/build/tests 04:20:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:40 INFO - https://queue.taskcluster.net/v1/task/50imxasqTTO73CsoI4Gd_g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:20:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/50imxasqTTO73CsoI4Gd_g/artifacts/public/build/test_packages.json 04:20:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/50imxasqTTO73CsoI4Gd_g/artifacts/public/build/test_packages.json 04:20:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/50imxasqTTO73CsoI4Gd_g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:20:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/50imxasqTTO73CsoI4Gd_g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:20:42 INFO - Downloaded 1302 bytes. 04:20:42 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:20:42 INFO - Using the following test package requirements: 04:20:42 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:20:42 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:20:42 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:42 INFO - u'jsshell-linux-x86_64.zip'], 04:20:42 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:20:42 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:20:42 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:20:42 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:20:42 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:20:42 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:20:42 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:20:42 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:20:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:42 INFO - https://queue.taskcluster.net/v1/task/50imxasqTTO73CsoI4Gd_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:20:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/50imxasqTTO73CsoI4Gd_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:20:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/50imxasqTTO73CsoI4Gd_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:20:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/50imxasqTTO73CsoI4Gd_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:20:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/50imxasqTTO73CsoI4Gd_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:20:43 INFO - Downloaded 21868914 bytes. 04:20:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:20:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:20:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:20:44 INFO - Return code: 0 04:20:44 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:20:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:44 INFO - https://queue.taskcluster.net/v1/task/50imxasqTTO73CsoI4Gd_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:20:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/50imxasqTTO73CsoI4Gd_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:20:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/50imxasqTTO73CsoI4Gd_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:20:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/50imxasqTTO73CsoI4Gd_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:20:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/50imxasqTTO73CsoI4Gd_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:20:47 INFO - Downloaded 21868914 bytes. 04:20:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:20:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:20:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:20:48 INFO - Return code: 0 04:20:48 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')]} 04:20:48 INFO - https://queue.taskcluster.net/v1/task/50imxasqTTO73CsoI4Gd_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:20:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/50imxasqTTO73CsoI4Gd_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:20:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/50imxasqTTO73CsoI4Gd_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:20:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/50imxasqTTO73CsoI4Gd_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:20:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/50imxasqTTO73CsoI4Gd_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:20:49 INFO - Downloaded 11132052 bytes. 04:20:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 04:20:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:20:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 04:20:49 INFO - Return code: 0 04:20: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')]} 04:20:49 INFO - https://queue.taskcluster.net/v1/task/50imxasqTTO73CsoI4Gd_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:20:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/50imxasqTTO73CsoI4Gd_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:20:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/50imxasqTTO73CsoI4Gd_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:20:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/50imxasqTTO73CsoI4Gd_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:20:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/50imxasqTTO73CsoI4Gd_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:20:50 INFO - Downloaded 57741130 bytes. 04:20:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/50imxasqTTO73CsoI4Gd_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:20:50 INFO - mkdir: /builds/slave/test/properties 04:20:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:20:50 INFO - Writing to file /builds/slave/test/properties/build_url 04:20:50 INFO - Contents: 04:20:50 INFO - build_url:https://queue.taskcluster.net/v1/task/50imxasqTTO73CsoI4Gd_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:20:50 INFO - Running post-action listener: _resource_record_post_action 04:20:50 INFO - Running post-action listener: set_extra_try_arguments 04:20:50 INFO - ##### 04:20:50 INFO - ##### Running populate-webroot step. 04:20:50 INFO - ##### 04:20:50 INFO - Running pre-action listener: _resource_record_pre_action 04:20:50 INFO - Running main action method: populate_webroot 04:20:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:20:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:20:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:20:50 INFO - '--tppagecycles', 04:20:50 INFO - '7'], 04:20:50 INFO - 'tests': ['tsvgm']}}, 04:20:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:20:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:20:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:20:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:20:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:20:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:20:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:20:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:50 INFO - 'talos_options': ['--e10s'], 04:20:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:20:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:50 INFO - 'tests': ['damp', 'tps']}, 04:20:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:50 INFO - 'talos_options': ['--e10s'], 04:20:50 INFO - 'tests': ['damp', 'tps']}, 04:20:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:20:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:20:50 INFO - 'other': {'tests': ['a11yr', 04:20:50 INFO - 'ts_paint', 04:20:50 INFO - 'tpaint', 04:20:50 INFO - 'sessionrestore', 04:20:50 INFO - 'sessionrestore_no_auto_restore']}, 04:20:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:20:50 INFO - 'tests': ['a11yr', 04:20:50 INFO - 'ts_paint', 04:20:50 INFO - 'tpaint', 04:20:50 INFO - 'sessionrestore', 04:20:50 INFO - 'sessionrestore_no_auto_restore']}, 04:20:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:20:50 INFO - 'tests': ['a11yr', 04:20:50 INFO - 'ts_paint', 04:20:50 INFO - 'tpaint', 04:20:50 INFO - 'sessionrestore', 04:20:50 INFO - 'sessionrestore_no_auto_restore']}, 04:20:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:20:50 INFO - 'tests': ['a11yr', 04:20:50 INFO - 'ts_paint', 04:20:50 INFO - 'tpaint', 04:20:50 INFO - 'sessionrestore', 04:20:50 INFO - 'sessionrestore_no_auto_restore']}, 04:20:50 INFO - 'other_l64': {'tests': ['a11yr', 04:20:50 INFO - 'ts_paint', 04:20:50 INFO - 'tpaint', 04:20:50 INFO - 'sessionrestore', 04:20:50 INFO - 'sessionrestore_no_auto_restore']}, 04:20:50 INFO - 'other_nol64': {'tests': ['a11yr', 04:20:50 INFO - 'ts_paint', 04:20:50 INFO - 'tpaint', 04:20:50 INFO - 'sessionrestore', 04:20:50 INFO - 'sessionrestore_no_auto_restore']}, 04:20:50 INFO - 'svgr': {'tests': ['tsvgx', 04:20:50 INFO - 'tsvgr_opacity', 04:20:50 INFO - 'tart', 04:20:50 INFO - 'tscrollx', 04:20:50 INFO - 'cart']}, 04:20:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:20:50 INFO - 'tests': ['tsvgx', 04:20:50 INFO - 'tsvgr_opacity', 04:20:50 INFO - 'tart', 04:20:50 INFO - 'tscrollx', 04:20:50 INFO - 'cart']}, 04:20:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:50 INFO - 'tests': ['tp5o']}, 04:20:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:50 INFO - 'talos_options': ['--e10s'], 04:20:50 INFO - 'tests': ['tp5o']}, 04:20:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:50 INFO - 'talos_options': ['--xperf_path', 04:20:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:20:50 INFO - 'tests': ['tp5n']}, 04:20:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:50 INFO - 'talos_options': ['--e10s', 04:20:50 INFO - '--xperf_path', 04:20:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:20:50 INFO - 'tests': ['tp5n']}}, 04:20:50 INFO - 'talos.zip': {'path': '', 04:20:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:20:50 INFO - Running post-action listener: _resource_record_post_action 04:20:50 INFO - ##### 04:20:50 INFO - ##### Running create-virtualenv step. 04:20:50 INFO - ##### 04:20:50 INFO - Running pre-action listener: _resource_record_pre_action 04:20:50 INFO - Running main action method: create_virtualenv 04:20:50 INFO - Creating virtualenv /builds/slave/test/build/venv 04:20:50 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 04:20:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:20:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:20:50 INFO - Using real prefix '/usr' 04:20:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:20:51 INFO - Installing distribute.............................................................................................................................................................................................done. 04:20:53 INFO - Installing pip.................done. 04:20:53 INFO - Return code: 0 04:20:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:20:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f755042ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1605240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16940b0>, '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 0x1694fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1695440>, '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': '01deea79d00cc2c334834894000001d2-1450352449.235700-1628821057', '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 04:20:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 04:20:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 04:20:53 INFO - Using env: {'DISPLAY': ':0', 04:20:53 INFO - 'HOME': '/home/cltbld', 04:20:53 INFO - 'LANG': 'en_US.UTF-8', 04:20:53 INFO - 'LANGUAGE': 'en_US:en', 04:20:53 INFO - 'LOGNAME': 'cltbld', 04:20:53 INFO - 'MAIL': '/var/mail/cltbld', 04:20:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:53 INFO - 'MOZ_NO_REMOTE': '1', 04:20:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:53 INFO - 'NO_EM_RESTART': '1', 04:20:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:53 INFO - 'PWD': '/builds/slave/test', 04:20:53 INFO - 'SHELL': '/bin/bash', 04:20:53 INFO - 'SHLVL': '1', 04:20:53 INFO - 'TERM': 'linux', 04:20:53 INFO - 'TMOUT': '86400', 04:20:53 INFO - 'USER': 'cltbld', 04:20:53 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450352449.235700-1628821057', 04:20:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:53 INFO - '_': '/tools/buildbot/bin/python'} 04:20:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:53 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 04:20:53 INFO - Cleaning up... 04:20:53 INFO - Return code: 0 04:20:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:20:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f755042ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1605240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16940b0>, '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 0x1694fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1695440>, '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': '01deea79d00cc2c334834894000001d2-1450352449.235700-1628821057', '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 04:20:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 04:20:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 04:20:53 INFO - Using env: {'DISPLAY': ':0', 04:20:53 INFO - 'HOME': '/home/cltbld', 04:20:53 INFO - 'LANG': 'en_US.UTF-8', 04:20:53 INFO - 'LANGUAGE': 'en_US:en', 04:20:53 INFO - 'LOGNAME': 'cltbld', 04:20:53 INFO - 'MAIL': '/var/mail/cltbld', 04:20:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:53 INFO - 'MOZ_NO_REMOTE': '1', 04:20:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:53 INFO - 'NO_EM_RESTART': '1', 04:20:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:53 INFO - 'PWD': '/builds/slave/test', 04:20:53 INFO - 'SHELL': '/bin/bash', 04:20:53 INFO - 'SHLVL': '1', 04:20:53 INFO - 'TERM': 'linux', 04:20:53 INFO - 'TMOUT': '86400', 04:20:53 INFO - 'USER': 'cltbld', 04:20:53 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450352449.235700-1628821057', 04:20:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:53 INFO - '_': '/tools/buildbot/bin/python'} 04:20:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:53 INFO - Downloading/unpacking psutil>=0.7.1 04:20: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 04:20: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 04:20: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 04:20: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 04:20: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 04:20: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 04:20:55 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:20:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:20:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:20:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:20:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:20:55 INFO - Installing collected packages: psutil 04:20:55 INFO - Running setup.py install for psutil 04:20:55 INFO - building 'psutil._psutil_linux' extension 04:20:55 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 04:20:55 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 04:20:55 INFO - building 'psutil._psutil_posix' extension 04:20:55 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 04:20:56 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 04:20:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:20:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:20:56 INFO - Successfully installed psutil 04:20:56 INFO - Cleaning up... 04:20:56 INFO - Return code: 0 04:20:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:20:56 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')]} 04:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:56 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')]} 04:20:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f755042ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1605240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16940b0>, '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 0x1694fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1695440>, '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': '01deea79d00cc2c334834894000001d2-1450352449.235700-1628821057', '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 04:20:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 04:20:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 04:20:56 INFO - Using env: {'DISPLAY': ':0', 04:20:56 INFO - 'HOME': '/home/cltbld', 04:20:56 INFO - 'LANG': 'en_US.UTF-8', 04:20:56 INFO - 'LANGUAGE': 'en_US:en', 04:20:56 INFO - 'LOGNAME': 'cltbld', 04:20:56 INFO - 'MAIL': '/var/mail/cltbld', 04:20:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:56 INFO - 'MOZ_NO_REMOTE': '1', 04:20:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:56 INFO - 'NO_EM_RESTART': '1', 04:20:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:56 INFO - 'PWD': '/builds/slave/test', 04:20:56 INFO - 'SHELL': '/bin/bash', 04:20:56 INFO - 'SHLVL': '1', 04:20:56 INFO - 'TERM': 'linux', 04:20:56 INFO - 'TMOUT': '86400', 04:20:56 INFO - 'USER': 'cltbld', 04:20:56 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450352449.235700-1628821057', 04:20:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:56 INFO - '_': '/tools/buildbot/bin/python'} 04:20:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:20:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:20:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:20:58 INFO - Installing collected packages: mozsystemmonitor 04:20:58 INFO - Running setup.py install for mozsystemmonitor 04:20:58 INFO - Successfully installed mozsystemmonitor 04:20:58 INFO - Cleaning up... 04:20:58 INFO - Return code: 0 04:20:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:20: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')]} 04:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20: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')]} 04:20:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f755042ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1605240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16940b0>, '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 0x1694fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1695440>, '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': '01deea79d00cc2c334834894000001d2-1450352449.235700-1628821057', '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 04:20:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 04:20:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 04:20:58 INFO - Using env: {'DISPLAY': ':0', 04:20:58 INFO - 'HOME': '/home/cltbld', 04:20:58 INFO - 'LANG': 'en_US.UTF-8', 04:20:58 INFO - 'LANGUAGE': 'en_US:en', 04:20:58 INFO - 'LOGNAME': 'cltbld', 04:20:58 INFO - 'MAIL': '/var/mail/cltbld', 04:20:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:58 INFO - 'MOZ_NO_REMOTE': '1', 04:20:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:58 INFO - 'NO_EM_RESTART': '1', 04:20:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:58 INFO - 'PWD': '/builds/slave/test', 04:20:58 INFO - 'SHELL': '/bin/bash', 04:20:58 INFO - 'SHLVL': '1', 04:20:58 INFO - 'TERM': 'linux', 04:20:58 INFO - 'TMOUT': '86400', 04:20:58 INFO - 'USER': 'cltbld', 04:20:58 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450352449.235700-1628821057', 04:20:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:58 INFO - '_': '/tools/buildbot/bin/python'} 04:20:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:58 INFO - Downloading/unpacking blobuploader==1.2.4 04:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:00 INFO - Downloading blobuploader-1.2.4.tar.gz 04:21:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:21:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:21:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:21:00 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 04:21:00 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 04:21:00 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 04:21:00 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 04:21:00 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 04:21:00 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 04:21:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:21:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:21:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:21:00 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 04:21:00 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 04:21:00 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 04:21:00 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 04:21:00 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 04:21:00 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 04:21:00 INFO - Downloading docopt-0.6.1.tar.gz 04:21:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:21:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:21:00 INFO - Installing collected packages: blobuploader, requests, docopt 04:21:00 INFO - Running setup.py install for blobuploader 04:21:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:21:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:21:01 INFO - Running setup.py install for requests 04:21:01 INFO - Running setup.py install for docopt 04:21:01 INFO - Successfully installed blobuploader requests docopt 04:21:01 INFO - Cleaning up... 04:21:01 INFO - Return code: 0 04:21:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f755042ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1605240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16940b0>, '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 0x1694fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1695440>, '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': '01deea79d00cc2c334834894000001d2-1450352449.235700-1628821057', '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 04:21:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 04:21:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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 04:21:01 INFO - Using env: {'DISPLAY': ':0', 04:21:01 INFO - 'HOME': '/home/cltbld', 04:21:01 INFO - 'LANG': 'en_US.UTF-8', 04:21:01 INFO - 'LANGUAGE': 'en_US:en', 04:21:01 INFO - 'LOGNAME': 'cltbld', 04:21:01 INFO - 'MAIL': '/var/mail/cltbld', 04:21:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:01 INFO - 'MOZ_NO_REMOTE': '1', 04:21:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:01 INFO - 'NO_EM_RESTART': '1', 04:21:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:01 INFO - 'PWD': '/builds/slave/test', 04:21:01 INFO - 'SHELL': '/bin/bash', 04:21:01 INFO - 'SHLVL': '1', 04:21:01 INFO - 'TERM': 'linux', 04:21:01 INFO - 'TMOUT': '86400', 04:21:01 INFO - 'USER': 'cltbld', 04:21:01 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450352449.235700-1628821057', 04:21:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:01 INFO - '_': '/tools/buildbot/bin/python'} 04:21:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:21:01 INFO - Running setup.py (path:/tmp/pip-H16pe4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:21:01 INFO - Running setup.py (path:/tmp/pip-PWqtP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:21:01 INFO - Running setup.py (path:/tmp/pip-bxiq4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:21:01 INFO - Running setup.py (path:/tmp/pip-6YYrvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:21:02 INFO - Running setup.py (path:/tmp/pip-xBOVVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:21:02 INFO - Running setup.py (path:/tmp/pip-S2m0vi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:21:02 INFO - Running setup.py (path:/tmp/pip-IaXamq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:21:02 INFO - Running setup.py (path:/tmp/pip-abYZlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:21:02 INFO - Running setup.py (path:/tmp/pip-jAyiXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:21:02 INFO - Running setup.py (path:/tmp/pip-mklA_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:21:02 INFO - Running setup.py (path:/tmp/pip-LGk3Js-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:21:02 INFO - Running setup.py (path:/tmp/pip-wkmZJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:21:02 INFO - Running setup.py (path:/tmp/pip-l2GKdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:21:02 INFO - Running setup.py (path:/tmp/pip-A_QUA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:02 INFO - Running setup.py (path:/tmp/pip-g6ZazD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:21:02 INFO - Running setup.py (path:/tmp/pip-eqWSq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:21:02 INFO - Running setup.py (path:/tmp/pip-zAato0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:21:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:21:02 INFO - Running setup.py install for manifestparser 04:21:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:21:03 INFO - Running setup.py install for mozcrash 04:21:03 INFO - Running setup.py install for mozdebug 04:21:03 INFO - Running setup.py install for mozdevice 04:21:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:21:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:21:03 INFO - Running setup.py install for mozfile 04:21:03 INFO - Running setup.py install for mozhttpd 04:21:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:21:03 INFO - Running setup.py install for mozinfo 04:21:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:21:03 INFO - Running setup.py install for mozInstall 04:21:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:21:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:21:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:21:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:21:03 INFO - Running setup.py install for mozleak 04:21:03 INFO - Running setup.py install for mozlog 04:21:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:21:03 INFO - Running setup.py install for moznetwork 04:21:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:21:04 INFO - Running setup.py install for mozprocess 04:21:04 INFO - Running setup.py install for mozprofile 04:21:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:21:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:21:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:21:04 INFO - Running setup.py install for mozrunner 04:21:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:21:04 INFO - Running setup.py install for mozscreenshot 04:21:04 INFO - Running setup.py install for moztest 04:21:04 INFO - Running setup.py install for mozversion 04:21:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:21:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:21:04 INFO - Cleaning up... 04:21:04 INFO - Return code: 0 04:21:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21:04 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')]} 04:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:04 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')]} 04:21:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f755042ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1605240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16940b0>, '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 0x1694fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1695440>, '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': '01deea79d00cc2c334834894000001d2-1450352449.235700-1628821057', '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 04:21:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 04:21:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 04:21:04 INFO - Using env: {'DISPLAY': ':0', 04:21:04 INFO - 'HOME': '/home/cltbld', 04:21:04 INFO - 'LANG': 'en_US.UTF-8', 04:21:04 INFO - 'LANGUAGE': 'en_US:en', 04:21:04 INFO - 'LOGNAME': 'cltbld', 04:21:04 INFO - 'MAIL': '/var/mail/cltbld', 04:21:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:04 INFO - 'MOZ_NO_REMOTE': '1', 04:21:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:04 INFO - 'NO_EM_RESTART': '1', 04:21:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:04 INFO - 'PWD': '/builds/slave/test', 04:21:04 INFO - 'SHELL': '/bin/bash', 04:21:04 INFO - 'SHLVL': '1', 04:21:04 INFO - 'TERM': 'linux', 04:21:04 INFO - 'TMOUT': '86400', 04:21:04 INFO - 'USER': 'cltbld', 04:21:04 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450352449.235700-1628821057', 04:21:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:04 INFO - '_': '/tools/buildbot/bin/python'} 04:21:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:21:04 INFO - Running setup.py (path:/tmp/pip-pv9IE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:21:05 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)) 04:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:21:05 INFO - Running setup.py (path:/tmp/pip-6bKwDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 04:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:21:05 INFO - Running setup.py (path:/tmp/pip-QyPwRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:21:05 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)) 04:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:21:05 INFO - Running setup.py (path:/tmp/pip-zyxozB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 04:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:21:05 INFO - Running setup.py (path:/tmp/pip-Ri_gzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:21:05 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)) 04:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:21:05 INFO - Running setup.py (path:/tmp/pip-lM0rA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:21:05 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)) 04:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:21:05 INFO - Running setup.py (path:/tmp/pip-GmILRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:21:05 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)) 04:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:21:05 INFO - Running setup.py (path:/tmp/pip-L8ioc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:21:05 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)) 04:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:21:05 INFO - Running setup.py (path:/tmp/pip-fzY71Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:21:05 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)) 04:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:21:05 INFO - Running setup.py (path:/tmp/pip-kzpHlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:21:05 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)) 04:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:21:05 INFO - Running setup.py (path:/tmp/pip-aXnWC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:21:05 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)) 04:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:21:05 INFO - Running setup.py (path:/tmp/pip-HDe6Wm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:21:05 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)) 04:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:21:05 INFO - Running setup.py (path:/tmp/pip-3sJI5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 04:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:21:05 INFO - Running setup.py (path:/tmp/pip-LQkSDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:21:05 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)) 04:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:05 INFO - Running setup.py (path:/tmp/pip-NL_npB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:06 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)) 04:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:21:06 INFO - Running setup.py (path:/tmp/pip-4o8LUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:21:06 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)) 04:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:21:06 INFO - Running setup.py (path:/tmp/pip-ytLKOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:21:06 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)) 04:21:06 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:21:06 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:21:06 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)) 04:21:06 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:21:06 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:21:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:21:06 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 04:21:06 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 04:21:06 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 04:21:06 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 04:21:06 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 04:21:06 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 04:21:07 INFO - Downloading blessings-1.5.1.tar.gz 04:21:07 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 04:21:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:21:07 INFO - Installing collected packages: blessings 04:21:07 INFO - Running setup.py install for blessings 04:21:08 INFO - Successfully installed blessings 04:21:08 INFO - Cleaning up... 04:21:08 INFO - Return code: 0 04:21:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:21:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:21:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:21:08 INFO - Reading from file tmpfile_stdout 04:21:08 INFO - Current package versions: 04:21:08 INFO - argparse == 1.2.1 04:21:08 INFO - blessings == 1.5.1 04:21:08 INFO - blobuploader == 1.2.4 04:21:08 INFO - docopt == 0.6.1 04:21:08 INFO - manifestparser == 1.1 04:21:08 INFO - mozInstall == 1.12 04:21:08 INFO - mozcrash == 0.16 04:21:08 INFO - mozdebug == 0.1 04:21:08 INFO - mozdevice == 0.47 04:21:08 INFO - mozfile == 1.2 04:21:08 INFO - mozhttpd == 0.7 04:21:08 INFO - mozinfo == 0.9 04:21:08 INFO - mozleak == 0.1 04:21:08 INFO - mozlog == 3.1 04:21:08 INFO - moznetwork == 0.27 04:21:08 INFO - mozprocess == 0.22 04:21:08 INFO - mozprofile == 0.27 04:21:08 INFO - mozrunner == 6.11 04:21:08 INFO - mozscreenshot == 0.1 04:21:08 INFO - mozsystemmonitor == 0.0 04:21:08 INFO - moztest == 0.7 04:21:08 INFO - mozversion == 1.4 04:21:08 INFO - psutil == 3.1.1 04:21:08 INFO - requests == 1.2.3 04:21:08 INFO - wsgiref == 0.1.2 04:21:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f755042ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1605240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16940b0>, '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 0x1694fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1695440>, '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': '01deea79d00cc2c334834894000001d2-1450352449.235700-1628821057', '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 04:21:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 04:21:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 04:21:08 INFO - Using env: {'DISPLAY': ':0', 04:21:08 INFO - 'HOME': '/home/cltbld', 04:21:08 INFO - 'LANG': 'en_US.UTF-8', 04:21:08 INFO - 'LANGUAGE': 'en_US:en', 04:21:08 INFO - 'LOGNAME': 'cltbld', 04:21:08 INFO - 'MAIL': '/var/mail/cltbld', 04:21:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:08 INFO - 'MOZ_NO_REMOTE': '1', 04:21:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:08 INFO - 'NO_EM_RESTART': '1', 04:21:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:08 INFO - 'PWD': '/builds/slave/test', 04:21:08 INFO - 'SHELL': '/bin/bash', 04:21:08 INFO - 'SHLVL': '1', 04:21:08 INFO - 'TERM': 'linux', 04:21:08 INFO - 'TMOUT': '86400', 04:21:08 INFO - 'USER': 'cltbld', 04:21:08 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450352449.235700-1628821057', 04:21:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:08 INFO - '_': '/tools/buildbot/bin/python'} 04:21:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:08 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 1)) 04:21:08 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 2)) 04:21:08 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 3)) 04:21:08 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 4)) 04:21:08 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 5)) 04:21:08 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 6)) 04:21:08 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 7)) 04:21:08 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 8)) 04:21:08 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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:21:08 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 3)) 04:21:08 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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:21:08 INFO - Cleaning up... 04:21:08 INFO - Return code: 0 04:21:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:21:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f755042ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1605240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16940b0>, '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 0x1694fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1695440>, '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': '01deea79d00cc2c334834894000001d2-1450352449.235700-1628821057', '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 04:21:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 04:21:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 04:21:08 INFO - Using env: {'DISPLAY': ':0', 04:21:08 INFO - 'HOME': '/home/cltbld', 04:21:08 INFO - 'LANG': 'en_US.UTF-8', 04:21:08 INFO - 'LANGUAGE': 'en_US:en', 04:21:08 INFO - 'LOGNAME': 'cltbld', 04:21:08 INFO - 'MAIL': '/var/mail/cltbld', 04:21:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:08 INFO - 'MOZ_NO_REMOTE': '1', 04:21:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:08 INFO - 'NO_EM_RESTART': '1', 04:21:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:08 INFO - 'PWD': '/builds/slave/test', 04:21:08 INFO - 'SHELL': '/bin/bash', 04:21:08 INFO - 'SHLVL': '1', 04:21:08 INFO - 'TERM': 'linux', 04:21:08 INFO - 'TMOUT': '86400', 04:21:08 INFO - 'USER': 'cltbld', 04:21:08 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450352449.235700-1628821057', 04:21:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:08 INFO - '_': '/tools/buildbot/bin/python'} 04:21:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:08 INFO - Downloading/unpacking jsonschema 04:21:08 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 04:21:08 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 04:21:08 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 04:21:08 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 04:21:08 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 04:21:08 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 04:21:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:21:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 04:21:10 INFO - Downloading/unpacking functools32 (from jsonschema) 04:21:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:10 INFO - Downloading functools32-3.2.3-2.tar.gz 04:21:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:21:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:21:10 INFO - warning: no files found matching '*.txt' 04:21:10 INFO - no previously-included directories found matching 'build' 04:21:10 INFO - no previously-included directories found matching 'dist' 04:21:10 INFO - no previously-included directories found matching '.git*' 04:21:10 INFO - Installing collected packages: jsonschema, functools32 04:21:10 INFO - Running setup.py install for functools32 04:21:10 INFO - warning: no files found matching '*.txt' 04:21:10 INFO - no previously-included directories found matching 'build' 04:21:10 INFO - no previously-included directories found matching 'dist' 04:21:10 INFO - no previously-included directories found matching '.git*' 04:21:10 INFO - Successfully installed jsonschema functools32 04:21:10 INFO - Cleaning up... 04:21:10 INFO - Return code: 0 04:21:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:21:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f755042ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1605240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16940b0>, '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 0x1694fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1695440>, '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': '01deea79d00cc2c334834894000001d2-1450352449.235700-1628821057', '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 04:21:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 04:21:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 04:21:10 INFO - Using env: {'DISPLAY': ':0', 04:21:10 INFO - 'HOME': '/home/cltbld', 04:21:10 INFO - 'LANG': 'en_US.UTF-8', 04:21:10 INFO - 'LANGUAGE': 'en_US:en', 04:21:10 INFO - 'LOGNAME': 'cltbld', 04:21:10 INFO - 'MAIL': '/var/mail/cltbld', 04:21:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:10 INFO - 'MOZ_NO_REMOTE': '1', 04:21:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:10 INFO - 'NO_EM_RESTART': '1', 04:21:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:10 INFO - 'PWD': '/builds/slave/test', 04:21:10 INFO - 'SHELL': '/bin/bash', 04:21:10 INFO - 'SHLVL': '1', 04:21:10 INFO - 'TERM': 'linux', 04:21:10 INFO - 'TMOUT': '86400', 04:21:10 INFO - 'USER': 'cltbld', 04:21:10 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450352449.235700-1628821057', 04:21:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:10 INFO - '_': '/tools/buildbot/bin/python'} 04:21:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:11 INFO - Downloading/unpacking flake8 04:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:21:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 04:21:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:21:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 04:21:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 04:21:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:21:13 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 04:21:13 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 04:21:13 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 04:21:13 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 04:21:13 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 04:21:13 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 04:21:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:21:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:21:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:21:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:21:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:21:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:21:13 INFO - no previously-included directories found matching 'docs/_build' 04:21:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:21:13 INFO - Running setup.py install for pep8 04:21:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:21:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:21:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:21:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:21:13 INFO - no previously-included directories found matching 'docs/_build' 04:21:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:21:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:21:13 INFO - Cleaning up... 04:21:13 INFO - Return code: 0 04:21:13 INFO - Running post-action listener: _resource_record_post_action 04:21:13 INFO - Running post-action listener: _start_resource_monitoring 04:21:13 INFO - Starting resource monitoring. 04:21:13 INFO - ##### 04:21:13 INFO - ##### Running install step. 04:21:13 INFO - ##### 04:21:13 INFO - Running pre-action listener: _resource_record_pre_action 04:21:13 INFO - Running main action method: install 04:21:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:21:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:21:13 INFO - Reading from file tmpfile_stdout 04:21:13 INFO - Detecting whether we're running mozinstall >=1.0... 04:21:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:21:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:21:13 INFO - Reading from file tmpfile_stdout 04:21:13 INFO - Output received: 04:21:13 INFO - Usage: mozinstall [options] installer 04:21:13 INFO - Options: 04:21:13 INFO - -h, --help show this help message and exit 04:21:13 INFO - -d DEST, --destination=DEST 04:21:13 INFO - Directory to install application into. [default: 04:21:13 INFO - "/builds/slave/test"] 04:21:13 INFO - --app=APP Application being installed. [default: firefox] 04:21:13 INFO - mkdir: /builds/slave/test/build/application 04:21:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:21:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:21:28 INFO - Reading from file tmpfile_stdout 04:21:28 INFO - Output received: 04:21:28 INFO - /builds/slave/test/build/application/firefox/firefox 04:21:28 INFO - Running post-action listener: _resource_record_post_action 04:21:28 INFO - ##### 04:21:28 INFO - ##### Running run-tests step. 04:21:28 INFO - ##### 04:21:28 INFO - Running pre-action listener: _resource_record_pre_action 04:21:28 INFO - Running main action method: run_tests 04:21:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:21:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:21:28 INFO - Python 2.7.3 04:21:28 INFO - Return code: 0 04:21:28 INFO - grabbing minidump binary from tooltool 04:21:28 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')]} 04:21:28 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 0x16940b0>, '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 0x1694fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1695440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:21:28 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 04:21:28 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 04:21:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:21:28 INFO - Return code: 0 04:21:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:21:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:21:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:21:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:21:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:21:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:21:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:21:29 INFO - Return code: 0 04:21:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/50imxasqTTO73CsoI4Gd_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost'] in /builds/slave/test/build 04:21:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/50imxasqTTO73CsoI4Gd_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost 04:21:29 INFO - Using env: {'DISPLAY': ':0', 04:21:29 INFO - 'HOME': '/home/cltbld', 04:21:29 INFO - 'LANG': 'en_US.UTF-8', 04:21:29 INFO - 'LANGUAGE': 'en_US:en', 04:21:29 INFO - 'LOGNAME': 'cltbld', 04:21:29 INFO - 'MAIL': '/var/mail/cltbld', 04:21:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:21:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:21:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:29 INFO - 'MOZ_NO_REMOTE': '1', 04:21:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:21:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:29 INFO - 'NO_EM_RESTART': '1', 04:21:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:29 INFO - 'PWD': '/builds/slave/test', 04:21:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:21:29 INFO - 'SHELL': '/bin/bash', 04:21:29 INFO - 'SHLVL': '1', 04:21:29 INFO - 'TERM': 'linux', 04:21:29 INFO - 'TMOUT': '86400', 04:21:29 INFO - 'USER': 'cltbld', 04:21:29 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450352449.235700-1628821057', 04:21:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:29 INFO - '_': '/tools/buildbot/bin/python'} 04:21:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/50imxasqTTO73CsoI4Gd_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost'] with output_timeout 3600 04:21:29 INFO - mozversion INFO | application_buildid: 20151217025634 04:21:29 INFO - mozversion INFO | application_changeset: 77ab820ce477438af4b32cea83f82fd55744cec7 04:21:29 INFO - mozversion INFO | application_display_name: Nightly 04:21:29 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:21:29 INFO - mozversion INFO | application_name: Firefox 04:21:29 INFO - mozversion INFO | application_remotingname: firefox 04:21:29 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 04:21:29 INFO - mozversion INFO | application_vendor: Mozilla 04:21:29 INFO - mozversion INFO | application_version: 46.0a1 04:21:29 INFO - mozversion INFO | platform_buildid: 20151217025634 04:21:29 INFO - mozversion INFO | platform_changeset: 77ab820ce477438af4b32cea83f82fd55744cec7 04:21:29 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 04:21:29 INFO - mozversion INFO | platform_version: 46.0a1 04:21:29 INFO - 2015-12-17 04:21:29,690 DEBUG : using testdate: 1450354889 04:21:29 INFO - 2015-12-17 04:21:29,690 DEBUG : actual date: 1450354889 04:21:29 INFO - 2015-12-17 04:21:29,703 INFO : starting webserver on 'localhost:40608' 04:21:29 INFO - 2015-12-17 04:21:29,704 INFO : Starting test suite talos-linux64-ix-014.e 04:21:29 INFO - 2015-12-17 04:21:29,704 INFO : Starting test dromaeo_css 04:21:29 INFO - 2015-12-17 04:21:29,704 DEBUG : operating with platform_type : linux_ 04:21:29 INFO - 2015-12-17 04:21:29,705 INFO : Initialising browser for dromaeo_css test... 04:21:29 INFO - 2015-12-17 04:21:29,721 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHB_NaH/profile http://localhost:40608/getInfo.html 04:21:34 INFO - 2015-12-17 04:21:34,732 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:21:34 INFO - 2015-12-17 04:21:34,732 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:21:34 INFO - 2015-12-17 04:21:34,733 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:21:34 INFO - 2015-12-17 04:21:34,733 DEBUG : BROWSER_OUTPUT: __metrics 04:21:34 INFO - 2015-12-17 04:21:34,874 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:21:35 INFO - 2015-12-17 04:21:35,873 INFO : Browser initialized. 04:21:35 INFO - 2015-12-17 04:21:35,873 INFO : Running cycle 1/1 for dromaeo_css test... 04:21:35 INFO - 2015-12-17 04:21:35,873 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHB_NaH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:21:47 INFO - 2015-12-17 04:21:47,817 DEBUG : BROWSER_OUTPUT: RSS: Main: 143384576 04:21:47 INFO - 2015-12-17 04:21:47,817 DEBUG : BROWSER_OUTPUT: 04:22:37 INFO - 2015-12-17 04:22:37,453 DEBUG : BROWSER_OUTPUT: 1450354957453 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] 04:24:48 INFO - 2015-12-17 04:24:48,343 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40608/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40608/tests/dromaeo/cssquery-ext.html) 04:24:49 INFO - 2015-12-17 04:24:49,408 DEBUG : BROWSER_OUTPUT: RSS: Main: 146767872 04:24:49 INFO - 2015-12-17 04:24:49,408 DEBUG : BROWSER_OUTPUT: 04:27:51 INFO - 2015-12-17 04:27:51,548 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40608/tests/dromaeo/cssquery-ext.html (next: http://localhost:40608/tests/dromaeo/cssquery-jquery.html) 04:27:52 INFO - 2015-12-17 04:27:52,149 DEBUG : BROWSER_OUTPUT: RSS: Main: 144830464 04:27:52 INFO - 2015-12-17 04:27:52,149 DEBUG : BROWSER_OUTPUT: 04:30:54 INFO - 2015-12-17 04:30:54,032 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40608/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40608/tests/dromaeo/cssquery-mootools.html) 04:30:54 INFO - 2015-12-17 04:30:54,634 DEBUG : BROWSER_OUTPUT: RSS: Main: 146173952 04:30:54 INFO - 2015-12-17 04:30:54,634 DEBUG : BROWSER_OUTPUT: 04:33:56 INFO - 2015-12-17 04:33:56,404 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40608/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40608/tests/dromaeo/cssquery-prototype.html) 04:33:57 INFO - 2015-12-17 04:33:57,006 DEBUG : BROWSER_OUTPUT: RSS: Main: 144527360 04:33:57 INFO - 2015-12-17 04:33:57,006 DEBUG : BROWSER_OUTPUT: 04:36:59 INFO - 2015-12-17 04:36:59,532 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40608/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40608/tests/dromaeo/cssquery-yui.html) 04:37:00 INFO - 2015-12-17 04:37:00,125 DEBUG : BROWSER_OUTPUT: RSS: Main: 144977920 04:37:00 INFO - 2015-12-17 04:37:00,126 DEBUG : BROWSER_OUTPUT: 04:40:02 INFO - 2015-12-17 04:40:02,613 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40608/tests/dromaeo/cssquery-yui.html (next: http://localhost:40608/tests/dromaeo/cssquery-dojo.html) 04:40:02 INFO - 2015-12-17 04:40:02,857 DEBUG : BROWSER_OUTPUT: RSS: Main: 147509248 04:40:02 INFO - 2015-12-17 04:40:02,857 DEBUG : BROWSER_OUTPUT: 04:40:02 INFO - 2015-12-17 04:40:02,860 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:40:02 INFO - 2015-12-17 04:40:02,860 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:40:02 INFO - 2015-12-17 04:40:02,861 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:40:02 INFO - 2015-12-17 04:40:02,861 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:40:02 INFO - 2015-12-17 04:40:02,861 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2679.0175270299974;2733.576295674171;2755.2973991632143;2764.2398340456384;2790.065328115082;4705.976470117645;4783.904321913559;4830.130576496229;4831.492693267209;4852.636052296074;4675.1351000065015;4800.087983283173;4804.759762011903;4806.327114204014;4898.387701537308;4439.067795762886;4506.375627827089;4522.072975040125;4564.497905230422;4600.378948841897;120.81108395870429;4292.892677683068;4396.714213576107;4399.494058183302;4403.867883963486;4375.7593332366705;4394.630444740981;4428.800703968329;4446;4468.441444819414;4442.800073996646;4448.911021779579;4450.532694067141;4469.7541635210055;4482.618977386926;4256.638185754215;4296.914061718748;4353.325234588644;4399.450068741407;4428.955710442919;4695.976520117411;4715.339852420664;4728.196206644879;4731.929021064687;4769.117713223065;5100.566451851597;5132.5124113209185;5143.897122057575;5152.330197074394;5182.455842136559;4974.726390048582;5088.974555127238;5141.948580514184;5220.3735551734035;5257.13257312543;4785.665003449794;4797.52024797521;4825.059113472874;4828.155072862271;4880.341153944243;5054.949450505522;5308.92036619451;5309.123994540858;5320.042392369333;5328.413874473805;4963.528464795839;4964.751762411865;5036.7733451994745;5053.620978426633;5101.336826212569;5167.173252279617;5176.352955880515;5176.430592634807;5180.678926873623;5218.425973142951;4830.29960655703;4956.628252881048;5096.490350964874;5115.437301896788;5128.564072053917;4987.426445958761;5040.84877453677;5053.469385714447;5068.923966140511;5106.106431374495;4282.657387409;4286.935695964563;4291.420658211102;4291.978540107342;4329.242382583036;3613.728970327236;3621.1128273573145;3730.3285408626166;3753.249350129985;3768.773873567595;4478.373027776114;4490.887727806766;4507.932381014288;4511.075229577994;4519.728816271035;5153.175491921274;5155.278261043457;5170.37955445349;5174.534291913746;5218.321618189611;4269.231538323132;4349.304111342233;4369.781510924505;4473;4478.820847166142;4529.705569137996;4538.909221815546;4546.818127274938;4551.40831691878;4588.587027167571;4896.6572339935865;4904.337914381513;4905.411350637946;4907.214845624683;4907.484714105039;4944.851654450372;5054.7978080876355;5067;5099.413567439792;5128.923066153936;4873.293372461044;4875.0493653737185;4912.975435122801;4916;4958.950410495849;4890.510948905223;5105.540501354896;5110.131277682728;5124.256982737407;5155.175171972466;5053.2420136979745;5107.157319042465;5159.329287192641;5166.199239117943;5225.81709640176;4959.20652695567;4999.525045120708;4999.625028122832;5011.09800235961;5024.070546948826;4748.4776674566465;4862.3922009748785;5030.37120359955;5035.5468007878;5059.924101138412;4808.2787581863;4829.855104346875;4853;4893.804247830047;4925.335079764186;5049.671343761422;5059.949400505948;5111.718855462986;5116.155834287301;5146.8970620588125;4759.904801904012;4877.804887804448;4890.755462226945;4987.301777751045;5025.120603894377 04:40:02 INFO - 2015-12-17 04:40:02,862 DEBUG : BROWSER_OUTPUT: |1;ext.html;545.9980934984303;561.1274468201947;573.6042130929658;578.0895090232882;579.6898659217318;35233.82383088084;36095.45856812143;36177.63822361775;36185.45721814172;36231.81884090576;40824.18351632966;41295.38056929141;41416;41507.377389339184;41522.377164342484;7946.523208607473;8120.472169309006;8120.878186827203;8152.510849349058;8169.060558035842;7790.298873101419;7875.763727088197;7878.212178782133;7888.171741967097;7891.881621775678;7937.920620793776;8074.3136833369235;8081;8083.514989100643;8112.269895709385;7961.880571791427;8092.676292948275;8107.310878575328;8115.675372985073;8128.471649342833;7905.96047019767;7959.164287749819;7994.360451163893;8026.558539280337;8026.919730802676;38013.42979855304;38289;38323.233535329135;38367.42448863269;38394.0401489965;2262.4277513905004;2691.4078902641386;2803.4393121375806;3002.234430220302;3380.6281309055985;27101.86449067742;27139.592906106423;27166;27178.32054198641;28193.295167620767;3218.1954511372155;3239.6598357172393;3307.3219989902013;3395.6774106459848;3438.8796392126405;170085.14957425135;170485;170722;171657;173284;39142;39345.21309573793;39574.406383904265;39584.802075989435;50628;36463.088422789115;36644.26711465756;36680.633193668255;36733.44899826505;36823.26353472916;13312.534061307808;13336.599902002956;13412;13433.328333583477;13447.865521344856;10018.048285412875;10035.69892903214;10051.447170405698;10067.093961543349;10187.930267321974;13464.394102265422;13473.932630336785;13479.123856949267;13527.526536571173;13579.117357371739;5582.49757521825;5617.32592088952;5624.240727501735;5634.3802181759975;5991.460768530853;817.284875733733;849.3544905871582;871.9825603487894;880.0935036911991;972.1202311907734;26273.34316642061;26591.601125983125;27169.728302717114;27182.5922611161;27460.725392746215;922.7462447826767;942.6323733743845;963.4026903319987;975.0401692597787;992.717075633441;14166.362513686703;14262.57212283633;14408.639784005274;14432.278386080654;14529.78205326921;260293;263901;264291;264309;265552;47135.29297060547;47467.28799068017;47626;47691.76154119207;47767.76116119397;1213.805791073424;1224.9832638909684;1228.0666693313146;1230.2679905456419;1234.9814752778716;25611;26302;26473.33816654522;26701.931922723652;26759.331016724736;42037.159256814084;42823.143537129705;42942;42975.355369668854;43070.78464607657;191099;192932;194291;194390;194702;36876.446853297755;42835.357469638606;43449;43840.61593840591;44322.77838610915;39941.80029099836;40133;43043.56956430521;43675.344869826346;47326.763366182946;33622.327553448304;34000;34098.659013409546;34332.82833585816;34763.65236347604;33898.49152262669;34269.82865085659;34465.48301775425;38839.41740873833;40623.796881015405;33446;33869.83065084659;34032.829835850665;34378;34434;29326.26684332909;30794.384112318075;31176.376472470878;31227.84386078055;31272.68727312789;24313;24548.263552093467;24589.38526536851;24920.626190606792;24966.126185583416 04:40:02 INFO - 2015-12-17 04:40:02,863 DEBUG : BROWSER_OUTPUT: |2;jquery.html;339.2553345406833;341.97948123112616;344.6157534349201;345.64053384480144;345.716512459783;12561.371931403428;14708.77936830947;14939.477118300862;16092.597685057879;16726.16369181542;10180.236482263823;10441.112505437048;14944.476943306987;16243.269052892618;16341.918290408561;4567.543245675431;4660;5175.8188463403785;5191.948080519203;5212.713300768456;5125.666831655949;5140.126178549637;5179.585633149358;5181.792728290864;5185.662931909433;3347.1130150510135;3473.791572505645;5109.156989096813;5127.102757017507;5145.794168233285;5229.921551176735;5241.371035475749;5269.710165940872;5295.841124766263;5301.681899086047;4986.052649996525;5077.416097148838;5081.8475445736685;5086.237064440364;5102.132637451642;11064.336139831636;11269.380184089872;11270.154738394653;11570.826437603442;17303.653926921517;1754.2719771294896;1852.8517718582482;1859.8140185981295;1875.4561177258715;1884.180381534037;8873.73378798637;8922.10778922109;9063.595142752883;9173.08269173084;9261.6295348186;1630.315267587616;1668.9248983795758;1708.487453763866;1714.322842477227;1722.86512370311;53698.463015369736;54650.72674636601;55444.72277638626;55770.44229557693;57074;9709.271804614682;9830;9855.90144098564;9914.603415863428;9968.501574921225;12600.180988235736;12689.619311420673;12699.619011429671;12705.428255728515;12714.872851271553;7177.497575169688;7177.856442871113;7270.236625154388;7316.414686825041;7419.703211871465;6992.1259842519685;7010.684519196649;7013.6142512161305;7044.330788575077;7065.399441047569;4184.456020717287;4189.371594260885;4205.9789701051295;4220.240356735756;4253.574642535722;1687.2829047654698;1688.2993557673428;1714.6484970581;1777.0759205213217;1796.6676164909272;760.9124950630637;807.4267270238079;854.5855260198798;897.4839467306325;943.5801068524578;14568.34442450071;14666.56000319992;15185.468508602145;15298.541043768704;15351.309191086428;824.9687890137328;826.8428998490388;840.8948881389827;879.7184900831672;908.6819613135482;8103.3112185463715;8612.741617751477;8643.308535317285;8667.263282620921;8961.372703910794;459883;475481;484615;485940;488043;69234.65382673054;71077.28922710811;71471.64264178646;71904.2809571908;72161;1094.2121672396022;1102.2449622008949;1155.8786327435666;1166.7666466706692;1171.6133675886938;13277.40251688657;13341.666458338232;13490.32548372597;13562.926014984023;13705.931470342584;30839.074827755205;31111.53332699966;31181.68818311788;31797.682023180398;32567.18582035468;41907.371389428576;44151.33772993343;44555;44749.55250447454;44942.10115797731;8384.874226886725;8630.439021463584;8668.78328041804;12173.208741432132;12557.623271301876;15375.69248614999;17014.914925425295;17440.040797756246;17476.388326408516;17571.472855814347;12974.637663045622;15425.382984680937;15602.84397156014;15604.92197539005;15607;13957.720845583235;14056.578302650936;14209.573712788633;14544.41822327095;14565.27173641335;8484.151584841466;8846.11538846136;14417.78373324422;14703.41186352534;14812.259387030821;13403.128796628189;13438.260895650834;13614.727705446034;13622.795658064939;13629.591112266648;13503.189808611121;13567.38946747379;13691.178529288274;13766.793498097337;14078.718425631225 04:40:02 INFO - 2015-12-17 04:40:02,864 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1484.4433337498438;1629.201691171326;1717.4504158669224;1717.467585048635;1729.2909906938157;6998.615076170815;7061.788146355605;7291.8906216406795;7475.7009719611215;7500.174980752113;7407.814804629874;7421;7440.107187137538;7496.137944136426;7503.399728021759;2075.491504581376;2108.420184449273;2113.830893528514;2116.354511873878;2116.798904104108;2062.164075665862;2081.510844951435;2124.2883633982556;2144.9356519304447;2145.0454547726267;1723.6208034232511;1748.9300427982866;2041.203930467119;2068.6793547000166;2092.529180934293;2077.4494758888904;2106.462851972745;2112.3874076517945;2122.3420739570784;2124.0972586650687;2090.446031801574;2102.2326850699537;2111.6304646686767;2113.123053932616;2127.9893600532055;6920.757773477954;7013.649317534103;7038.92961070393;7086.539374940664;7095.609741464217;4202.411662367271;4299.91400171998;4301.268784306644;4310.547392523771;4315.784210789448;2730.0990673078036;2745.492083964473;2827.123591686584;2835.333696581302;2842.6588809342807;896.4531635702216;898.380117718772;911.5260064766351;926.7822061815468;935.1770442010986;9680.031996800333;9901;9906.950465247699;9935.751606209902;9977.950110249401;3830.3296923038356;3920.3923391874305;3937.547182074098;3948.368261078271;3969.364901615728;8589.785255368666;8662.78343041429;8668.436551624125;8685.782855428539;8697.391182617283;4317.395564620955;4326.783660816946;4341.240282950471;4355.542668019875;4359.302511598129;3896.473976013259;3918.647321741057;3929.626685464876;3929.7249192556246;3938.350172221609;3286.671332866742;3394.2023624448234;3399.7790143640586;3411.2154204533094;3417.8120203389053;1036.0209601926108;1036.9948150259352;1045.6340280901622;1055.9894401055892;1062.744941214103;936.4194199596294;937.2829785214317;1007.8740157480315;1054.2462139570243;1188.4117361905912;6886.586804791728;6949.096617439701;6952.513324067368;6962.094927659372;6966.9651651741415;982.4449186209769;997.8303688372994;1062.6387028410377;1064.882862885082;1096.1833434091493;5167.715775632301;5202.71385073817;5224.764885580158;5236.869078272997;5246.108161612535;8494.108118647453;8510.617022234015;8621.137886211454;8663.436876603;8703.651853925772;8610.483370997761;8715.823363845926;8739.956300218459;8810.911890881009;8840.292776577859;6825.761098361633;6842.384185423336;6919.965400173068;6920.30796920314;6997.16034075904;6858.451323894176;6894.655267236719;6902.275261097512;6913.1358580177475;6925.688344024632;7592.177877309517;7700;7847.411444141826;7878.960605196938;7890.289873911375;7843.098043724816;7998.48009879356;8098.109207986999;8099.635516401659;8109.594520273845;6439.484841212598;6553.901691474536;6593.175853018372;6593.868122637617;6610;6716.429103526059;6781.084553585203;6786.966065169642;6788.59268443895;6788.660566971533;6408.423241908251;6453.386928241809;6572.967135164294;6591.901121483277;6789.219239787488;5673.461021202979;6200.224971878515;6205.348438413902;6228.501719862491;6282.528810339334;6594.340565943367;6629.906065499139;6636.170478690164;6636.83407914806;6645.734170633121;5967.940320596738;5968.31364393083;6021.096835474714;6051.152838602511;6063.211782468251;6105.84735381619;6116.449519543263;6138.140660307471;6141;6145.9692701538 04:40:02 INFO - 2015-12-17 04:40:02,866 DEBUG : BROWSER_OUTPUT: |4;prototype.html;302.94092651932874;311.2747298793811;314.6601670196187;315.9004913452262;317.8299609708806;5529.972350138249;5628.352739434966;5634.9857025735455;5674.205611214428;5686.800961966332;5570.192322113291;5570.637908535942;5591.720413979305;5593.216949627045;5601.467860553251;4095.221907837516;4175.68682348825;4278.1871444425615;4279.593438623326;4285.57144285572;4236.216299984498;4309.870703878889;4312.029793296499;4318.309070548713;4352.608265256126;4270.7864606769535;4279.72181808183;4279.957200428003;4284.314509678452;4297.097609502009;4271.807768650403;4291.098869237464;4298.892527686801;4302.075053863418;4302.333138363559;3798.4682144499793;3802.068493219179;3807.7905715185652;3809.314323421783;3813.2945405100145;5238.554722848562;5317.441668624816;5346.144616861322;5352.785888564453;5385.461453854622;4961.8511444656715;4965.180745177042;4965.553100220997;4971.353724015855;4982.377202849644;5855.033919403293;5864.648121112747;5866.853328666774;5870.412958704138;5878.882422351572;4033.294173519652;4106.7946602669745;4124.731892427013;4127.628513433805;4130.896727581804;6179.258488981306;6193.5045196384635;6200.968995155041;6202.286737025254;6202.503799696014;4255;4257.02088519636;4265.488141422987;4268.637165840876;4276.016516201229;4330.328799036154;4331.848385306562;4333.58830911063;4336.739795612273;4348.108637729258;4846.684965477232;4932.580730637864;4939.259111133287;4941.061198372297;4946.653734238569;5886.823395298148;5890.823275301748;5893.616914900518;5897.439743224387;5900.203472531153;1515.7423238049557;1540.7457769468137;1541.8149822021205;1543.9459618913509;1544.4903181950153;1051.784384201237;1053.7629033467563;1060.9204309676804;1069.893010698924;1082.6697857153486;5139.58883289336;5145.691258524501;5151.07280689472;5153.0466863630345;5153.3815942087185;6026.668533230714;6110.4500594945775;6137.631742095399;6158.476529495043;6213.099100630474;5158.432572417031;5172.405173405106;5173.042987047408;5179.870503237449;5197.506236907488;3295.07737833407;3330.6169790474405;3332.783369081002;3348.263382055944;3348.68187522185;5701.857453563694;5808.273965754281;5851.561132915049;5855.4730074292665;5861.941380586225;6347.746090156342;6364.745410183634;6368.713407896656;6369.872602547923;6372.394622510854;5817.6218545793545;5833.562482813806;5846.123081537803;5849.064149736022;5857.619254748428;6040.426159514839;6176.444120029039;6179.938200617937;6187.81436556904;6188.721507532262;5985.790497332572;6029.698515074317;6040.305364883095;6044.032954727222;6046;5840.707964601838;5842.795502157404;5847.853803654943;5849.94150058494;5860.208871802252;4141.97929010353;4190.580941905907;4192.769397683157;4196.2656535105625;4199.790010499401;5989.311229208697;6158.291796443287;6164.167837342081;6167.784127555514;6180.381961803783;5891.9116213255975;5906.4093590642315;5912.172295878494;5919.644821310563;5926.407359264039;5944.138099975393;5946.583739138218;5956.851078723066;5961.821145365646;5966.522678185822;5710.457506536873;5802.390748971297;5807.796727114531;5823.94176058234;5828.679422631626;5987.101934709828;5993.820185394445;5994.820155395345;6001.159837622649;6007.939920600913;5668.234788303526;5824.737886795019;5829.53363730892;5831;5843.883122337615 04:40:02 INFO - 2015-12-17 04:40:02,866 DEBUG : BROWSER_OUTPUT: |5;yui.html;614.2475467552247;640.9936399852234;648.3743187823749;654.9967250163749;720.8342081321296;11599.304041757501;11766;11865.7626847463;11869.525218991252;11885.702857428558;10368.948155259213;11812;11919.463624136913;11938;11952.462139203735;627.0907184582351;824.5918270456102;836.6318819719335;837.0833936839151;837.1210229259253;819.8975128108987;821.5563595658338;821.7411515372669;822.9711960081398;827.9503229806201;856.0797143071223;863.4905405810571;868.2229404682805;868.288003836854;868.9739307820776;854.1970547685156;854.6367793687658;855.9743207703779;857.7769779857251;862.9784255393603;640.2221301119116;640.785336912135;642.1427394428397;644.0532417346493;644.8001119652922;11045.613403530919;11047.83428248577;11054.557817687282;11066.944665276622;11090.611828585961;10944.56221751129;11118.55525778976;11319.490622921989;11374.886251137465;11803;9321.207697345733;9606.519674016341;9696.0788725071;9697.612095516171;10020.498975051218;3248.187953011747;3288.671132886716;3300.1254667513126;3331.4669652855428;3406.1654894550993;41655;41796.1640767183;41856;42022.159556809;42023.369649455286;8901.955490222637;8984.46093234408;9260.7684807879;9325.953370233105;9362.672306469241;16253;16544.83455165457;16569;16582.917085414738;16616.58458538522;5928.555358348141;5953.880922381615;6126.172966649446;6214.161088253119;6374.075759014917;3361.411752943225;3378.015552594435;3563.8574457021427;3610.2598967211657;3618.16782140104;2565.4356041670803;2579.5743702288914;2583.5220484210104;2585.5475291823855;2592.196419110082;464.22474467639125;482.35605466701645;484.2469959213457;496.6498618473967;514.8661348049534;478.7582270953216;583.4486410342271;604.8125081224835;612.2316492801506;617.3949529461153;7724.6523906424345;7724.8455030900195;7772.84454310922;7912.525248485109;7991.24083212094;520.1132069820947;539.8434454008373;556.3796367050709;568.4003376437897;608.8873558391712;3870.6903447724117;3881.4565960765517;3888.5528164261473;4007.35882258843;4017.4777278954134;48571;49068.26397604039;49126.26310605344;49160.26259606109;49205.261921071215;44219.33670994938;44240;46844.5315546847;49462.75268623634;49592.256116158285;40004;40111.79944100261;41033;42601.57398425976;42692.78653606712;8374.623141958748;8415.621297041525;8505.82988340242;8824.5587720615;8865;29094.563581546718;29530.261743456587;30285.848570757003;31221.531677025316;31866.522002169524;38294.234115316984;38324;38868.08489363253;38961;38999.2200156001;11155.107591392507;11227.887721122685;11267.436628168723;11429.59996400122;11469.655910322703;11327.263727857993;11439.167878760709;11568.942155289169;11769.705757356134;12126.029917606747;10829.620963266563;11404.828927565926;11406.429678516208;11554.711132221762;11913.82129268079;10785.298955567863;10798;10830.620928267474;10877.728056798644;10916.12670986335;11018.889811101786;11032.944835276094;11061.336319820837;11098.667039988813;11583.594574189863;8691.608877600396;8810.691625793066;8873.556322183995;9073.092690730875;9909.55407006672;9277.48973806447;9493.572789224363;9526.47604381738;9629.56666950003;9644.469554174588 04:40:02 INFO - 2015-12-17 04:40:02,866 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:40:02 INFO - 2015-12-17 04:40:02,866 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:40:02 INFO - 2015-12-17 04:40:02,866 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,329 04:40:02 INFO - 2015-12-17 04:40:02,866 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:40:02 INFO - 2015-12-17 04:40:02,866 DEBUG : BROWSER_OUTPUT: __startTimestamp1450356002858__endTimestamp 04:40:02 INFO - 2015-12-17 04:40:02,866 DEBUG : BROWSER_OUTPUT: 04:40:02 INFO - 2015-12-17 04:40:02,866 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:40:02 INFO - 2015-12-17 04:40:02,866 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:40:02 INFO - 2015-12-17 04:40:02,866 DEBUG : BROWSER_OUTPUT: 04:40:02 INFO - 2015-12-17 04:40:02,867 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4712.47 Median:4877.80 stddev:612.24 (12.6%) stddev-sans-first:592.97 04:40:02 INFO - 2015-12-17 04:40:02,868 DEBUG : BROWSER_OUTPUT: Values: 2679.0 2733.6 2755.3 2764.2 2790.1 4706.0 4783.9 4830.1 4831.5 4852.6 4675.1 4800.1 4804.8 4806.3 4898.4 4439.1 4506.4 4522.1 4564.5 4600.4 120.8 4292.9 4396.7 4399.5 4403.9 4375.8 4394.6 4428.8 4446.0 4468.4 4442.8 4448.9 4450.5 4469.8 4482.6 4256.6 4296.9 4353.3 4399.5 4429.0 4696.0 4715.3 4728.2 4731.9 4769.1 5100.6 5132.5 5143.9 5152.3 5182.5 4974.7 5089.0 5141.9 5220.4 5257.1 4785.7 4797.5 4825.1 4828.2 4880.3 5054.9 5308.9 5309.1 5320.0 5328.4 4963.5 4964.8 5036.8 5053.6 5101.3 5167.2 5176.4 5176.4 5180.7 5218.4 4830.3 4956.6 5096.5 5115.4 5128.6 4987.4 5040.8 5053.5 5068.9 5106.1 4282.7 4286.9 4291.4 4292.0 4329.2 3613.7 3621.1 3730.3 3753.2 3768.8 4478.4 4490.9 4507.9 4511.1 4519.7 5153.2 5155.3 5170.4 5174.5 5218.3 4269.2 4349.3 4369.8 4473.0 4478.8 4529.7 4538.9 4546.8 4551.4 4588.6 4896.7 4904.3 4905.4 4907.2 4907.5 4944.9 5054.8 5067.0 5099.4 5128.9 4873.3 4875.0 4913.0 4916.0 4959.0 4890.5 5105.5 5110.1 5124.3 5155.2 5053.2 5107.2 5159.3 5166.2 5225.8 4959.2 4999.5 4999.6 5011.1 5024.1 4748.5 4862.4 5030.4 5035.5 5059.9 4808.3 4829.9 4853.0 4893.8 4925.3 5049.7 5059.9 5111.7 5116.2 5146.9 4759.9 4877.8 4890.8 4987.3 5025.1 04:40:02 INFO - 2015-12-17 04:40:02,868 DEBUG : BROWSER_OUTPUT: 04:40:02 INFO - 2015-12-17 04:40:02,868 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:37368.89 Median:36181.55 stddev:55365.43 (153.0%) stddev-sans-first:55451.71 04:40:02 INFO - 2015-12-17 04:40:02,868 DEBUG : BROWSER_OUTPUT: Values: 546.0 561.1 573.6 578.1 579.7 35233.8 36095.5 36177.6 36185.5 36231.8 40824.2 41295.4 41416.0 41507.4 41522.4 7946.5 8120.5 8120.9 8152.5 8169.1 7790.3 7875.8 7878.2 7888.2 7891.9 7937.9 8074.3 8081.0 8083.5 8112.3 7961.9 8092.7 8107.3 8115.7 8128.5 7906.0 7959.2 7994.4 8026.6 8026.9 38013.4 38289.0 38323.2 38367.4 38394.0 2262.4 2691.4 2803.4 3002.2 3380.6 27101.9 27139.6 27166.0 27178.3 28193.3 3218.2 3239.7 3307.3 3395.7 3438.9 170085.1 170485.0 170722.0 171657.0 173284.0 39142.0 39345.2 39574.4 39584.8 50628.0 36463.1 36644.3 36680.6 36733.4 36823.3 13312.5 13336.6 13412.0 13433.3 13447.9 10018.0 10035.7 10051.4 10067.1 10187.9 13464.4 13473.9 13479.1 13527.5 13579.1 5582.5 5617.3 5624.2 5634.4 5991.5 817.3 849.4 872.0 880.1 972.1 26273.3 26591.6 27169.7 27182.6 27460.7 922.7 942.6 963.4 975.0 992.7 14166.4 14262.6 14408.6 14432.3 14529.8 260293.0 263901.0 264291.0 264309.0 265552.0 47135.3 47467.3 47626.0 47691.8 47767.8 1213.8 1225.0 1228.1 1230.3 1235.0 25611.0 26302.0 26473.3 26701.9 26759.3 42037.2 42823.1 42942.0 42975.4 43070.8 191099.0 192932.0 194291.0 194390.0 194702.0 36876.4 42835.4 43449.0 43840.6 44322.8 39941.8 40133.0 43043.6 43675.3 47326.8 33622.3 34000.0 34098.7 34332.8 34763.7 33898.5 34269.8 34465.5 38839.4 40623.8 33446.0 33869.8 34032.8 34378.0 34434.0 29326.3 30794.4 31176.4 31227.8 31272.7 24313.0 24548.3 24589.4 24920.6 24966.1 04:40:02 INFO - 2015-12-17 04:40:02,868 DEBUG : BROWSER_OUTPUT: 04:40:02 INFO - 2015-12-17 04:40:02,868 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26067.09 Median:1909.75 stddev:78207.68 (4095.2%) stddev-sans-first:78403.21 04:40:02 INFO - 2015-12-17 04:40:02,869 DEBUG : BROWSER_OUTPUT: Values: 339.3 342.0 344.6 345.6 345.7 12561.4 14708.8 14939.5 16092.6 16726.2 10180.2 10441.1 14944.5 16243.3 16341.9 4567.5 4660.0 5175.8 5191.9 5212.7 5125.7 5140.1 5179.6 5181.8 5185.7 3347.1 3473.8 5109.2 5127.1 5145.8 5229.9 5241.4 5269.7 5295.8 5301.7 4986.1 5077.4 5081.8 5086.2 5102.1 11064.3 11269.4 11270.2 11570.8 17303.7 1754.3 1852.9 1859.8 1875.5 1884.2 8873.7 8922.1 9063.6 9173.1 9261.6 1630.3 1668.9 1708.5 1714.3 1722.9 53698.5 54650.7 55444.7 55770.4 57074.0 9709.3 9830.0 9855.9 9914.6 9968.5 12600.2 12689.6 12699.6 12705.4 12714.9 7177.5 7177.9 7270.2 7316.4 7419.7 6992.1 7010.7 7013.6 7044.3 7065.4 4184.5 4189.4 4206.0 4220.2 4253.6 1687.3 1688.3 1714.6 1777.1 1796.7 760.9 807.4 854.6 897.5 943.6 14568.3 14666.6 15185.5 15298.5 15351.3 825.0 826.8 840.9 879.7 908.7 8103.3 8612.7 8643.3 8667.3 8961.4 459883.0 475481.0 484615.0 485940.0 488043.0 69234.7 71077.3 71471.6 71904.3 72161.0 1094.2 1102.2 1155.9 1166.8 1171.6 13277.4 13341.7 13490.3 13562.9 13705.9 30839.1 31111.5 31181.7 31797.7 32567.2 41907.4 44151.3 44555.0 44749.6 44942.1 8384.9 8630.4 8668.8 12173.2 12557.6 15375.7 17014.9 17440.0 17476.4 17571.5 12974.6 15425.4 15602.8 15604.9 15607.0 13957.7 14056.6 14209.6 14544.4 14565.3 8484.2 8846.1 14417.8 14703.4 14812.3 13403.1 13438.3 13614.7 13622.8 13629.6 13503.2 13567.4 13691.2 13766.8 14078.7 04:40:02 INFO - 2015-12-17 04:40:02,869 DEBUG : BROWSER_OUTPUT: 04:40:02 INFO - 2015-12-17 04:40:02,869 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5080.25 Median:6345.48 stddev:2643.66 (41.7%) stddev-sans-first:2637.26 04:40:02 INFO - 2015-12-17 04:40:02,870 DEBUG : BROWSER_OUTPUT: Values: 1484.4 1629.2 1717.5 1717.5 1729.3 6998.6 7061.8 7291.9 7475.7 7500.2 7407.8 7421.0 7440.1 7496.1 7503.4 2075.5 2108.4 2113.8 2116.4 2116.8 2062.2 2081.5 2124.3 2144.9 2145.0 1723.6 1748.9 2041.2 2068.7 2092.5 2077.4 2106.5 2112.4 2122.3 2124.1 2090.4 2102.2 2111.6 2113.1 2128.0 6920.8 7013.6 7038.9 7086.5 7095.6 4202.4 4299.9 4301.3 4310.5 4315.8 2730.1 2745.5 2827.1 2835.3 2842.7 896.5 898.4 911.5 926.8 935.2 9680.0 9901.0 9907.0 9935.8 9978.0 3830.3 3920.4 3937.5 3948.4 3969.4 8589.8 8662.8 8668.4 8685.8 8697.4 4317.4 4326.8 4341.2 4355.5 4359.3 3896.5 3918.6 3929.6 3929.7 3938.4 3286.7 3394.2 3399.8 3411.2 3417.8 1036.0 1037.0 1045.6 1056.0 1062.7 936.4 937.3 1007.9 1054.2 1188.4 6886.6 6949.1 6952.5 6962.1 6967.0 982.4 997.8 1062.6 1064.9 1096.2 5167.7 5202.7 5224.8 5236.9 5246.1 8494.1 8510.6 8621.1 8663.4 8703.7 8610.5 8715.8 8740.0 8810.9 8840.3 6825.8 6842.4 6920.0 6920.3 6997.2 6858.5 6894.7 6902.3 6913.1 6925.7 7592.2 7700.0 7847.4 7879.0 7890.3 7843.1 7998.5 8098.1 8099.6 8109.6 6439.5 6553.9 6593.2 6593.9 6610.0 6716.4 6781.1 6787.0 6788.6 6788.7 6408.4 6453.4 6573.0 6591.9 6789.2 5673.5 6200.2 6205.3 6228.5 6282.5 6594.3 6629.9 6636.2 6636.8 6645.7 5967.9 5968.3 6021.1 6051.2 6063.2 6105.8 6116.4 6138.1 6141.0 6146.0 04:40:02 INFO - 2015-12-17 04:40:02,870 DEBUG : BROWSER_OUTPUT: 04:40:02 INFO - 2015-12-17 04:40:02,870 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4903.70 Median:5550.08 stddev:1444.72 (26.0%) stddev-sans-first:1406.90 04:40:02 INFO - 2015-12-17 04:40:02,871 DEBUG : BROWSER_OUTPUT: Values: 302.9 311.3 314.7 315.9 317.8 5530.0 5628.4 5635.0 5674.2 5686.8 5570.2 5570.6 5591.7 5593.2 5601.5 4095.2 4175.7 4278.2 4279.6 4285.6 4236.2 4309.9 4312.0 4318.3 4352.6 4270.8 4279.7 4280.0 4284.3 4297.1 4271.8 4291.1 4298.9 4302.1 4302.3 3798.5 3802.1 3807.8 3809.3 3813.3 5238.6 5317.4 5346.1 5352.8 5385.5 4961.9 4965.2 4965.6 4971.4 4982.4 5855.0 5864.6 5866.9 5870.4 5878.9 4033.3 4106.8 4124.7 4127.6 4130.9 6179.3 6193.5 6201.0 6202.3 6202.5 4255.0 4257.0 4265.5 4268.6 4276.0 4330.3 4331.8 4333.6 4336.7 4348.1 4846.7 4932.6 4939.3 4941.1 4946.7 5886.8 5890.8 5893.6 5897.4 5900.2 1515.7 1540.7 1541.8 1543.9 1544.5 1051.8 1053.8 1060.9 1069.9 1082.7 5139.6 5145.7 5151.1 5153.0 5153.4 6026.7 6110.5 6137.6 6158.5 6213.1 5158.4 5172.4 5173.0 5179.9 5197.5 3295.1 3330.6 3332.8 3348.3 3348.7 5701.9 5808.3 5851.6 5855.5 5861.9 6347.7 6364.7 6368.7 6369.9 6372.4 5817.6 5833.6 5846.1 5849.1 5857.6 6040.4 6176.4 6179.9 6187.8 6188.7 5985.8 6029.7 6040.3 6044.0 6046.0 5840.7 5842.8 5847.9 5849.9 5860.2 4142.0 4190.6 4192.8 4196.3 4199.8 5989.3 6158.3 6164.2 6167.8 6180.4 5891.9 5906.4 5912.2 5919.6 5926.4 5944.1 5946.6 5956.9 5961.8 5966.5 5710.5 5802.4 5807.8 5823.9 5828.7 5987.1 5993.8 5994.8 6001.2 6007.9 5668.2 5824.7 5829.5 5831.0 5843.9 04:40:02 INFO - 2015-12-17 04:40:02,871 DEBUG : BROWSER_OUTPUT: 04:40:02 INFO - 2015-12-17 04:40:02,871 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12399.11 Median:43456.06 stddev:13943.08 (32.1%) stddev-sans-first:13954.11 04:40:02 INFO - 2015-12-17 04:40:02,873 DEBUG : BROWSER_OUTPUT: Values: 614.2 641.0 648.4 655.0 720.8 11599.3 11766.0 11865.8 11869.5 11885.7 10368.9 11812.0 11919.5 11938.0 11952.5 627.1 824.6 836.6 837.1 837.1 819.9 821.6 821.7 823.0 828.0 856.1 863.5 868.2 868.3 869.0 854.2 854.6 856.0 857.8 863.0 640.2 640.8 642.1 644.1 644.8 11045.6 11047.8 11054.6 11066.9 11090.6 10944.6 11118.6 11319.5 11374.9 11803.0 9321.2 9606.5 9696.1 9697.6 10020.5 3248.2 3288.7 3300.1 3331.5 3406.2 41655.0 41796.2 41856.0 42022.2 42023.4 8902.0 8984.5 9260.8 9326.0 9362.7 16253.0 16544.8 16569.0 16582.9 16616.6 5928.6 5953.9 6126.2 6214.2 6374.1 3361.4 3378.0 3563.9 3610.3 3618.2 2565.4 2579.6 2583.5 2585.5 2592.2 464.2 482.4 484.2 496.6 514.9 478.8 583.4 604.8 612.2 617.4 7724.7 7724.8 7772.8 7912.5 7991.2 520.1 539.8 556.4 568.4 608.9 3870.7 3881.5 3888.6 4007.4 4017.5 48571.0 49068.3 49126.3 49160.3 49205.3 44219.3 44240.0 46844.5 49462.8 49592.3 40004.0 40111.8 41033.0 42601.6 42692.8 8374.6 8415.6 8505.8 8824.6 8865.0 29094.6 29530.3 30285.8 31221.5 31866.5 38294.2 38324.0 38868.1 38961.0 38999.2 11155.1 11227.9 11267.4 11429.6 11469.7 11327.3 11439.2 11568.9 11769.7 12126.0 10829.6 11404.8 11406.4 11554.7 11913.8 10785.3 10798.0 10830.6 10877.7 10916.1 11018.9 11032.9 11061.3 11098.7 11583.6 8691.6 8810.7 8873.6 9073.1 9909.6 9277.5 9493.6 9526.5 9629.6 9644.5 04:40:02 INFO - 2015-12-17 04:40:02,873 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:40:02 INFO - 2015-12-17 04:40:02,873 DEBUG : BROWSER_OUTPUT: 04:40:03 INFO - 2015-12-17 04:40:03,477 INFO : Browser exited with error code: 0 04:40:03 INFO - 2015-12-17 04:40:03,500 INFO : Completed test dromaeo_css (00:18:33) 04:40:03 INFO - 2015-12-17 04:40:03,500 INFO : Starting test kraken 04:40:03 INFO - 2015-12-17 04:40:03,500 DEBUG : operating with platform_type : linux_ 04:40:03 INFO - 2015-12-17 04:40:03,500 INFO : Initialising browser for kraken test... 04:40:03 INFO - 2015-12-17 04:40:03,507 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaoPxyT/profile http://localhost:40608/getInfo.html 04:40:08 INFO - 2015-12-17 04:40:08,434 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:40:08 INFO - 2015-12-17 04:40:08,434 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:40:08 INFO - 2015-12-17 04:40:08,435 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:40:08 INFO - 2015-12-17 04:40:08,435 DEBUG : BROWSER_OUTPUT: __metrics 04:40:08 INFO - 2015-12-17 04:40:08,591 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:40:09 INFO - 2015-12-17 04:40:09,536 INFO : Browser initialized. 04:40:09 INFO - 2015-12-17 04:40:09,537 INFO : Running cycle 1/1 for kraken test... 04:40:09 INFO - 2015-12-17 04:40:09,537 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaoPxyT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:40:21 INFO - 2015-12-17 04:40:21,604 DEBUG : BROWSER_OUTPUT: RSS: Main: 143331328 04:40:21 INFO - 2015-12-17 04:40:21,604 DEBUG : BROWSER_OUTPUT: 04:40:24 INFO - 2015-12-17 04:40:24,187 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40608/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40608/tests/kraken/driver.html?testName=audio-beat-detection) 04:40:24 INFO - 2015-12-17 04:40:24,809 DEBUG : BROWSER_OUTPUT: RSS: Main: 141963264 04:40:24 INFO - 2015-12-17 04:40:24,809 DEBUG : BROWSER_OUTPUT: 04:40:27 INFO - 2015-12-17 04:40:27,552 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40608/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40608/tests/kraken/driver.html?testName=audio-dft) 04:40:28 INFO - 2015-12-17 04:40:28,155 DEBUG : BROWSER_OUTPUT: RSS: Main: 142893056 04:40:28 INFO - 2015-12-17 04:40:28,155 DEBUG : BROWSER_OUTPUT: 04:40:31 INFO - 2015-12-17 04:40:31,055 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40608/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40608/tests/kraken/driver.html?testName=audio-fft) 04:40:31 INFO - 2015-12-17 04:40:31,637 DEBUG : BROWSER_OUTPUT: RSS: Main: 137867264 04:40:31 INFO - 2015-12-17 04:40:31,638 DEBUG : BROWSER_OUTPUT: 04:40:33 INFO - 2015-12-17 04:40:33,715 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40608/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40608/tests/kraken/driver.html?testName=audio-oscillator) 04:40:34 INFO - 2015-12-17 04:40:34,301 DEBUG : BROWSER_OUTPUT: RSS: Main: 139075584 04:40:34 INFO - 2015-12-17 04:40:34,301 DEBUG : BROWSER_OUTPUT: 04:40:36 INFO - 2015-12-17 04:40:36,590 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40608/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40608/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:40:37 INFO - 2015-12-17 04:40:37,177 DEBUG : BROWSER_OUTPUT: RSS: Main: 141053952 04:40:37 INFO - 2015-12-17 04:40:37,177 DEBUG : BROWSER_OUTPUT: 04:40:40 INFO - 2015-12-17 04:40:40,231 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40608/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40608/tests/kraken/driver.html?testName=imaging-darkroom) 04:40:40 INFO - 2015-12-17 04:40:40,833 DEBUG : BROWSER_OUTPUT: RSS: Main: 141561856 04:40:40 INFO - 2015-12-17 04:40:40,834 DEBUG : BROWSER_OUTPUT: 04:40:44 INFO - 2015-12-17 04:40:44,316 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40608/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40608/tests/kraken/driver.html?testName=imaging-desaturate) 04:40:44 INFO - 2015-12-17 04:40:44,909 DEBUG : BROWSER_OUTPUT: RSS: Main: 139071488 04:40:44 INFO - 2015-12-17 04:40:44,910 DEBUG : BROWSER_OUTPUT: 04:40:47 INFO - 2015-12-17 04:40:47,833 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40608/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40608/tests/kraken/driver.html?testName=json-parse-financial) 04:40:48 INFO - 2015-12-17 04:40:48,436 DEBUG : BROWSER_OUTPUT: RSS: Main: 139452416 04:40:48 INFO - 2015-12-17 04:40:48,436 DEBUG : BROWSER_OUTPUT: 04:40:50 INFO - 2015-12-17 04:40:50,238 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40608/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40608/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:40:50 INFO - 2015-12-17 04:40:50,823 DEBUG : BROWSER_OUTPUT: RSS: Main: 140828672 04:40:50 INFO - 2015-12-17 04:40:50,824 DEBUG : BROWSER_OUTPUT: 04:40:52 INFO - 2015-12-17 04:40:52,714 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40608/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40608/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:40:53 INFO - 2015-12-17 04:40:53,323 DEBUG : BROWSER_OUTPUT: RSS: Main: 140050432 04:40:53 INFO - 2015-12-17 04:40:53,323 DEBUG : BROWSER_OUTPUT: 04:40:55 INFO - 2015-12-17 04:40:55,498 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40608/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40608/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:40:56 INFO - 2015-12-17 04:40:56,091 DEBUG : BROWSER_OUTPUT: RSS: Main: 140242944 04:40:56 INFO - 2015-12-17 04:40:56,091 DEBUG : BROWSER_OUTPUT: 04:40:58 INFO - 2015-12-17 04:40:58,680 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40608/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40608/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:40:59 INFO - 2015-12-17 04:40:59,286 DEBUG : BROWSER_OUTPUT: RSS: Main: 140783616 04:40:59 INFO - 2015-12-17 04:40:59,286 DEBUG : BROWSER_OUTPUT: 04:41:01 INFO - 2015-12-17 04:41:01,927 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40608/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40608/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:41:02 INFO - 2015-12-17 04:41:02,522 DEBUG : BROWSER_OUTPUT: RSS: Main: 141316096 04:41:02 INFO - 2015-12-17 04:41:02,522 DEBUG : BROWSER_OUTPUT: 04:41:04 INFO - 2015-12-17 04:41:04,316 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40608/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40608/tests/kraken/driver.html?testName=ai-astar) 04:41:04 INFO - 2015-12-17 04:41:04,566 DEBUG : BROWSER_OUTPUT: RSS: Main: 140476416 04:41:04 INFO - 2015-12-17 04:41:04,566 DEBUG : BROWSER_OUTPUT: 04:41:04 INFO - 2015-12-17 04:41:04,566 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:41:04 INFO - 2015-12-17 04:41:04,566 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:41:04 INFO - 2015-12-17 04:41:04,567 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:41:04 INFO - 2015-12-17 04:41:04,567 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:41:04 INFO - 2015-12-17 04:41:04,567 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;111;113;116;114;129;119;115;119;115 04:41:04 INFO - 2015-12-17 04:41:04,567 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;166;136;150;177;129;154;157;132;167;134 04:41:04 INFO - 2015-12-17 04:41:04,567 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;162;163;166;171;162;163;165;164 04:41:04 INFO - 2015-12-17 04:41:04,567 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;72;73;73;133;71;72;71;72;87 04:41:04 INFO - 2015-12-17 04:41:04,567 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;96;136;94;97;95;139;95;96;132 04:41:04 INFO - 2015-12-17 04:41:04,567 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;111;110;110;111;110;111 04:41:04 INFO - 2015-12-17 04:41:04,567 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;148;149;148;147;147;149;149;148 04:41:04 INFO - 2015-12-17 04:41:04,568 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;96;95;96;97;96;96 04:41:04 INFO - 2015-12-17 04:41:04,568 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;74;77;75;74;77;75;82;72;74 04:41:04 INFO - 2015-12-17 04:41:04,568 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;67;69;68;69;69;68;69;69 04:41:04 INFO - 2015-12-17 04:41:04,568 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;87;85;86;88;95;87;88;86;86 04:41:04 INFO - 2015-12-17 04:41:04,568 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;124;123;124;127;134;131;124;127;122;120 04:41:04 INFO - 2015-12-17 04:41:04,569 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;152;153;152;153;142;143;154;152;143 04:41:04 INFO - 2015-12-17 04:41:04,569 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;72;69;74;73;74;73;72;71;71 04:41:04 INFO - 2015-12-17 04:41:04,569 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:41:04 INFO - 2015-12-17 04:41:04,569 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:41:04 INFO - 2015-12-17 04:41:04,569 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,802 04:41:04 INFO - 2015-12-17 04:41:04,570 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:41:04 INFO - 2015-12-17 04:41:04,570 DEBUG : BROWSER_OUTPUT: __startTimestamp1450356064565__endTimestamp 04:41:04 INFO - 2015-12-17 04:41:04,570 DEBUG : BROWSER_OUTPUT: 04:41:04 INFO - 2015-12-17 04:41:04,573 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:41:04 INFO - 2015-12-17 04:41:04,574 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:41:04 INFO - 2015-12-17 04:41:04,574 DEBUG : BROWSER_OUTPUT: 04:41:04 INFO - 2015-12-17 04:41:04,574 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:116.60 Median:115.50 stddev:4.99 (4.3%) stddev-sans-first:5.26 04:41:04 INFO - 2015-12-17 04:41:04,575 DEBUG : BROWSER_OUTPUT: Values: 115.0 111.0 113.0 116.0 114.0 129.0 119.0 115.0 119.0 115.0 04:41:04 INFO - 2015-12-17 04:41:04,575 DEBUG : BROWSER_OUTPUT: 04:41:04 INFO - 2015-12-17 04:41:04,575 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.20 Median:155.50 stddev:16.85 (10.8%) stddev-sans-first:16.88 04:41:04 INFO - 2015-12-17 04:41:04,575 DEBUG : BROWSER_OUTPUT: Values: 166.0 136.0 150.0 177.0 129.0 154.0 157.0 132.0 167.0 134.0 04:41:04 INFO - 2015-12-17 04:41:04,575 DEBUG : BROWSER_OUTPUT: 04:41:04 INFO - 2015-12-17 04:41:04,576 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.00 Median:163.50 stddev:2.83 (1.7%) stddev-sans-first:2.91 04:41:04 INFO - 2015-12-17 04:41:04,576 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 162.0 163.0 166.0 171.0 162.0 163.0 165.0 164.0 04:41:04 INFO - 2015-12-17 04:41:04,576 DEBUG : BROWSER_OUTPUT: 04:41:04 INFO - 2015-12-17 04:41:04,576 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.80 Median:72.50 stddev:19.28 (26.6%) stddev-sans-first:20.34 04:41:04 INFO - 2015-12-17 04:41:04,576 DEBUG : BROWSER_OUTPUT: Values: 74.0 72.0 73.0 73.0 133.0 71.0 72.0 71.0 72.0 87.0 04:41:04 INFO - 2015-12-17 04:41:04,577 DEBUG : BROWSER_OUTPUT: 04:41:04 INFO - 2015-12-17 04:41:04,577 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.40 Median:95.00 stddev:19.60 (20.6%) stddev-sans-first:20.18 04:41:04 INFO - 2015-12-17 04:41:04,577 DEBUG : BROWSER_OUTPUT: Values: 94.0 96.0 136.0 94.0 97.0 95.0 139.0 95.0 96.0 132.0 04:41:04 INFO - 2015-12-17 04:41:04,577 DEBUG : BROWSER_OUTPUT: 04:41:04 INFO - 2015-12-17 04:41:04,577 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.30 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 04:41:04 INFO - 2015-12-17 04:41:04,577 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 111.0 110.0 110.0 111.0 110.0 111.0 04:41:04 INFO - 2015-12-17 04:41:04,577 DEBUG : BROWSER_OUTPUT: 04:41:04 INFO - 2015-12-17 04:41:04,577 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:1.03 (0.7%) stddev-sans-first:0.87 04:41:04 INFO - 2015-12-17 04:41:04,578 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 148.0 149.0 148.0 147.0 147.0 149.0 149.0 148.0 04:41:04 INFO - 2015-12-17 04:41:04,578 DEBUG : BROWSER_OUTPUT: 04:41:04 INFO - 2015-12-17 04:41:04,578 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 04:41:04 INFO - 2015-12-17 04:41:04,578 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 96.0 95.0 96.0 97.0 96.0 96.0 04:41:04 INFO - 2015-12-17 04:41:04,578 DEBUG : BROWSER_OUTPUT: 04:41:04 INFO - 2015-12-17 04:41:04,578 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:75.40 Median:75.00 stddev:2.76 (3.7%) stddev-sans-first:2.88 04:41:04 INFO - 2015-12-17 04:41:04,578 DEBUG : BROWSER_OUTPUT: Values: 74.0 74.0 77.0 75.0 74.0 77.0 75.0 82.0 72.0 74.0 04:41:04 INFO - 2015-12-17 04:41:04,578 DEBUG : BROWSER_OUTPUT: 04:41:04 INFO - 2015-12-17 04:41:04,579 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 04:41:04 INFO - 2015-12-17 04:41:04,579 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 67.0 69.0 68.0 69.0 69.0 68.0 69.0 69.0 04:41:04 INFO - 2015-12-17 04:41:04,579 DEBUG : BROWSER_OUTPUT: 04:41:04 INFO - 2015-12-17 04:41:04,579 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:87.00 stddev:3.01 (3.5%) stddev-sans-first:2.96 04:41:04 INFO - 2015-12-17 04:41:04,579 DEBUG : BROWSER_OUTPUT: Values: 84.0 87.0 85.0 86.0 88.0 95.0 87.0 88.0 86.0 86.0 04:41:04 INFO - 2015-12-17 04:41:04,579 DEBUG : BROWSER_OUTPUT: 04:41:04 INFO - 2015-12-17 04:41:04,579 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.60 Median:125.50 stddev:4.25 (3.4%) stddev-sans-first:4.47 04:41:04 INFO - 2015-12-17 04:41:04,579 DEBUG : BROWSER_OUTPUT: Values: 124.0 123.0 124.0 127.0 134.0 131.0 124.0 127.0 122.0 120.0 04:41:04 INFO - 2015-12-17 04:41:04,579 DEBUG : BROWSER_OUTPUT: 04:41:04 INFO - 2015-12-17 04:41:04,579 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.50 Median:152.00 stddev:5.44 (3.6%) stddev-sans-first:5.05 04:41:04 INFO - 2015-12-17 04:41:04,580 DEBUG : BROWSER_OUTPUT: Values: 141.0 152.0 153.0 152.0 153.0 142.0 143.0 154.0 152.0 143.0 04:41:04 INFO - 2015-12-17 04:41:04,580 DEBUG : BROWSER_OUTPUT: 04:41:04 INFO - 2015-12-17 04:41:04,580 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:72.50 stddev:1.52 (2.1%) stddev-sans-first:1.62 04:41:04 INFO - 2015-12-17 04:41:04,580 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 69.0 74.0 73.0 74.0 73.0 72.0 71.0 71.0 04:41:04 INFO - 2015-12-17 04:41:04,580 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:41:04 INFO - 2015-12-17 04:41:04,580 DEBUG : BROWSER_OUTPUT: 04:41:05 INFO - 2015-12-17 04:41:05,517 INFO : Browser exited with error code: 0 04:41:05 INFO - 2015-12-17 04:41:05,565 INFO : Completed test kraken (00:01:02) 04:41:05 INFO - 2015-12-17 04:41:05,566 INFO : Starting test v8_7 04:41:05 INFO - 2015-12-17 04:41:05,566 DEBUG : operating with platform_type : linux_ 04:41:05 INFO - 2015-12-17 04:41:05,566 INFO : Initialising browser for v8_7 test... 04:41:05 INFO - 2015-12-17 04:41:05,572 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUhPjr2/profile http://localhost:40608/getInfo.html 04:41:10 INFO - 2015-12-17 04:41:10,466 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:41:10 INFO - 2015-12-17 04:41:10,466 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:41:10 INFO - 2015-12-17 04:41:10,466 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:41:10 INFO - 2015-12-17 04:41:10,466 DEBUG : BROWSER_OUTPUT: __metrics 04:41:10 INFO - 2015-12-17 04:41:10,609 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:41:11 INFO - 2015-12-17 04:41:11,489 INFO : Browser initialized. 04:41:11 INFO - 2015-12-17 04:41:11,489 INFO : Running cycle 1/1 for v8_7 test... 04:41:11 INFO - 2015-12-17 04:41:11,489 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUhPjr2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:41:23 INFO - 2015-12-17 04:41:23,586 DEBUG : BROWSER_OUTPUT: RSS: Main: 143093760 04:41:23 INFO - 2015-12-17 04:41:23,587 DEBUG : BROWSER_OUTPUT: 04:41:45 INFO - 2015-12-17 04:41:45,127 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40608/tests/v8_7/run.html (next: http://localhost:40608/tests/v8_7/run.html) 04:41:45 INFO - 2015-12-17 04:41:45,377 DEBUG : BROWSER_OUTPUT: RSS: Main: 137736192 04:41:45 INFO - 2015-12-17 04:41:45,378 DEBUG : BROWSER_OUTPUT: 04:41:45 INFO - 2015-12-17 04:41:45,378 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:41:45 INFO - 2015-12-17 04:41:45,378 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:41:45 INFO - 2015-12-17 04:41:45,378 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:41:45 INFO - 2015-12-17 04:41:45,378 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:41:45 INFO - 2015-12-17 04:41:45,378 DEBUG : BROWSER_OUTPUT: |0;Richards;167.36401673640168 04:41:45 INFO - 2015-12-17 04:41:45,379 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.70102135561746 04:41:45 INFO - 2015-12-17 04:41:45,379 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.85495971103086 04:41:45 INFO - 2015-12-17 04:41:45,379 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5223.958333333333 04:41:45 INFO - 2015-12-17 04:41:45,379 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1085.7763300760043 04:41:45 INFO - 2015-12-17 04:41:45,379 DEBUG : BROWSER_OUTPUT: |5;Earley;715.8196134574088 04:41:45 INFO - 2015-12-17 04:41:45,379 DEBUG : BROWSER_OUTPUT: |6;Boyer;12256.09756097561 04:41:45 INFO - 2015-12-17 04:41:45,380 DEBUG : BROWSER_OUTPUT: |7;RegExp;26205.128205128207 04:41:45 INFO - 2015-12-17 04:41:45,380 DEBUG : BROWSER_OUTPUT: |8;Splay;595.9475566150179 04:41:45 INFO - 2015-12-17 04:41:45,380 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 04:41:45 INFO - 2015-12-17 04:41:45,380 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:41:45 INFO - 2015-12-17 04:41:45,380 DEBUG : BROWSER_OUTPUT: __startTimestamp1450356105376__endTimestamp 04:41:45 INFO - 2015-12-17 04:41:45,381 DEBUG : BROWSER_OUTPUT: 04:41:45 INFO - 2015-12-17 04:41:45,381 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:41:45 INFO - 2015-12-17 04:41:45,381 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:41:45 INFO - 2015-12-17 04:41:45,381 DEBUG : BROWSER_OUTPUT: 04:41:45 INFO - 2015-12-17 04:41:45,381 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.36 Median:167.36 stddev:0.00 (0.0%) 04:41:45 INFO - 2015-12-17 04:41:45,381 DEBUG : BROWSER_OUTPUT: Values: 167.4 04:41:45 INFO - 2015-12-17 04:41:45,381 DEBUG : BROWSER_OUTPUT: 04:41:45 INFO - 2015-12-17 04:41:45,382 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.70 Median:185.70 stddev:0.00 (0.0%) 04:41:45 INFO - 2015-12-17 04:41:45,382 DEBUG : BROWSER_OUTPUT: Values: 185.7 04:41:45 INFO - 2015-12-17 04:41:45,382 DEBUG : BROWSER_OUTPUT: 04:41:45 INFO - 2015-12-17 04:41:45,382 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.85 Median:277.85 stddev:0.00 (0.0%) 04:41:45 INFO - 2015-12-17 04:41:45,382 DEBUG : BROWSER_OUTPUT: Values: 277.9 04:41:45 INFO - 2015-12-17 04:41:45,382 DEBUG : BROWSER_OUTPUT: 04:41:45 INFO - 2015-12-17 04:41:45,383 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5223.96 Median:5223.96 stddev:0.00 (0.0%) 04:41:45 INFO - 2015-12-17 04:41:45,384 DEBUG : BROWSER_OUTPUT: Values: 5224.0 04:41:45 INFO - 2015-12-17 04:41:45,384 DEBUG : BROWSER_OUTPUT: 04:41:45 INFO - 2015-12-17 04:41:45,384 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1085.78 Median:1085.78 stddev:0.00 (0.0%) 04:41:45 INFO - 2015-12-17 04:41:45,385 DEBUG : BROWSER_OUTPUT: Values: 1085.8 04:41:45 INFO - 2015-12-17 04:41:45,385 DEBUG : BROWSER_OUTPUT: 04:41:45 INFO - 2015-12-17 04:41:45,385 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:715.82 Median:715.82 stddev:0.00 (0.0%) 04:41:45 INFO - 2015-12-17 04:41:45,385 DEBUG : BROWSER_OUTPUT: Values: 715.8 04:41:45 INFO - 2015-12-17 04:41:45,385 DEBUG : BROWSER_OUTPUT: 04:41:45 INFO - 2015-12-17 04:41:45,385 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12256.10 Median:12256.10 stddev:0.00 (0.0%) 04:41:45 INFO - 2015-12-17 04:41:45,385 DEBUG : BROWSER_OUTPUT: Values: 12256.1 04:41:45 INFO - 2015-12-17 04:41:45,385 DEBUG : BROWSER_OUTPUT: 04:41:45 INFO - 2015-12-17 04:41:45,386 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26205.13 Median:26205.13 stddev:0.00 (0.0%) 04:41:45 INFO - 2015-12-17 04:41:45,386 DEBUG : BROWSER_OUTPUT: Values: 26205.1 04:41:45 INFO - 2015-12-17 04:41:45,386 DEBUG : BROWSER_OUTPUT: 04:41:45 INFO - 2015-12-17 04:41:45,386 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:595.95 Median:595.95 stddev:0.00 (0.0%) 04:41:45 INFO - 2015-12-17 04:41:45,386 DEBUG : BROWSER_OUTPUT: Values: 595.9 04:41:45 INFO - 2015-12-17 04:41:45,386 DEBUG : BROWSER_OUTPUT: 04:41:45 INFO - 2015-12-17 04:41:45,386 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 04:41:45 INFO - 2015-12-17 04:41:45,387 DEBUG : BROWSER_OUTPUT: Values: 4830.9 04:41:45 INFO - 2015-12-17 04:41:45,387 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:41:45 INFO - 2015-12-17 04:41:45,387 DEBUG : BROWSER_OUTPUT: 04:41:46 INFO - 2015-12-17 04:41:46,305 INFO : Browser exited with error code: 0 04:41:46 INFO - 2015-12-17 04:41:46,317 INFO : Completed test v8_7 (00:00:40) 04:41:46 INFO - 2015-12-17 04:41:46,331 INFO : Completed test suite (00:20:16) 04:41:46 INFO - 2015-12-17 04:41:46,331 DEBUG : Working with test: dromaeo_css 04:41:46 INFO - 2015-12-17 04:41:46,331 DEBUG : Generating results file: dromaeo_css 04:41:46 INFO - 2015-12-17 04:41:46,333 DEBUG : Working with test: kraken 04:41:46 INFO - 2015-12-17 04:41:46,333 DEBUG : Generating results file: kraken 04:41:46 INFO - 2015-12-17 04:41:46,333 INFO : javascript benchmark 04:41:46 INFO - 2015-12-17 04:41:46,333 DEBUG : Working with test: v8_7 04:41:46 INFO - 2015-12-17 04:41:46,333 DEBUG : Generating results file: v8_7 04:41:46 INFO - 2015-12-17 04:41:46,334 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:41:46 INFO - 2015-12-17 04:41:46,389 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 04:41:46 INFO - 2015-12-17 04:41:46,389 DEBUG : process_Request line: dromaeo_css 6385.18 graph.html#tests=[[72,94,43]] 04:41:46 INFO - 2015-12-17 04:41:46,390 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:41:46 INFO - 2015-12-17 04:41:46,421 DEBUG : process_Request line: kraken 1549.50 graph.html#tests=[[232,94,43]] 04:41:46 INFO - 2015-12-17 04:41:46,421 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:41:46 INFO - 2015-12-17 04:41:46,451 DEBUG : process_Request line: v8_7 21302.11 graph.html#tests=[[230,94,43]] 04:41:46 INFO - 2015-12-17 04:41:46,453 INFO : javascript benchmark 04:41:46 INFO - 2015-12-17 04:41:46,457 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2679.0175270299974, 2733.576295674171, 2755.2973991632143, 2764.2398340456384, 2790.065328115082, 4705.976470117645, 4783.904321913559, 4830.130576496229, 4831.492693267209, 4852.636052296074, 4675.1351000065015, 4800.087983283173, 4804.759762011903, 4806.327114204014, 4898.387701537308, 4439.067795762886, 4506.375627827089, 4522.072975040125, 4564.497905230422, 4600.378948841897, 120.81108395870429, 4292.892677683068, 4396.714213576107, 4399.494058183302, 4403.867883963486, 4375.7593332366705, 4394.630444740981, 4428.800703968329, 4446.0, 4468.441444819414, 4442.800073996646, 4448.911021779579, 4450.532694067141, 4469.7541635210055, 4482.618977386926, 4256.638185754215, 4296.914061718748, 4353.325234588644, 4399.450068741407, 4428.955710442919, 4695.976520117411, 4715.339852420664, 4728.196206644879, 4731.929021064687, 4769.117713223065, 5100.566451851597, 5132.5124113209185, 5143.897122057575, 5152.330197074394, 5182.455842136559, 4974.726390048582, 5088.974555127238, 5141.948580514184, 5220.3735551734035, 5257.13257312543, 4785.665003449794, 4797.52024797521, 4825.059113472874, 4828.155072862271, 4880.341153944243, 5054.949450505522, 5308.92036619451, 5309.123994540858, 5320.042392369333, 5328.413874473805, 4963.528464795839, 4964.751762411865, 5036.7733451994745, 5053.620978426633, 5101.336826212569, 5167.173252279617, 5176.352955880515, 5176.430592634807, 5180.678926873623, 5218.425973142951, 4830.29960655703, 4956.628252881048, 5096.490350964874, 5115.437301896788, 5128.564072053917, 4987.426445958761, 5040.84877453677, 5053.469385714447, 5068.923966140511, 5106.106431374495, 4282.657387409, 4286.935695964563, 4291.420658211102, 4291.978540107342, 4329.242382583036, 3613.728970327236, 3621.1128273573145, 3730.3285408626166, 3753.249350129985, 3768.773873567595, 4478.373027776114, 4490.887727806766, 4507.932381014288, 4511.075229577994, 4519.728816271035, 5153.175491921274, 5155.278261043457, 5170.37955445349, 5174.534291913746, 5218.321618189611, 4269.231538323132, 4349.304111342233, 4369.781510924505, 4473.0, 4478.820847166142, 4529.705569137996, 4538.909221815546, 4546.818127274938, 4551.40831691878, 4588.587027167571, 4896.6572339935865, 4904.337914381513, 4905.411350637946, 4907.214845624683, 4907.484714105039, 4944.851654450372, 5054.7978080876355, 5067.0, 5099.413567439792, 5128.923066153936, 4873.293372461044, 4875.0493653737185, 4912.975435122801, 4916.0, 4958.950410495849, 4890.510948905223, 5105.540501354896, 5110.131277682728, 5124.256982737407, 5155.175171972466, 5053.2420136979745, 5107.157319042465, 5159.329287192641, 5166.199239117943, 5225.81709640176, 4959.20652695567, 4999.525045120708, 4999.625028122832, 5011.09800235961, 5024.070546948826, 4748.4776674566465, 4862.3922009748785, 5030.37120359955, 5035.5468007878, 5059.924101138412, 4808.2787581863, 4829.855104346875, 4853.0, 4893.804247830047, 4925.335079764186, 5049.671343761422, 5059.949400505948, 5111.718855462986, 5116.155834287301, 5146.8970620588125, 4759.904801904012, 4877.804887804448, 4890.755462226945, 4987.301777751045, 5025.120603894377], "unit": "score", "name": "dojo.html", "value": 4676.426401529568}, {"lowerIsBetter": false, "replicates": [545.9980934984303, 561.1274468201947, 573.6042130929658, 578.0895090232882, 579.6898659217318, 35233.82383088084, 36095.45856812143, 36177.63822361775, 36185.45721814172, 36231.81884090576, 40824.18351632966, 41295.38056929141, 41416.0, 41507.377389339184, 41522.377164342484, 7946.523208607473, 8120.472169309006, 8120.878186827203, 8152.510849349058, 8169.060558035842, 7790.298873101419, 7875.763727088197, 7878.212178782133, 7888.171741967097, 7891.881621775678, 7937.920620793776, 8074.3136833369235, 8081.0, 8083.514989100643, 8112.269895709385, 7961.880571791427, 8092.676292948275, 8107.310878575328, 8115.675372985073, 8128.471649342833, 7905.96047019767, 7959.164287749819, 7994.360451163893, 8026.558539280337, 8026.919730802676, 38013.42979855304, 38289.0, 38323.233535329135, 38367.42448863269, 38394.0401489965, 2262.4277513905004, 2691.4078902641386, 2803.4393121375806, 3002.234430220302, 3380.6281309055985, 27101.86449067742, 27139.592906106423, 27166.0, 27178.32054198641, 28193.295167620767, 3218.1954511372155, 3239.6598357172393, 3307.3219989902013, 3395.6774106459848, 3438.8796392126405, 170085.14957425135, 170485.0, 170722.0, 171657.0, 173284.0, 39142.0, 39345.21309573793, 39574.406383904265, 39584.802075989435, 50628.0, 36463.088422789115, 36644.26711465756, 36680.633193668255, 36733.44899826505, 36823.26353472916, 13312.534061307808, 13336.599902002956, 13412.0, 13433.328333583477, 13447.865521344856, 10018.048285412875, 10035.69892903214, 10051.447170405698, 10067.093961543349, 10187.930267321974, 13464.394102265422, 13473.932630336785, 13479.123856949267, 13527.526536571173, 13579.117357371739, 5582.49757521825, 5617.32592088952, 5624.240727501735, 5634.3802181759975, 5991.460768530853, 817.284875733733, 849.3544905871582, 871.9825603487894, 880.0935036911991, 972.1202311907734, 26273.34316642061, 26591.601125983125, 27169.728302717114, 27182.5922611161, 27460.725392746215, 922.7462447826767, 942.6323733743845, 963.4026903319987, 975.0401692597787, 992.717075633441, 14166.362513686703, 14262.57212283633, 14408.639784005274, 14432.278386080654, 14529.78205326921, 260293.0, 263901.0, 264291.0, 264309.0, 265552.0, 47135.29297060547, 47467.28799068017, 47626.0, 47691.76154119207, 47767.76116119397, 1213.805791073424, 1224.9832638909684, 1228.0666693313146, 1230.2679905456419, 1234.9814752778716, 25611.0, 26302.0, 26473.33816654522, 26701.931922723652, 26759.331016724736, 42037.159256814084, 42823.143537129705, 42942.0, 42975.355369668854, 43070.78464607657, 191099.0, 192932.0, 194291.0, 194390.0, 194702.0, 36876.446853297755, 42835.357469638606, 43449.0, 43840.61593840591, 44322.77838610915, 39941.80029099836, 40133.0, 43043.56956430521, 43675.344869826346, 47326.763366182946, 33622.327553448304, 34000.0, 34098.659013409546, 34332.82833585816, 34763.65236347604, 33898.49152262669, 34269.82865085659, 34465.48301775425, 38839.41740873833, 40623.796881015405, 33446.0, 33869.83065084659, 34032.829835850665, 34378.0, 34434.0, 29326.26684332909, 30794.384112318075, 31176.376472470878, 31227.84386078055, 31272.68727312789, 24313.0, 24548.263552093467, 24589.38526536851, 24920.626190606792, 24966.126185583416], "unit": "score", "name": "ext.html", "value": 16340.307000619472}, {"lowerIsBetter": false, "replicates": [339.2553345406833, 341.97948123112616, 344.6157534349201, 345.64053384480144, 345.716512459783, 12561.371931403428, 14708.77936830947, 14939.477118300862, 16092.597685057879, 16726.16369181542, 10180.236482263823, 10441.112505437048, 14944.476943306987, 16243.269052892618, 16341.918290408561, 4567.543245675431, 4660.0, 5175.8188463403785, 5191.948080519203, 5212.713300768456, 5125.666831655949, 5140.126178549637, 5179.585633149358, 5181.792728290864, 5185.662931909433, 3347.1130150510135, 3473.791572505645, 5109.156989096813, 5127.102757017507, 5145.794168233285, 5229.921551176735, 5241.371035475749, 5269.710165940872, 5295.841124766263, 5301.681899086047, 4986.052649996525, 5077.416097148838, 5081.8475445736685, 5086.237064440364, 5102.132637451642, 11064.336139831636, 11269.380184089872, 11270.154738394653, 11570.826437603442, 17303.653926921517, 1754.2719771294896, 1852.8517718582482, 1859.8140185981295, 1875.4561177258715, 1884.180381534037, 8873.73378798637, 8922.10778922109, 9063.595142752883, 9173.08269173084, 9261.6295348186, 1630.315267587616, 1668.9248983795758, 1708.487453763866, 1714.322842477227, 1722.86512370311, 53698.463015369736, 54650.72674636601, 55444.72277638626, 55770.44229557693, 57074.0, 9709.271804614682, 9830.0, 9855.90144098564, 9914.603415863428, 9968.501574921225, 12600.180988235736, 12689.619311420673, 12699.619011429671, 12705.428255728515, 12714.872851271553, 7177.497575169688, 7177.856442871113, 7270.236625154388, 7316.414686825041, 7419.703211871465, 6992.1259842519685, 7010.684519196649, 7013.6142512161305, 7044.330788575077, 7065.399441047569, 4184.456020717287, 4189.371594260885, 4205.9789701051295, 4220.240356735756, 4253.574642535722, 1687.2829047654698, 1688.2993557673428, 1714.6484970581, 1777.0759205213217, 1796.6676164909272, 760.9124950630637, 807.4267270238079, 854.5855260198798, 897.4839467306325, 943.5801068524578, 14568.34442450071, 14666.56000319992, 15185.468508602145, 15298.541043768704, 15351.309191086428, 824.9687890137328, 826.8428998490388, 840.8948881389827, 879.7184900831672, 908.6819613135482, 8103.3112185463715, 8612.741617751477, 8643.308535317285, 8667.263282620921, 8961.372703910794, 459883.0, 475481.0, 484615.0, 485940.0, 488043.0, 69234.65382673054, 71077.28922710811, 71471.64264178646, 71904.2809571908, 72161.0, 1094.2121672396022, 1102.2449622008949, 1155.8786327435666, 1166.7666466706692, 1171.6133675886938, 13277.40251688657, 13341.666458338232, 13490.32548372597, 13562.926014984023, 13705.931470342584, 30839.074827755205, 31111.53332699966, 31181.68818311788, 31797.682023180398, 32567.18582035468, 41907.371389428576, 44151.33772993343, 44555.0, 44749.55250447454, 44942.10115797731, 8384.874226886725, 8630.439021463584, 8668.78328041804, 12173.208741432132, 12557.623271301876, 15375.69248614999, 17014.914925425295, 17440.040797756246, 17476.388326408516, 17571.472855814347, 12974.637663045622, 15425.382984680937, 15602.84397156014, 15604.92197539005, 15607.0, 13957.720845583235, 14056.578302650936, 14209.573712788633, 14544.41822327095, 14565.27173641335, 8484.151584841466, 8846.11538846136, 14417.78373324422, 14703.41186352534, 14812.259387030821, 13403.128796628189, 13438.260895650834, 13614.727705446034, 13622.795658064939, 13629.591112266648, 13503.189808611121, 13567.38946747379, 13691.178529288274, 13766.793498097337, 14078.718425631225], "unit": "score", "name": "jquery.html", "value": 8279.25232577851}, {"lowerIsBetter": false, "replicates": [1484.4433337498438, 1629.201691171326, 1717.4504158669224, 1717.467585048635, 1729.2909906938157, 6998.615076170815, 7061.788146355605, 7291.8906216406795, 7475.7009719611215, 7500.174980752113, 7407.814804629874, 7421.0, 7440.107187137538, 7496.137944136426, 7503.399728021759, 2075.491504581376, 2108.420184449273, 2113.830893528514, 2116.354511873878, 2116.798904104108, 2062.164075665862, 2081.510844951435, 2124.2883633982556, 2144.9356519304447, 2145.0454547726267, 1723.6208034232511, 1748.9300427982866, 2041.203930467119, 2068.6793547000166, 2092.529180934293, 2077.4494758888904, 2106.462851972745, 2112.3874076517945, 2122.3420739570784, 2124.0972586650687, 2090.446031801574, 2102.2326850699537, 2111.6304646686767, 2113.123053932616, 2127.9893600532055, 6920.757773477954, 7013.649317534103, 7038.92961070393, 7086.539374940664, 7095.609741464217, 4202.411662367271, 4299.91400171998, 4301.268784306644, 4310.547392523771, 4315.784210789448, 2730.0990673078036, 2745.492083964473, 2827.123591686584, 2835.333696581302, 2842.6588809342807, 896.4531635702216, 898.380117718772, 911.5260064766351, 926.7822061815468, 935.1770442010986, 9680.031996800333, 9901.0, 9906.950465247699, 9935.751606209902, 9977.950110249401, 3830.3296923038356, 3920.3923391874305, 3937.547182074098, 3948.368261078271, 3969.364901615728, 8589.785255368666, 8662.78343041429, 8668.436551624125, 8685.782855428539, 8697.391182617283, 4317.395564620955, 4326.783660816946, 4341.240282950471, 4355.542668019875, 4359.302511598129, 3896.473976013259, 3918.647321741057, 3929.626685464876, 3929.7249192556246, 3938.350172221609, 3286.671332866742, 3394.2023624448234, 3399.7790143640586, 3411.2154204533094, 3417.8120203389053, 1036.0209601926108, 1036.9948150259352, 1045.6340280901622, 1055.9894401055892, 1062.744941214103, 936.4194199596294, 937.2829785214317, 1007.8740157480315, 1054.2462139570243, 1188.4117361905912, 6886.586804791728, 6949.096617439701, 6952.513324067368, 6962.094927659372, 6966.9651651741415, 982.4449186209769, 997.8303688372994, 1062.6387028410377, 1064.882862885082, 1096.1833434091493, 5167.715775632301, 5202.71385073817, 5224.764885580158, 5236.869078272997, 5246.108161612535, 8494.108118647453, 8510.617022234015, 8621.137886211454, 8663.436876603, 8703.651853925772, 8610.483370997761, 8715.823363845926, 8739.956300218459, 8810.911890881009, 8840.292776577859, 6825.761098361633, 6842.384185423336, 6919.965400173068, 6920.30796920314, 6997.16034075904, 6858.451323894176, 6894.655267236719, 6902.275261097512, 6913.1358580177475, 6925.688344024632, 7592.177877309517, 7700.0, 7847.411444141826, 7878.960605196938, 7890.289873911375, 7843.098043724816, 7998.48009879356, 8098.109207986999, 8099.635516401659, 8109.594520273845, 6439.484841212598, 6553.901691474536, 6593.175853018372, 6593.868122637617, 6610.0, 6716.429103526059, 6781.084553585203, 6786.966065169642, 6788.59268443895, 6788.660566971533, 6408.423241908251, 6453.386928241809, 6572.967135164294, 6591.901121483277, 6789.219239787488, 5673.461021202979, 6200.224971878515, 6205.348438413902, 6228.501719862491, 6282.528810339334, 6594.340565943367, 6629.906065499139, 6636.170478690164, 6636.83407914806, 6645.734170633121, 5967.940320596738, 5968.31364393083, 6021.096835474714, 6051.152838602511, 6063.211782468251, 6105.84735381619, 6116.449519543263, 6138.140660307471, 6141.0, 6145.9692701538], "unit": "score", "name": "mootools.html", "value": 4164.695012933265}, {"lowerIsBetter": false, "replicates": [302.94092651932874, 311.2747298793811, 314.6601670196187, 315.9004913452262, 317.8299609708806, 5529.972350138249, 5628.352739434966, 5634.9857025735455, 5674.205611214428, 5686.800961966332, 5570.192322113291, 5570.637908535942, 5591.720413979305, 5593.216949627045, 5601.467860553251, 4095.221907837516, 4175.68682348825, 4278.1871444425615, 4279.593438623326, 4285.57144285572, 4236.216299984498, 4309.870703878889, 4312.029793296499, 4318.309070548713, 4352.608265256126, 4270.7864606769535, 4279.72181808183, 4279.957200428003, 4284.314509678452, 4297.097609502009, 4271.807768650403, 4291.098869237464, 4298.892527686801, 4302.075053863418, 4302.333138363559, 3798.4682144499793, 3802.068493219179, 3807.7905715185652, 3809.314323421783, 3813.2945405100145, 5238.554722848562, 5317.441668624816, 5346.144616861322, 5352.785888564453, 5385.461453854622, 4961.8511444656715, 4965.180745177042, 4965.553100220997, 4971.353724015855, 4982.377202849644, 5855.033919403293, 5864.648121112747, 5866.853328666774, 5870.412958704138, 5878.882422351572, 4033.294173519652, 4106.7946602669745, 4124.731892427013, 4127.628513433805, 4130.896727581804, 6179.258488981306, 6193.5045196384635, 6200.968995155041, 6202.286737025254, 6202.503799696014, 4255.0, 4257.02088519636, 4265.488141422987, 4268.637165840876, 4276.016516201229, 4330.328799036154, 4331.848385306562, 4333.58830911063, 4336.739795612273, 4348.108637729258, 4846.684965477232, 4932.580730637864, 4939.259111133287, 4941.061198372297, 4946.653734238569, 5886.823395298148, 5890.823275301748, 5893.616914900518, 5897.439743224387, 5900.203472531153, 1515.7423238049557, 1540.7457769468137, 1541.8149822021205, 1543.9459618913509, 1544.4903181950153, 1051.784384201237, 1053.7629033467563, 1060.9204309676804, 1069.893010698924, 1082.6697857153486, 5139.58883289336, 5145.691258524501, 5151.07280689472, 5153.0466863630345, 5153.3815942087185, 6026.668533230714, 6110.4500594945775, 6137.631742095399, 6158.476529495043, 6213.099100630474, 5158.432572417031, 5172.405173405106, 5173.042987047408, 5179.870503237449, 5197.506236907488, 3295.07737833407, 3330.6169790474405, 3332.783369081002, 3348.263382055944, 3348.68187522185, 5701.857453563694, 5808.273965754281, 5851.561132915049, 5855.4730074292665, 5861.941380586225, 6347.746090156342, 6364.745410183634, 6368.713407896656, 6369.872602547923, 6372.394622510854, 5817.6218545793545, 5833.562482813806, 5846.123081537803, 5849.064149736022, 5857.619254748428, 6040.426159514839, 6176.444120029039, 6179.938200617937, 6187.81436556904, 6188.721507532262, 5985.790497332572, 6029.698515074317, 6040.305364883095, 6044.032954727222, 6046.0, 5840.707964601838, 5842.795502157404, 5847.853803654943, 5849.94150058494, 5860.208871802252, 4141.97929010353, 4190.580941905907, 4192.769397683157, 4196.2656535105625, 4199.790010499401, 5989.311229208697, 6158.291796443287, 6164.167837342081, 6167.784127555514, 6180.381961803783, 5891.9116213255975, 5906.4093590642315, 5912.172295878494, 5919.644821310563, 5926.407359264039, 5944.138099975393, 5946.583739138218, 5956.851078723066, 5961.821145365646, 5966.522678185822, 5710.457506536873, 5802.390748971297, 5807.796727114531, 5823.94176058234, 5828.679422631626, 5987.101934709828, 5993.820185394445, 5994.820155395345, 6001.159837622649, 6007.939920600913, 5668.234788303526, 5824.737886795019, 5829.53363730892, 5831.0, 5843.883122337615], "unit": "score", "name": "prototype.html", "value": 4439.894981591202}, {"lowerIsBetter": false, "replicates": [614.2475467552247, 640.9936399852234, 648.3743187823749, 654.9967250163749, 720.8342081321296, 11599.304041757501, 11766.0, 11865.7626847463, 11869.525218991252, 11885.702857428558, 10368.948155259213, 11812.0, 11919.463624136913, 11938.0, 11952.462139203735, 627.0907184582351, 824.5918270456102, 836.6318819719335, 837.0833936839151, 837.1210229259253, 819.8975128108987, 821.5563595658338, 821.7411515372669, 822.9711960081398, 827.9503229806201, 856.0797143071223, 863.4905405810571, 868.2229404682805, 868.288003836854, 868.9739307820776, 854.1970547685156, 854.6367793687658, 855.9743207703779, 857.7769779857251, 862.9784255393603, 640.2221301119116, 640.785336912135, 642.1427394428397, 644.0532417346493, 644.8001119652922, 11045.613403530919, 11047.83428248577, 11054.557817687282, 11066.944665276622, 11090.611828585961, 10944.56221751129, 11118.55525778976, 11319.490622921989, 11374.886251137465, 11803.0, 9321.207697345733, 9606.519674016341, 9696.0788725071, 9697.612095516171, 10020.498975051218, 3248.187953011747, 3288.671132886716, 3300.1254667513126, 3331.4669652855428, 3406.1654894550993, 41655.0, 41796.1640767183, 41856.0, 42022.159556809, 42023.369649455286, 8901.955490222637, 8984.46093234408, 9260.7684807879, 9325.953370233105, 9362.672306469241, 16253.0, 16544.83455165457, 16569.0, 16582.917085414738, 16616.58458538522, 5928.555358348141, 5953.880922381615, 6126.172966649446, 6214.161088253119, 6374.075759014917, 3361.411752943225, 3378.015552594435, 3563.8574457021427, 3610.2598967211657, 3618.16782140104, 2565.4356041670803, 2579.5743702288914, 2583.5220484210104, 2585.5475291823855, 2592.196419110082, 464.22474467639125, 482.35605466701645, 484.2469959213457, 496.6498618473967, 514.8661348049534, 478.7582270953216, 583.4486410342271, 604.8125081224835, 612.2316492801506, 617.3949529461153, 7724.6523906424345, 7724.8455030900195, 7772.84454310922, 7912.525248485109, 7991.24083212094, 520.1132069820947, 539.8434454008373, 556.3796367050709, 568.4003376437897, 608.8873558391712, 3870.6903447724117, 3881.4565960765517, 3888.5528164261473, 4007.35882258843, 4017.4777278954134, 48571.0, 49068.26397604039, 49126.26310605344, 49160.26259606109, 49205.261921071215, 44219.33670994938, 44240.0, 46844.5315546847, 49462.75268623634, 49592.256116158285, 40004.0, 40111.79944100261, 41033.0, 42601.57398425976, 42692.78653606712, 8374.623141958748, 8415.621297041525, 8505.82988340242, 8824.5587720615, 8865.0, 29094.563581546718, 29530.261743456587, 30285.848570757003, 31221.531677025316, 31866.522002169524, 38294.234115316984, 38324.0, 38868.08489363253, 38961.0, 38999.2200156001, 11155.107591392507, 11227.887721122685, 11267.436628168723, 11429.59996400122, 11469.655910322703, 11327.263727857993, 11439.167878760709, 11568.942155289169, 11769.705757356134, 12126.029917606747, 10829.620963266563, 11404.828927565926, 11406.429678516208, 11554.711132221762, 11913.82129268079, 10785.298955567863, 10798.0, 10830.620928267474, 10877.728056798644, 10916.12670986335, 11018.889811101786, 11032.944835276094, 11061.336319820837, 11098.667039988813, 11583.594574189863, 8691.608877600396, 8810.691625793066, 8873.556322183995, 9073.092690730875, 9909.55407006672, 9277.48973806447, 9493.572789224363, 9526.47604381738, 9629.56666950003, 9644.469554174588], "unit": "score", "name": "yui.html", "value": 5792.629162300593}], "name": "dromaeo_css", "value": 6385.177691292734}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 111.0, 113.0, 116.0, 114.0, 129.0, 119.0, 115.0, 119.0, 115.0], "unit": "score", "name": "ai-astar", "value": 116.6}, {"lowerIsBetter": true, "replicates": [166.0, 136.0, 150.0, 177.0, 129.0, 154.0, 157.0, 132.0, 167.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 150.2}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 162.0, 163.0, 166.0, 171.0, 162.0, 163.0, 165.0, 164.0], "unit": "score", "name": "audio-dft", "value": 164.0}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 73.0, 73.0, 133.0, 71.0, 72.0, 71.0, 72.0, 87.0], "unit": "score", "name": "audio-fft", "value": 79.8}, {"lowerIsBetter": true, "replicates": [94.0, 96.0, 136.0, 94.0, 97.0, 95.0, 139.0, 95.0, 96.0, 132.0], "unit": "score", "name": "audio-oscillator", "value": 107.4}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 111.0, 110.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.3}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 148.0, 149.0, 148.0, 147.0, 147.0, 149.0, 149.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 77.0, 75.0, 74.0, 77.0, 75.0, 82.0, 72.0, 74.0], "unit": "score", "name": "json-parse-financial", "value": 75.4}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 67.0, 69.0, 68.0, 69.0, 69.0, 68.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [84.0, 87.0, 85.0, 86.0, 88.0, 95.0, 87.0, 88.0, 86.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.2}, {"lowerIsBetter": true, "replicates": [124.0, 123.0, 124.0, 127.0, 134.0, 131.0, 124.0, 127.0, 122.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.6}, {"lowerIsBetter": true, "replicates": [141.0, 152.0, 153.0, 152.0, 153.0, 142.0, 143.0, 154.0, 152.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.5}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 69.0, 74.0, 73.0, 74.0, 73.0, 72.0, 71.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.1}], "name": "kraken", "value": 1549.4999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.36401673640168], "unit": "score", "name": "Richards", "value": 210.92945000000006}, {"lowerIsBetter": false, "replicates": [185.70102135561746], "unit": "score", "name": "DeltaBlue", "value": 356.04543000000007}, {"lowerIsBetter": false, "replicates": [277.85495971103086], "unit": "score", "name": "Encrypt", "value": 957.9854189999998}, {"lowerIsBetter": false, "replicates": [5223.958333333333], "unit": "score", "name": "Decrypt", "value": 50.95389032901295}, {"lowerIsBetter": false, "replicates": [1085.7763300760043], "unit": "score", "name": "RayTrace", "value": 681.5298690000002}, {"lowerIsBetter": false, "replicates": [715.8196134574088], "unit": "score", "name": "Earley", "value": 931.0488110000001}, {"lowerIsBetter": false, "replicates": [12256.09756097561], "unit": "score", "name": "Boyer", "value": 54.378075621890574}, {"lowerIsBetter": false, "replicates": [26205.128205128207], "unit": "score", "name": "RegExp", "value": 34.76361545988257}, {"lowerIsBetter": false, "replicates": [595.9475566150179], "unit": "score", "name": "Splay", "value": 136.74189800000005}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21302.11163102802}]} 04:41:46 INFO - RETURN: dromaeo_css: 6385.18 04:41:46 INFO - RETURN: kraken: 1549.50 04:41:46 INFO - RETURN: v8_7: 21302.11 04:41:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "21302.11"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1549.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6385.18"}}} 04:41:46 INFO - Return code: 0 04:41:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:41:46 INFO - # TBPL SUCCESS # 04:41:46 INFO - Running post-action listener: _resource_record_post_action 04:41:46 INFO - Running post-run listener: _resource_record_post_run 04:41:47 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 4096; Write bytes: 518356992; Read time: 8; Write time: 689384 04:41:47 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 246517760; Read time: 0; Write time: 459516 04:41:47 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 4096; Write bytes: 271527936; Read time: 8; Write time: 229836 04:41:47 INFO - Running post-run listener: _upload_blobber_files 04:41:47 INFO - Blob upload gear active. 04:41:47 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:41:47 INFO - Copying logs to upload dir... 04:41:47 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1268.137272 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-17 04:41:47.435038) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 04:41:47.442515) ========= 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=01deea79d00cc2c334834894000001d2-1450352449.235700-1628821057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/50imxasqTTO73CsoI4Gd_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009941 build_url: 'https://queue.taskcluster.net/v1/task/50imxasqTTO73CsoI4Gd_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 04:41:47.493953) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 04:41:47.497439) ========= 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=01deea79d00cc2c334834894000001d2-1450352449.235700-1628821057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004561 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 04:41:47.546791) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 04:41:47.547898) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 04:41:47.548232) ========= ========= Total master_lag: 0.29 =========