builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-022 starttime: 1450094913.39 results: success (0) buildid: 20151214025632 builduid: b66ad645f9ea46ce986289e656b5de0c revision: 99137d6d4061f408ae0869122649d8bdf489cc30 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-14 04:08:33.389528) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-14 04:08:33.389939) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-14 04:08:33.390226) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1450094187.277993-2019549519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006327 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-14 04:08:33.429357) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-14 04:08:33.429650) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-14 04:08:33.526913) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 04:08:33.527197) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1450094187.277993-2019549519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004583 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 04:08:33.580836) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-14 04:08:33.581140) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-14 04:08:33.581518) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 04:08:33.582086) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1450094187.277993-2019549519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-14 04:08:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 14.5M=0.001s 2015-12-14 04:08:35 (14.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.196133 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 04:08:33.792724) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 04:08:33.793211) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1450094187.277993-2019549519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015247 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 04:08:33.845177) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-14 04:08:33.845569) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 99137d6d4061f408ae0869122649d8bdf489cc30 --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 99137d6d4061f408ae0869122649d8bdf489cc30 --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=b47e8c1238be48f5acbf8f2f000001bb-1450094187.277993-2019549519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-14 04:08:35,655 truncating revision to first 12 chars 2015-12-14 04:08:35,655 Setting DEBUG logging. 2015-12-14 04:08:35,655 attempt 1/10 2015-12-14 04:08:35,655 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/99137d6d4061?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-14 04:08:36,855 unpacking tar archive at: mozilla-central-99137d6d4061/testing/mozharness/ program finished with exit code 0 elapsedTime=1.499315 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-14 04:08:35.359675) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-14 04:08:35.360067) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-14 04:08:35.369985) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-14 04:08:35.370262) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-14 04:08:35.370655) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2015-12-14 04:08:35.370946) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=b47e8c1238be48f5acbf8f2f000001bb-1450094187.277993-2019549519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:08:37 INFO - MultiFileLogger online at 20151214 04:08:37 in /builds/slave/test 04:08:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:08:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:08:37 INFO - {'append_to_log': False, 04:08:37 INFO - 'base_work_dir': '/builds/slave/test', 04:08:37 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:08:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:08:37 INFO - 'branch': 'Firefox-Non-PGO', 04:08:37 INFO - 'buildbot_json_path': 'buildprops.json', 04:08:37 INFO - 'config_files': ('talos/linux_config.py',), 04:08:37 INFO - 'default_actions': ('clobber', 04:08:37 INFO - 'read-buildbot-config', 04:08:37 INFO - 'download-and-extract', 04:08:37 INFO - 'populate-webroot', 04:08:37 INFO - 'create-virtualenv', 04:08:37 INFO - 'install', 04:08:37 INFO - 'run-tests'), 04:08:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:08:37 INFO - 'download_minidump_stackwalk': True, 04:08:37 INFO - 'download_symbols': 'ondemand', 04:08:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:08:37 INFO - 'tooltool.py': '/tools/tooltool.py', 04:08:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:08:37 INFO - '/tools/misc-python/virtualenv.py')}, 04:08:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:08:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:08:37 INFO - 'installer_path': 'installer.exe', 04:08:37 INFO - 'log_level': 'info', 04:08:37 INFO - 'log_name': 'talos', 04:08:37 INFO - 'log_to_console': True, 04:08:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:08:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:08:37 INFO - 'opt_config_files': (), 04:08:37 INFO - 'pip_index': False, 04:08:37 INFO - 'sps_profile': False, 04:08:37 INFO - 'sps_profile_interval': 0, 04:08:37 INFO - 'suite': 'dromaeojs', 04:08:37 INFO - 'system_bits': '64', 04:08:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:08:37 INFO - 'title': 'talos-linux64-ix-022', 04:08:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:08:37 INFO - 'use_talos_json': True, 04:08:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:08:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:08:37 INFO - 'work_dir': 'build'} 04:08:37 INFO - ##### 04:08:37 INFO - ##### Running clobber step. 04:08:37 INFO - ##### 04:08:37 INFO - Running pre-action listener: _resource_record_pre_action 04:08:37 INFO - Running main action method: clobber 04:08:37 INFO - rmtree: /builds/slave/test/build 04:08:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:08:38 INFO - Running post-action listener: _resource_record_post_action 04:08:38 INFO - ##### 04:08:38 INFO - ##### Running read-buildbot-config step. 04:08:38 INFO - ##### 04:08:38 INFO - Running pre-action listener: _resource_record_pre_action 04:08:38 INFO - Running main action method: read_buildbot_config 04:08:38 INFO - Using buildbot properties: 04:08:38 INFO - { 04:08:38 INFO - "properties": { 04:08:38 INFO - "buildnumber": 345, 04:08:38 INFO - "product": "firefox", 04:08:38 INFO - "script_repo_revision": "production", 04:08:38 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:08:38 INFO - "repository": "", 04:08:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:08:38 INFO - "buildid": "20151214025632", 04:08:38 INFO - "slavename": "talos-linux64-ix-022", 04:08:38 INFO - "pgo_build": "False", 04:08:38 INFO - "basedir": "/builds/slave/test", 04:08:38 INFO - "project": "", 04:08:38 INFO - "platform": "ubuntu64_hw", 04:08:38 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:08:38 INFO - "slavebuilddir": "test", 04:08:38 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:08:38 INFO - "branch": "mozilla-central", 04:08:38 INFO - "repo_path": "mozilla-central", 04:08:38 INFO - "stage_platform": "linux64", 04:08:38 INFO - "builduid": "b66ad645f9ea46ce986289e656b5de0c", 04:08:38 INFO - "revision": "99137d6d4061f408ae0869122649d8bdf489cc30" 04:08:38 INFO - }, 04:08:38 INFO - "sourcestamp": { 04:08:38 INFO - "repository": "", 04:08:38 INFO - "hasPatch": false, 04:08:38 INFO - "project": "", 04:08:38 INFO - "branch": "mozilla-central-linux64-talos", 04:08:38 INFO - "changes": [ 04:08:38 INFO - { 04:08:38 INFO - "category": null, 04:08:38 INFO - "files": [ 04:08:38 INFO - { 04:08:38 INFO - "url": null, 04:08:38 INFO - "name": "https://queue.taskcluster.net/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 04:08:38 INFO - } 04:08:38 INFO - ], 04:08:38 INFO - "repository": "", 04:08:38 INFO - "rev": "99137d6d4061f408ae0869122649d8bdf489cc30", 04:08:38 INFO - "who": "cbook@mozilla.com", 04:08:38 INFO - "when": 1450094876, 04:08:38 INFO - "number": 7357083, 04:08:38 INFO - "comments": "Merge m-c to b-i", 04:08:38 INFO - "project": "", 04:08:38 INFO - "at": "Mon 14 Dec 2015 04:07:56", 04:08:38 INFO - "branch": "mozilla-central-linux64-talos", 04:08:38 INFO - "revlink": "", 04:08:38 INFO - "properties": [ 04:08:38 INFO - [ 04:08:38 INFO - "buildid", 04:08:38 INFO - "20151214025632", 04:08:38 INFO - "Change" 04:08:38 INFO - ], 04:08:38 INFO - [ 04:08:38 INFO - "builduid", 04:08:38 INFO - "b66ad645f9ea46ce986289e656b5de0c", 04:08:38 INFO - "Change" 04:08:38 INFO - ], 04:08:38 INFO - [ 04:08:38 INFO - "pgo_build", 04:08:38 INFO - "False", 04:08:38 INFO - "Change" 04:08:38 INFO - ] 04:08:38 INFO - ], 04:08:38 INFO - "revision": "99137d6d4061f408ae0869122649d8bdf489cc30" 04:08:38 INFO - } 04:08:38 INFO - ], 04:08:38 INFO - "revision": "99137d6d4061f408ae0869122649d8bdf489cc30" 04:08:38 INFO - } 04:08:38 INFO - } 04:08:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 04:08:38 INFO - Running post-action listener: _resource_record_post_action 04:08:38 INFO - ##### 04:08:38 INFO - ##### Running download-and-extract step. 04:08:38 INFO - ##### 04:08:38 INFO - Running pre-action listener: _resource_record_pre_action 04:08:38 INFO - Running main action method: download_and_extract 04:08:38 INFO - mkdir: /builds/slave/test/build/tests 04:08:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:38 INFO - https://queue.taskcluster.net/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:08:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/test_packages.json 04:08:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/test_packages.json 04:08:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:08:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:08:40 INFO - Downloaded 1302 bytes. 04:08:40 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:08:40 INFO - Using the following test package requirements: 04:08:40 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:08:40 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:08:40 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:40 INFO - u'jsshell-linux-x86_64.zip'], 04:08:40 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:08:40 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:08:40 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:08:40 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:08:40 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:08:40 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:08:40 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:08:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:08: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:08:40 INFO - https://queue.taskcluster.net/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:08:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:08:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:08:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:08:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:08:48 INFO - Downloaded 21869728 bytes. 04:08:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:08:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:08:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:08:49 INFO - Return code: 0 04:08:49 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:08: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:08:49 INFO - https://queue.taskcluster.net/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:08:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:08:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:08:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:08:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:08:57 INFO - Downloaded 21869728 bytes. 04:08:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:08:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:08:57 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:08:59 INFO - Return code: 0 04:08:59 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:08:59 INFO - https://queue.taskcluster.net/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:08:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:08:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:08:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:08:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:09:00 INFO - Downloaded 11132038 bytes. 04:09:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 04:09:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:09:00 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 04:09:00 INFO - Return code: 0 04:09:00 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:09:00 INFO - https://queue.taskcluster.net/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:09:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:09:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:09:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:09:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:09:01 INFO - Downloaded 57739813 bytes. 04:09:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:09:01 INFO - mkdir: /builds/slave/test/properties 04:09:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:09:01 INFO - Writing to file /builds/slave/test/properties/build_url 04:09:01 INFO - Contents: 04:09:01 INFO - build_url:https://queue.taskcluster.net/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:09:01 INFO - Running post-action listener: _resource_record_post_action 04:09:01 INFO - Running post-action listener: set_extra_try_arguments 04:09:01 INFO - ##### 04:09:01 INFO - ##### Running populate-webroot step. 04:09:01 INFO - ##### 04:09:01 INFO - Running pre-action listener: _resource_record_pre_action 04:09:01 INFO - Running main action method: populate_webroot 04:09:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:09:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:09:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:09:01 INFO - '--tppagecycles', 04:09:01 INFO - '7'], 04:09:01 INFO - 'tests': ['tsvgm']}}, 04:09:01 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:09:01 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:09:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:09:01 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:09:01 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:09:01 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:09:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:09:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:01 INFO - 'talos_options': ['--e10s'], 04:09:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:09:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:01 INFO - 'tests': ['damp', 'tps']}, 04:09:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:01 INFO - 'talos_options': ['--e10s'], 04:09:01 INFO - 'tests': ['damp', 'tps']}, 04:09:01 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:09:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:09:01 INFO - 'other': {'tests': ['a11yr', 04:09:01 INFO - 'ts_paint', 04:09:01 INFO - 'tpaint', 04:09:01 INFO - 'sessionrestore', 04:09:01 INFO - 'sessionrestore_no_auto_restore']}, 04:09:01 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:09:01 INFO - 'tests': ['a11yr', 04:09:01 INFO - 'ts_paint', 04:09:01 INFO - 'tpaint', 04:09:01 INFO - 'sessionrestore', 04:09:01 INFO - 'sessionrestore_no_auto_restore']}, 04:09:01 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:09:01 INFO - 'tests': ['a11yr', 04:09:01 INFO - 'ts_paint', 04:09:01 INFO - 'tpaint', 04:09:01 INFO - 'sessionrestore', 04:09:01 INFO - 'sessionrestore_no_auto_restore']}, 04:09:01 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:09:01 INFO - 'tests': ['a11yr', 04:09:01 INFO - 'ts_paint', 04:09:01 INFO - 'tpaint', 04:09:01 INFO - 'sessionrestore', 04:09:01 INFO - 'sessionrestore_no_auto_restore']}, 04:09:01 INFO - 'other_l64': {'tests': ['a11yr', 04:09:01 INFO - 'ts_paint', 04:09:01 INFO - 'tpaint', 04:09:01 INFO - 'sessionrestore', 04:09:01 INFO - 'sessionrestore_no_auto_restore']}, 04:09:01 INFO - 'other_nol64': {'tests': ['a11yr', 04:09:01 INFO - 'ts_paint', 04:09:01 INFO - 'tpaint', 04:09:01 INFO - 'sessionrestore', 04:09:01 INFO - 'sessionrestore_no_auto_restore']}, 04:09:01 INFO - 'svgr': {'tests': ['tsvgx', 04:09:01 INFO - 'tsvgr_opacity', 04:09:01 INFO - 'tart', 04:09:01 INFO - 'tscrollx', 04:09:01 INFO - 'cart']}, 04:09:01 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:09:01 INFO - 'tests': ['tsvgx', 04:09:01 INFO - 'tsvgr_opacity', 04:09:01 INFO - 'tart', 04:09:01 INFO - 'tscrollx', 04:09:01 INFO - 'cart']}, 04:09:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:01 INFO - 'tests': ['tp5o']}, 04:09:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:01 INFO - 'talos_options': ['--e10s'], 04:09:01 INFO - 'tests': ['tp5o']}, 04:09:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:01 INFO - 'talos_options': ['--xperf_path', 04:09:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:09:01 INFO - 'tests': ['tp5n']}, 04:09:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:01 INFO - 'talos_options': ['--e10s', 04:09:01 INFO - '--xperf_path', 04:09:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:09:01 INFO - 'tests': ['tp5n']}}, 04:09:01 INFO - 'talos.zip': {'path': '', 04:09:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:09:01 INFO - Running post-action listener: _resource_record_post_action 04:09:01 INFO - ##### 04:09:01 INFO - ##### Running create-virtualenv step. 04:09:01 INFO - ##### 04:09:01 INFO - Running pre-action listener: _resource_record_pre_action 04:09:01 INFO - Running main action method: create_virtualenv 04:09:01 INFO - Creating virtualenv /builds/slave/test/build/venv 04:09:01 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:09:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:09:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:09:02 INFO - Using real prefix '/usr' 04:09:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:09:02 INFO - Installing distribute.............................................................................................................................................................................................done. 04:09:04 INFO - Installing pip.................done. 04:09:04 INFO - Return code: 0 04:09:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:09: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:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09: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:09:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09: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', '--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 0x7fea433f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2544240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d30b0>, '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 0x25d3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d4440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450094187.277993-2019549519', '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:09:04 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:09:04 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:09:04 INFO - Using env: {'DISPLAY': ':0', 04:09:04 INFO - 'HOME': '/home/cltbld', 04:09:04 INFO - 'LANG': 'en_US.UTF-8', 04:09:04 INFO - 'LANGUAGE': 'en_US:en', 04:09:04 INFO - 'LOGNAME': 'cltbld', 04:09:04 INFO - 'MAIL': '/var/mail/cltbld', 04:09:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:04 INFO - 'MOZ_NO_REMOTE': '1', 04:09:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:04 INFO - 'NO_EM_RESTART': '1', 04:09:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:04 INFO - 'PWD': '/builds/slave/test', 04:09:04 INFO - 'SHELL': '/bin/bash', 04:09:04 INFO - 'SHLVL': '1', 04:09:04 INFO - 'TERM': 'linux', 04:09:04 INFO - 'TMOUT': '86400', 04:09:04 INFO - 'USER': 'cltbld', 04:09:04 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450094187.277993-2019549519', 04:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:04 INFO - '_': '/tools/buildbot/bin/python'} 04:09:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:04 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:09:04 INFO - Cleaning up... 04:09:04 INFO - Return code: 0 04:09:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:09: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:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09: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:09:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09: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', '--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 0x7fea433f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2544240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d30b0>, '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 0x25d3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d4440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450094187.277993-2019549519', '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:09:04 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:09:04 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:09:04 INFO - Using env: {'DISPLAY': ':0', 04:09:04 INFO - 'HOME': '/home/cltbld', 04:09:04 INFO - 'LANG': 'en_US.UTF-8', 04:09:04 INFO - 'LANGUAGE': 'en_US:en', 04:09:04 INFO - 'LOGNAME': 'cltbld', 04:09:04 INFO - 'MAIL': '/var/mail/cltbld', 04:09:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:04 INFO - 'MOZ_NO_REMOTE': '1', 04:09:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:04 INFO - 'NO_EM_RESTART': '1', 04:09:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:04 INFO - 'PWD': '/builds/slave/test', 04:09:04 INFO - 'SHELL': '/bin/bash', 04:09:04 INFO - 'SHLVL': '1', 04:09:04 INFO - 'TERM': 'linux', 04:09:04 INFO - 'TMOUT': '86400', 04:09:04 INFO - 'USER': 'cltbld', 04:09:04 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450094187.277993-2019549519', 04:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:04 INFO - '_': '/tools/buildbot/bin/python'} 04:09:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:05 INFO - Downloading/unpacking psutil>=0.7.1 04:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:06 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:09:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:09:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:09:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:09:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:09:06 INFO - Installing collected packages: psutil 04:09:06 INFO - Running setup.py install for psutil 04:09:06 INFO - building 'psutil._psutil_linux' extension 04:09:06 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:09:07 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:09:07 INFO - building 'psutil._psutil_posix' extension 04:09:07 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:09:07 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:09:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:09:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:09:07 INFO - Successfully installed psutil 04:09:07 INFO - Cleaning up... 04:09:07 INFO - Return code: 0 04:09:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:07 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 0x7fea433f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2544240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d30b0>, '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 0x25d3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d4440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450094187.277993-2019549519', '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:09:07 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:09:07 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:09:07 INFO - Using env: {'DISPLAY': ':0', 04:09:07 INFO - 'HOME': '/home/cltbld', 04:09:07 INFO - 'LANG': 'en_US.UTF-8', 04:09:07 INFO - 'LANGUAGE': 'en_US:en', 04:09:07 INFO - 'LOGNAME': 'cltbld', 04:09:07 INFO - 'MAIL': '/var/mail/cltbld', 04:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:07 INFO - 'MOZ_NO_REMOTE': '1', 04:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:07 INFO - 'NO_EM_RESTART': '1', 04:09:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:07 INFO - 'PWD': '/builds/slave/test', 04:09:07 INFO - 'SHELL': '/bin/bash', 04:09:07 INFO - 'SHLVL': '1', 04:09:07 INFO - 'TERM': 'linux', 04:09:07 INFO - 'TMOUT': '86400', 04:09:07 INFO - 'USER': 'cltbld', 04:09:07 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450094187.277993-2019549519', 04:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:07 INFO - '_': '/tools/buildbot/bin/python'} 04:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:09:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:09:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:09:09 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:09:09 INFO - Installing collected packages: mozsystemmonitor 04:09:09 INFO - Running setup.py install for mozsystemmonitor 04:09:09 INFO - Successfully installed mozsystemmonitor 04:09:09 INFO - Cleaning up... 04:09:09 INFO - Return code: 0 04:09:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:09:09 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:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:09 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:09:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:09 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 0x7fea433f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2544240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d30b0>, '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 0x25d3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d4440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450094187.277993-2019549519', '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:09:09 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:09:09 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:09:09 INFO - Using env: {'DISPLAY': ':0', 04:09:09 INFO - 'HOME': '/home/cltbld', 04:09:09 INFO - 'LANG': 'en_US.UTF-8', 04:09:09 INFO - 'LANGUAGE': 'en_US:en', 04:09:09 INFO - 'LOGNAME': 'cltbld', 04:09:09 INFO - 'MAIL': '/var/mail/cltbld', 04:09:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:09 INFO - 'MOZ_NO_REMOTE': '1', 04:09:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:09 INFO - 'NO_EM_RESTART': '1', 04:09:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:09 INFO - 'PWD': '/builds/slave/test', 04:09:09 INFO - 'SHELL': '/bin/bash', 04:09:09 INFO - 'SHLVL': '1', 04:09:09 INFO - 'TERM': 'linux', 04:09:09 INFO - 'TMOUT': '86400', 04:09:09 INFO - 'USER': 'cltbld', 04:09:09 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450094187.277993-2019549519', 04:09:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:09 INFO - '_': '/tools/buildbot/bin/python'} 04:09:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:09 INFO - Downloading/unpacking blobuploader==1.2.4 04:09:09 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:09:09 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:09:09 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:09:09 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:09:09 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:09:09 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:09:11 INFO - Downloading blobuploader-1.2.4.tar.gz 04:09:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:09:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:09:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:09: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:09: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:09: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:09: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:09: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:09: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:09:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:09:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:09:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:09: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:09: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:09: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:09: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:09: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:09: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:09:12 INFO - Downloading docopt-0.6.1.tar.gz 04:09:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:09:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:09:12 INFO - Installing collected packages: blobuploader, requests, docopt 04:09:12 INFO - Running setup.py install for blobuploader 04:09:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:09:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:09:12 INFO - Running setup.py install for requests 04:09:12 INFO - Running setup.py install for docopt 04:09:12 INFO - Successfully installed blobuploader requests docopt 04:09:12 INFO - Cleaning up... 04:09:12 INFO - Return code: 0 04:09:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:12 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 0x7fea433f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2544240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d30b0>, '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 0x25d3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d4440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450094187.277993-2019549519', '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:09:12 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:09:12 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:09:12 INFO - Using env: {'DISPLAY': ':0', 04:09:12 INFO - 'HOME': '/home/cltbld', 04:09:12 INFO - 'LANG': 'en_US.UTF-8', 04:09:12 INFO - 'LANGUAGE': 'en_US:en', 04:09:12 INFO - 'LOGNAME': 'cltbld', 04:09:12 INFO - 'MAIL': '/var/mail/cltbld', 04:09:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:12 INFO - 'MOZ_NO_REMOTE': '1', 04:09:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:12 INFO - 'NO_EM_RESTART': '1', 04:09:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:12 INFO - 'PWD': '/builds/slave/test', 04:09:12 INFO - 'SHELL': '/bin/bash', 04:09:12 INFO - 'SHLVL': '1', 04:09:12 INFO - 'TERM': 'linux', 04:09:12 INFO - 'TMOUT': '86400', 04:09:12 INFO - 'USER': 'cltbld', 04:09:12 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450094187.277993-2019549519', 04:09:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:12 INFO - '_': '/tools/buildbot/bin/python'} 04:09:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:09:12 INFO - Running setup.py (path:/tmp/pip-lgDe2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:09:12 INFO - Running setup.py (path:/tmp/pip-H7_3A1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:09:13 INFO - Running setup.py (path:/tmp/pip-jxCfwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:09:13 INFO - Running setup.py (path:/tmp/pip-e61AXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:09:13 INFO - Running setup.py (path:/tmp/pip-_PcDH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:09:13 INFO - Running setup.py (path:/tmp/pip-c49bkh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:09:13 INFO - Running setup.py (path:/tmp/pip-KqgyJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:09:13 INFO - Running setup.py (path:/tmp/pip-mxR5XN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:09:13 INFO - Running setup.py (path:/tmp/pip-lnIzNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:09:13 INFO - Running setup.py (path:/tmp/pip-iTaIPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:09:13 INFO - Running setup.py (path:/tmp/pip-AbcMm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:09:13 INFO - Running setup.py (path:/tmp/pip-HHHm_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:09:13 INFO - Running setup.py (path:/tmp/pip-FapgqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:09:13 INFO - Running setup.py (path:/tmp/pip-ZHP0cd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:13 INFO - Running setup.py (path:/tmp/pip-2bwnyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:09:14 INFO - Running setup.py (path:/tmp/pip-TNtpk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:09:14 INFO - Running setup.py (path:/tmp/pip-2xJB1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:09:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:09:14 INFO - Running setup.py install for manifestparser 04:09:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:09:14 INFO - Running setup.py install for mozcrash 04:09:14 INFO - Running setup.py install for mozdebug 04:09:14 INFO - Running setup.py install for mozdevice 04:09:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:09:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:09:14 INFO - Running setup.py install for mozfile 04:09:14 INFO - Running setup.py install for mozhttpd 04:09:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:09:14 INFO - Running setup.py install for mozinfo 04:09:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:09:14 INFO - Running setup.py install for mozInstall 04:09:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:09:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:09:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:09:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:09:14 INFO - Running setup.py install for mozleak 04:09:15 INFO - Running setup.py install for mozlog 04:09:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:09:15 INFO - Running setup.py install for moznetwork 04:09:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:09:15 INFO - Running setup.py install for mozprocess 04:09:15 INFO - Running setup.py install for mozprofile 04:09:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:09:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:09:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:09:15 INFO - Running setup.py install for mozrunner 04:09:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:09:15 INFO - Running setup.py install for mozscreenshot 04:09:15 INFO - Running setup.py install for moztest 04:09:15 INFO - Running setup.py install for mozversion 04:09:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:09:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:09:15 INFO - Cleaning up... 04:09:15 INFO - Return code: 0 04:09:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:15 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 0x7fea433f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2544240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d30b0>, '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 0x25d3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d4440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450094187.277993-2019549519', '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:09:15 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:09:15 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:09:15 INFO - Using env: {'DISPLAY': ':0', 04:09:15 INFO - 'HOME': '/home/cltbld', 04:09:15 INFO - 'LANG': 'en_US.UTF-8', 04:09:15 INFO - 'LANGUAGE': 'en_US:en', 04:09:15 INFO - 'LOGNAME': 'cltbld', 04:09:15 INFO - 'MAIL': '/var/mail/cltbld', 04:09:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:15 INFO - 'MOZ_NO_REMOTE': '1', 04:09:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:15 INFO - 'NO_EM_RESTART': '1', 04:09:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:15 INFO - 'PWD': '/builds/slave/test', 04:09:15 INFO - 'SHELL': '/bin/bash', 04:09:15 INFO - 'SHLVL': '1', 04:09:15 INFO - 'TERM': 'linux', 04:09:15 INFO - 'TMOUT': '86400', 04:09:15 INFO - 'USER': 'cltbld', 04:09:15 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450094187.277993-2019549519', 04:09:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:15 INFO - '_': '/tools/buildbot/bin/python'} 04:09:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:09:16 INFO - Running setup.py (path:/tmp/pip-WHnpQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:09:16 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:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:09:16 INFO - Running setup.py (path:/tmp/pip-eVLHjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:09:16 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:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:09:16 INFO - Running setup.py (path:/tmp/pip-rmRz8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:09:16 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:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:09:16 INFO - Running setup.py (path:/tmp/pip-EOQgnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:09:16 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:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:09:16 INFO - Running setup.py (path:/tmp/pip-ejjW6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:09:16 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:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:09:16 INFO - Running setup.py (path:/tmp/pip-JQGBdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:09:16 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:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:09:16 INFO - Running setup.py (path:/tmp/pip-rxJT7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:09:16 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:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:09:16 INFO - Running setup.py (path:/tmp/pip-vmflpZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:09:16 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:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:09:16 INFO - Running setup.py (path:/tmp/pip-heoYHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:09:16 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:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:09:16 INFO - Running setup.py (path:/tmp/pip-OsY9dz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:09:16 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:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:09:16 INFO - Running setup.py (path:/tmp/pip-7S2Yea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:09:16 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:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:09:16 INFO - Running setup.py (path:/tmp/pip-iZwYpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:09:17 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:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:09:17 INFO - Running setup.py (path:/tmp/pip-ssqDa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:09:17 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:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:09:17 INFO - Running setup.py (path:/tmp/pip-cdkKr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:09:17 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:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:17 INFO - Running setup.py (path:/tmp/pip-41qwf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:17 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:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:09:17 INFO - Running setup.py (path:/tmp/pip-CNDnVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:09:17 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:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:09:17 INFO - Running setup.py (path:/tmp/pip-kL1xYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:09:17 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:09:17 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:09:17 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:09:17 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:09:17 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:09:17 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:09:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:09:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:19 INFO - Downloading blessings-1.5.1.tar.gz 04:09:19 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:09:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:09:19 INFO - Installing collected packages: blessings 04:09:19 INFO - Running setup.py install for blessings 04:09:19 INFO - Successfully installed blessings 04:09:19 INFO - Cleaning up... 04:09:19 INFO - Return code: 0 04:09:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:09:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:09:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:09:19 INFO - Reading from file tmpfile_stdout 04:09:19 INFO - Current package versions: 04:09:19 INFO - argparse == 1.2.1 04:09:19 INFO - blessings == 1.5.1 04:09:19 INFO - blobuploader == 1.2.4 04:09:19 INFO - docopt == 0.6.1 04:09:19 INFO - manifestparser == 1.1 04:09:19 INFO - mozInstall == 1.12 04:09:19 INFO - mozcrash == 0.16 04:09:19 INFO - mozdebug == 0.1 04:09:19 INFO - mozdevice == 0.47 04:09:19 INFO - mozfile == 1.2 04:09:19 INFO - mozhttpd == 0.7 04:09:19 INFO - mozinfo == 0.9 04:09:19 INFO - mozleak == 0.1 04:09:19 INFO - mozlog == 3.1 04:09:19 INFO - moznetwork == 0.27 04:09:19 INFO - mozprocess == 0.22 04:09:19 INFO - mozprofile == 0.27 04:09:19 INFO - mozrunner == 6.11 04:09:19 INFO - mozscreenshot == 0.1 04:09:19 INFO - mozsystemmonitor == 0.0 04:09:19 INFO - moztest == 0.7 04:09:19 INFO - mozversion == 1.4 04:09:19 INFO - psutil == 3.1.1 04:09:19 INFO - requests == 1.2.3 04:09:19 INFO - wsgiref == 0.1.2 04:09:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09:19 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:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:19 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:09:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:19 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 0x7fea433f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2544240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d30b0>, '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 0x25d3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d4440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450094187.277993-2019549519', '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:09:19 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:09:19 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:09:19 INFO - Using env: {'DISPLAY': ':0', 04:09:19 INFO - 'HOME': '/home/cltbld', 04:09:19 INFO - 'LANG': 'en_US.UTF-8', 04:09:19 INFO - 'LANGUAGE': 'en_US:en', 04:09:19 INFO - 'LOGNAME': 'cltbld', 04:09:19 INFO - 'MAIL': '/var/mail/cltbld', 04:09:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:19 INFO - 'MOZ_NO_REMOTE': '1', 04:09:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:19 INFO - 'NO_EM_RESTART': '1', 04:09:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:19 INFO - 'PWD': '/builds/slave/test', 04:09:19 INFO - 'SHELL': '/bin/bash', 04:09:19 INFO - 'SHLVL': '1', 04:09:19 INFO - 'TERM': 'linux', 04:09:19 INFO - 'TMOUT': '86400', 04:09:19 INFO - 'USER': 'cltbld', 04:09:19 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450094187.277993-2019549519', 04:09:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:19 INFO - '_': '/tools/buildbot/bin/python'} 04:09:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:19 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:09:19 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:09:19 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:09:19 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:09:19 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:09:19 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:09:19 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:09:19 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:09:19 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:09:19 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:09:19 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:09:19 INFO - Cleaning up... 04:09:19 INFO - Return code: 0 04:09:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:09:19 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:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:19 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:09:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:19 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 0x7fea433f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2544240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d30b0>, '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 0x25d3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d4440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450094187.277993-2019549519', '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:09:19 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:09:19 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:09:19 INFO - Using env: {'DISPLAY': ':0', 04:09:19 INFO - 'HOME': '/home/cltbld', 04:09:19 INFO - 'LANG': 'en_US.UTF-8', 04:09:19 INFO - 'LANGUAGE': 'en_US:en', 04:09:19 INFO - 'LOGNAME': 'cltbld', 04:09:19 INFO - 'MAIL': '/var/mail/cltbld', 04:09:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:19 INFO - 'MOZ_NO_REMOTE': '1', 04:09:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:19 INFO - 'NO_EM_RESTART': '1', 04:09:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:19 INFO - 'PWD': '/builds/slave/test', 04:09:19 INFO - 'SHELL': '/bin/bash', 04:09:19 INFO - 'SHLVL': '1', 04:09:19 INFO - 'TERM': 'linux', 04:09:19 INFO - 'TMOUT': '86400', 04:09:19 INFO - 'USER': 'cltbld', 04:09:19 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450094187.277993-2019549519', 04:09:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:19 INFO - '_': '/tools/buildbot/bin/python'} 04:09:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:19 INFO - Downloading/unpacking jsonschema 04:09:19 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:09:19 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:09:19 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:09:19 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:09:19 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:09:19 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:09:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:09:21 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:09:21 INFO - Downloading/unpacking functools32 (from jsonschema) 04:09:21 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:09:21 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:09:21 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:09:21 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:09:21 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:09:21 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:09:21 INFO - Downloading functools32-3.2.3-2.tar.gz 04:09:21 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:09:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:09:21 INFO - warning: no files found matching '*.txt' 04:09:21 INFO - no previously-included directories found matching 'build' 04:09:21 INFO - no previously-included directories found matching 'dist' 04:09:21 INFO - no previously-included directories found matching '.git*' 04:09:21 INFO - Installing collected packages: jsonschema, functools32 04:09:21 INFO - Running setup.py install for functools32 04:09:22 INFO - warning: no files found matching '*.txt' 04:09:22 INFO - no previously-included directories found matching 'build' 04:09:22 INFO - no previously-included directories found matching 'dist' 04:09:22 INFO - no previously-included directories found matching '.git*' 04:09:22 INFO - Successfully installed jsonschema functools32 04:09:22 INFO - Cleaning up... 04:09:22 INFO - Return code: 0 04:09:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:09:22 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:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:22 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:09:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:22 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 0x7fea433f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2544240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d30b0>, '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 0x25d3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d4440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450094187.277993-2019549519', '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:09:22 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:09:22 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:09:22 INFO - Using env: {'DISPLAY': ':0', 04:09:22 INFO - 'HOME': '/home/cltbld', 04:09:22 INFO - 'LANG': 'en_US.UTF-8', 04:09:22 INFO - 'LANGUAGE': 'en_US:en', 04:09:22 INFO - 'LOGNAME': 'cltbld', 04:09:22 INFO - 'MAIL': '/var/mail/cltbld', 04:09:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:22 INFO - 'MOZ_NO_REMOTE': '1', 04:09:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:22 INFO - 'NO_EM_RESTART': '1', 04:09:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:22 INFO - 'PWD': '/builds/slave/test', 04:09:22 INFO - 'SHELL': '/bin/bash', 04:09:22 INFO - 'SHLVL': '1', 04:09:22 INFO - 'TERM': 'linux', 04:09:22 INFO - 'TMOUT': '86400', 04:09:22 INFO - 'USER': 'cltbld', 04:09:22 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450094187.277993-2019549519', 04:09:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:22 INFO - '_': '/tools/buildbot/bin/python'} 04:09:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:22 INFO - Downloading/unpacking flake8 04:09:22 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:09:22 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:09:22 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:09:22 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:09:22 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:09:22 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:09:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:09:23 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:09:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:09:24 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:09:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:09:24 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:09:24 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:09:24 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:09:24 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:09:24 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:09:24 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:09:24 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:09:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:09:24 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:09:24 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:09:24 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:09:24 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:09:24 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:09:24 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:09:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:09:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:09:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:09:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:09:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:09:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:09:24 INFO - no previously-included directories found matching 'docs/_build' 04:09:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:09:24 INFO - Running setup.py install for pep8 04:09:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:09:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:09:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:09:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:09:24 INFO - no previously-included directories found matching 'docs/_build' 04:09:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:09:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:09:24 INFO - Cleaning up... 04:09:24 INFO - Return code: 0 04:09:24 INFO - Running post-action listener: _resource_record_post_action 04:09:24 INFO - Running post-action listener: _start_resource_monitoring 04:09:24 INFO - Starting resource monitoring. 04:09:24 INFO - ##### 04:09:24 INFO - ##### Running install step. 04:09:24 INFO - ##### 04:09:24 INFO - Running pre-action listener: _resource_record_pre_action 04:09:24 INFO - Running main action method: install 04:09:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:09:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:09:25 INFO - Reading from file tmpfile_stdout 04:09:25 INFO - Detecting whether we're running mozinstall >=1.0... 04:09:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:09:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:09:25 INFO - Reading from file tmpfile_stdout 04:09:25 INFO - Output received: 04:09:25 INFO - Usage: mozinstall [options] installer 04:09:25 INFO - Options: 04:09:25 INFO - -h, --help show this help message and exit 04:09:25 INFO - -d DEST, --destination=DEST 04:09:25 INFO - Directory to install application into. [default: 04:09:25 INFO - "/builds/slave/test"] 04:09:25 INFO - --app=APP Application being installed. [default: firefox] 04:09:25 INFO - mkdir: /builds/slave/test/build/application 04:09:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:09:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:09:39 INFO - Reading from file tmpfile_stdout 04:09:39 INFO - Output received: 04:09:39 INFO - /builds/slave/test/build/application/firefox/firefox 04:09:39 INFO - Running post-action listener: _resource_record_post_action 04:09:39 INFO - ##### 04:09:39 INFO - ##### Running run-tests step. 04:09:39 INFO - ##### 04:09:39 INFO - Running pre-action listener: _resource_record_pre_action 04:09:39 INFO - Running main action method: run_tests 04:09:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:09:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:09:39 INFO - Python 2.7.3 04:09:39 INFO - Return code: 0 04:09:39 INFO - grabbing minidump binary from tooltool 04:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:39 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 0x25d30b0>, '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 0x25d3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d4440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:09:39 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:09:39 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:09:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:09:39 INFO - Return code: 0 04:09:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:09:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:09:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:09:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:09:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:09:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:09:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:09:40 INFO - Return code: 0 04:09:40 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost'] in /builds/slave/test/build 04:09:40 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost 04:09:40 INFO - Using env: {'DISPLAY': ':0', 04:09:40 INFO - 'HOME': '/home/cltbld', 04:09:40 INFO - 'LANG': 'en_US.UTF-8', 04:09:40 INFO - 'LANGUAGE': 'en_US:en', 04:09:40 INFO - 'LOGNAME': 'cltbld', 04:09:40 INFO - 'MAIL': '/var/mail/cltbld', 04:09:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:09:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:09:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:40 INFO - 'MOZ_NO_REMOTE': '1', 04:09:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:09:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:40 INFO - 'NO_EM_RESTART': '1', 04:09:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:40 INFO - 'PWD': '/builds/slave/test', 04:09:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:09:40 INFO - 'SHELL': '/bin/bash', 04:09:40 INFO - 'SHLVL': '1', 04:09:40 INFO - 'TERM': 'linux', 04:09:40 INFO - 'TMOUT': '86400', 04:09:40 INFO - 'USER': 'cltbld', 04:09:40 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450094187.277993-2019549519', 04:09:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:40 INFO - '_': '/tools/buildbot/bin/python'} 04:09:40 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost'] with output_timeout 3600 04:09:40 INFO - mozversion INFO | application_buildid: 20151214025632 04:09:40 INFO - mozversion INFO | application_changeset: 99137d6d4061f408ae0869122649d8bdf489cc30 04:09:40 INFO - mozversion INFO | application_display_name: Nightly 04:09:40 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:09:40 INFO - mozversion INFO | application_name: Firefox 04:09:40 INFO - mozversion INFO | application_remotingname: firefox 04:09:40 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 04:09:40 INFO - mozversion INFO | application_vendor: Mozilla 04:09:40 INFO - mozversion INFO | application_version: 45.0a1 04:09:40 INFO - mozversion INFO | platform_buildid: 20151214025632 04:09:40 INFO - mozversion INFO | platform_changeset: 99137d6d4061f408ae0869122649d8bdf489cc30 04:09:40 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 04:09:40 INFO - mozversion INFO | platform_version: 45.0a1 04:09:40 INFO - 2015-12-14 04:09:40,961 DEBUG : using testdate: 1450094980 04:09:40 INFO - 2015-12-14 04:09:40,961 DEBUG : actual date: 1450094980 04:09:40 INFO - 2015-12-14 04:09:40,970 INFO : starting webserver on 'localhost:59412' 04:09:40 INFO - 2015-12-14 04:09:40,971 INFO : Starting test suite talos-linux64-ix-022 04:09:40 INFO - 2015-12-14 04:09:40,971 INFO : Starting test dromaeo_css 04:09:40 INFO - 2015-12-14 04:09:40,972 DEBUG : operating with platform_type : linux_ 04:09:40 INFO - 2015-12-14 04:09:40,972 INFO : Initialising browser for dromaeo_css test... 04:09:40 INFO - 2015-12-14 04:09:40,987 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxZPMXm/profile http://localhost:59412/getInfo.html 04:09:45 INFO - 2015-12-14 04:09:45,983 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:09:45 INFO - 2015-12-14 04:09:45,984 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:09:45 INFO - 2015-12-14 04:09:45,984 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:09:45 INFO - 2015-12-14 04:09:45,984 DEBUG : BROWSER_OUTPUT: __metrics 04:09:46 INFO - 2015-12-14 04:09:46,121 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:09:46 INFO - 2015-12-14 04:09:46,197 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:09:47 INFO - 2015-12-14 04:09:47,105 INFO : Browser initialized. 04:09:47 INFO - 2015-12-14 04:09:47,106 INFO : Running cycle 1/1 for dromaeo_css test... 04:09:47 INFO - 2015-12-14 04:09:47,106 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxZPMXm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:09:59 INFO - 2015-12-14 04:09:59,131 DEBUG : BROWSER_OUTPUT: RSS: Main: 142741504 04:09:59 INFO - 2015-12-14 04:09:59,132 DEBUG : BROWSER_OUTPUT: 04:10:50 INFO - 2015-12-14 04:10:50,532 DEBUG : BROWSER_OUTPUT: 1450095050531 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:13:02 INFO - 2015-12-14 04:13:02,677 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59412/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59412/tests/dromaeo/cssquery-ext.html) 04:13:03 INFO - 2015-12-14 04:13:03,902 DEBUG : BROWSER_OUTPUT: RSS: Main: 261844992 04:13:03 INFO - 2015-12-14 04:13:03,902 DEBUG : BROWSER_OUTPUT: 04:16:06 INFO - 2015-12-14 04:16:06,534 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59412/tests/dromaeo/cssquery-ext.html (next: http://localhost:59412/tests/dromaeo/cssquery-jquery.html) 04:16:07 INFO - 2015-12-14 04:16:07,100 DEBUG : BROWSER_OUTPUT: RSS: Main: 218423296 04:16:07 INFO - 2015-12-14 04:16:07,100 DEBUG : BROWSER_OUTPUT: 04:19:09 INFO - 2015-12-14 04:19:09,186 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59412/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59412/tests/dromaeo/cssquery-mootools.html) 04:19:09 INFO - 2015-12-14 04:19:09,759 DEBUG : BROWSER_OUTPUT: RSS: Main: 217423872 04:19:09 INFO - 2015-12-14 04:19:09,759 DEBUG : BROWSER_OUTPUT: 04:22:11 INFO - 2015-12-14 04:22:11,741 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59412/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59412/tests/dromaeo/cssquery-prototype.html) 04:22:12 INFO - 2015-12-14 04:22:12,314 DEBUG : BROWSER_OUTPUT: RSS: Main: 206114816 04:22:12 INFO - 2015-12-14 04:22:12,314 DEBUG : BROWSER_OUTPUT: 04:25:15 INFO - 2015-12-14 04:25:15,128 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59412/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59412/tests/dromaeo/cssquery-yui.html) 04:25:15 INFO - 2015-12-14 04:25:15,709 DEBUG : BROWSER_OUTPUT: RSS: Main: 208097280 04:25:15 INFO - 2015-12-14 04:25:15,709 DEBUG : BROWSER_OUTPUT: 04:28:18 INFO - 2015-12-14 04:28:18,455 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59412/tests/dromaeo/cssquery-yui.html (next: http://localhost:59412/tests/dromaeo/cssquery-dojo.html) 04:28:18 INFO - 2015-12-14 04:28:18,700 DEBUG : BROWSER_OUTPUT: RSS: Main: 255479808 04:28:18 INFO - 2015-12-14 04:28:18,701 DEBUG : BROWSER_OUTPUT: 04:28:18 INFO - 2015-12-14 04:28:18,702 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:28:18 INFO - 2015-12-14 04:28:18,702 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:28:18 INFO - 2015-12-14 04:28:18,702 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:28:18 INFO - 2015-12-14 04:28:18,702 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:28:18 INFO - 2015-12-14 04:28:18,706 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2633.5391306521356;2733.83596984181;2734.371094648232;2744.2727677165544;2771.5149848776464;4507.774611269431;4617.769111544418;4786.688865223758;4792.041591681665;4814.229723244282;4601.654875884314;4712.552307530787;4768.690035147713;4773.80904763809;4830.2754586812;4308.547602501739;4391.890202744941;4463.799129039185;4514.8194072237075;4549.61328287096;4469.865904022869;4527.4567051953645;4530.66020048496;4541.386912766784;4575.359449677031;4192.9790351048205;4285.764282964436;4302.677299202541;4402.735835849827;4437.356583295436;4445.666575006888;4448.5773851484055;4458.621017213508;4460.241758900995;4494.303382975644;4383.630053184855;4403.6256918162;4424;4432.490263619693;4453.799579018952;4557.908841823178;4630.83792067276;4677.859664210079;4703.412073490814;4764.737939413331;5165.66423182492;5172.896542069175;5173.430922598549;5178.042062218502;5181.53366197044;5188.066148093341;5190.06578815813;5199.194124910645;5202.635815492917;5244.632875698702;4635.281531362644;4738.147133516;4807.471178170398;4816.20532612115;4816.4220293564995;5108.642395032312;5163.535281824654;5250.894982100413;5262.158054711228;5302.602304827154;5068.82259120929;5112.079825631347;5114.744262786846;5116.846494605168;5117.078925793393;5196.662216955886;5203.375594928632;5207.453217412193;5210.8957820844125;5240.580753539708;4799.544043315879;4975.850724478271;4983.352164218701;4993.300937868701;5111.131107711698;5026.52248036436;5041.470645582234;5056.873578160502;5065.924011139836;5117.897642047138;4262.6376757975295;4268.359746038119;4269.039466120098;4269.274223382033;4317.028668549551;3620.5474315710535;3679.8344074516713;3729.5151630287887;3736.1593641431004;3768.8304026318883;4434.091011342732;4441.933370999438;4443.37792709021;4449.621782148553;4494.865154045384;5130.48695130484;5132.486751324912;5135.743212839343;5138.640295179302;5185.662931909414;4304.978475107604;4353.564643535621;4402.119576084796;4405.845795397146;4456.952616135206;4612.884677883013;4625.861224163281;4630.259158534618;4637.095766325534;4666.626669866402;4926.679765815211;4939.061578300111;4942.6293028023765;4947.628927830499;4989.750512474289;4919.262110683426;5033.2701758245585;5035.59715222774;5213;5228.45101264377;4791.401074865642;4802.423709154924;4868.683535570177;4891.070696567641;4896.167651499325;5023.522765337287;5052.115879720961;5101.591872650253;5128.538431541179;5133.921876405997;5176;5205.92191117126;5208.557272631869;5213.713245771367;5253.973730131478;4729.527047295243;4876.414830220397;4877.878053048702;5013.373328333958;5041.168207245763;4914.729689867092;4996.900061998667;5038.244263360525;5046.84859454217;5086.618503612318;4792.976035119802;4836.758162091952;4861.829835955866;4862.3922009748785;4916.557509824133;4719.905601888012;4839.128956787671;4839.177339852163;4972.378452693413;4976.2286845539;4769.8790784165;4824.179889418737;4831.227003679394;4839.758012099311;4882.36529251195 04:28:18 INFO - 2015-12-14 04:28:18,706 DEBUG : BROWSER_OUTPUT: |1;ext.html;554.1272495819085;559.3679142568898;564.3848205456052;570.4466667332691;573.0659025787965;27149.59275610865;35201.64798352015;36188.27623447529;36274.455883161776;36323.81838090806;39645.80177099118;40039.399409008816;40089.59910400895;40095.39856902142;40175.397369039485;6891.276415976326;7009.649517524129;7866.370690344758;8034.758957231264;8037.758867233963;10189.847152292721;10473.31923424975;10473.895261047368;10476.161907047417;10480.685579432591;10089.243306751987;10138.442385668784;10170.288079834414;10196.082352588266;10197.745056373613;7140.928590714104;7301.1603665578605;7307.3058059484265;7317.634118294064;10037.849432258485;9947.701568952943;10140.442275674835;10162.441065741381;10169.135623472013;10169.847452288222;36528.45207321892;37056.62943370586;37089.62910370916;37163.81418092919;37174.442383364;2801.089645865102;2890.4363649088436;2945.661248956376;3103.953440698391;3352.8826491072696;28310;28555.428891422263;28709.28226794326;29004.709952900623;29064.12807615775;3388.762786604939;3468.7745296555645;3472.4444088945647;3511.929761404783;3519.63043880394;219078;221136;221610;222262;222528;52053;57265.427345726006;57598.7120064397;57656.423435765944;57697.13454298189;47080;65782;66776.6661166691;67515.66242168758;67600;12458.252504849737;12596.874031259571;12600.4329805159;12601.180923240143;12602.936985315015;9641.807163856824;9750.366226195416;9754.658586949423;9768.07203315684;9769.071938165864;19238.61522769537;19247.422577322704;19394;19511.512212194524;19522.804771952382;7516.285952834472;7750.922490775133;7833.686652533835;7877.724279650185;7960.726283794681;842.8609279468942;858.2533196119416;873.9257163141205;956.8995255498212;1078.5955266774959;25089;25688.229353119437;25707.87146064258;25767.484650306887;25788.74211257901;912.2610685344891;949.4493193947494;1040.089921318846;1100.1693721240413;1106.25880659958;13224.867751322556;13379.799303010463;13393.330333483287;13578.660533486543;13586.864131358758;309135;312422;312556;313393;314137;48562.27156592654;49122.26316605254;49160.26259606109;49182.75408622934;49186.75406622944;1211.5032836536977;1213.0841214882707;1217.8903898649164;1218.994329678019;1231.205872212436;25095;25120.37199070038;25286.620700689873;25731.871340643178;29816.403671926873;43619.34570981501;44185.33721994237;44213.55786442223;44250.33624495571;44253.55746442494;239795;241740;242483;242669;243258;28799.85600071986;31368.215794605316;34676.826615867765;38805.80597096997;43194.568054319054;37579.805716514406;38071.42892856554;38204.80897595494;38630.80684596559;39117.608823911396;32724.34551309008;33214.16964575905;33298.833505832314;33487.49768753422;33627.49558756669;30174.245643859078;37969.4304585437;38330.61669383271;39477.802610986764;39932;32119.839400802848;32712;32803.391626920544;33412.665873341924;33498;29032.41935161243;29544.852275738485;29909;29920.55119173258;30080.849595752756;22961.770382296632;23144.768552314934;25057.624135637616;25191.622125667764;26883 04:28:18 INFO - 2015-12-14 04:28:18,710 DEBUG : BROWSER_OUTPUT: |2;jquery.html;324.6347858659009;330.39537646107624;335.9916002099947;336.07076433660933;337.03607682029406;12631.873681263185;12925.418356173972;14817.851821481796;15387.923060384697;15397.6150596235;13813.861861381383;14267.1439713617;14492.927535362334;15042.022268552537;15055.92472037641;4103.179364127186;5055.494450554934;5088.287639730441;5117.590592752571;5205.427402985669;5180.896382072357;5215.504527069941;5223.477652234784;5223.608229382792;5224.7387630618505;5026.195808670614;5087.898242035157;5090.949090509084;5165.845024649267;5178.300929374524;5083.212102124176;5110.156824124015;5111.923321150186;5119.10415677255;5120.92318615221;4431.5789999950275;4504.6396288296855;4527.1624749421135;4568.063546972896;4570.154521413549;19467.221311147678;19599.510012249666;19777.40667779969;19784.30754923585;19823.504412389662;1716.9399071032453;1813.3200049981258;1871.129924585061;1997.6204521141083;2060.042080432606;9209.401388909766;9282.396644218104;12056.397180140957;12119.636410907688;12834.101612887102;1704.3012364930444;1707.5133586927666;1813.882097663661;1839.4389711138097;1847.3257261099602;50589.74705126488;51863.22205166963;53522.464775352135;56523.71738141324;58125.7093714533;9139.543022848964;9377;9511.096445837635;9582.616695332108;9634.470104144339;10796.352218866894;11028.613998510014;11716.94141529287;12431.254124752544;12438.19151755133;6520.576162549419;6599.538032337787;6606.042123892009;6636.402723754885;6652.467802575782;6197.504199664016;6211.16149319836;6221.47117495018;6262.655553944577;6343.746250150035;4117.794110294473;4119.402686610425;4173.937390939138;4226.239276930182;4237.343211802176;1678.4880611413637;1711.3325802936865;1713.468824664358;1717.8883372580742;1757.1390018890652;833.5082301442178;902.873597696323;978.0610613810821;994.3387647214521;1000.4847503535685;15094.622634434227;16211.108389038716;16212.75680864788;16476.83523164777;16594.253258603392;795.5544894858782;806.2864365036985;817.0767033252387;817.2603793566832;828.6643909216776;6888.896666550006;8965.413984129438;9288.628454861864;9431.198348140484;9530;501053;508202;557997;558058;566158;55067.07265245697;61907.690461547405;68613.65693171503;72849.6357518209;73983.63008185032;1020.938743675367;1030.8659874216303;1044.9007344302279;1077.6605369308643;1077.983830242547;14459.349329279998;14703.705925881637;14749.852501474848;14837.332320045409;14932.62668433298;33883.661163389035;33943;33983.49024764581;34809.8259508711;35599;43778.562214377445;44777.55222447734;45577.77211113923;46037.76981115073;47170;8707.259882910024;8720.476771393736;8824.823503530022;8923.196912277926;8928.196462318423;10527.263091583516;10557.841632375366;10593.417362045162;10654.680359589225;11123.666290011313;13166.539171128965;13936.928783825462;14003.50987715425;14007.159570425807;14028.22844743508;12701.174423662433;13018.15382000167;13161.27612981257;13549.187048777105;13550.119242249222;13259.337033148111;13416.060875738995;13472.259025753285;13871.583852484442;13957.092788968685;8386.706465273686;8861.113888611088;8916.242119419663;9132.589033493376;9173.908260917573;9452.385594936308;12712.3008234548;13756.312184390541;13916.443342266197;14524.927375363055 04:28:18 INFO - 2015-12-14 04:28:18,711 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1447.652563384788;1630.290823491781;1687.3672372860178;1695.7032519309118;1748.1434097292322;5760.7407666655;6992.47556433267;7247.565146091239;7251.7461888833905;7256.528325658828;7117.679704413301;7281.162666293378;7281.453890958172;7285.344319011288;7303.233160518135;1765.8763886527947;1795.3446991847948;1796.7843858736906;2092.884891330976;2147.5919575280723;2081.0739221046642;2124.5538436928264;2125.6811478278305;2127.914883404662;2133.9146434142694;2038.6024725178597;2057.9794202057938;2063.1541068162055;2070.109852763311;2096.8427367947465;2095.486605781578;2105.5558866178008;2119.141747592212;2122.7664956854655;2124.2671278409002;2097.5070858348276;2124.5007423255524;2128.2019242783954;2129.169623846701;2131.5523740014614;7179.246179151219;7300.525465844757;7304.525205861655;7312.561246325237;7327.853442931165;3998.8800335989968;4091.079507110906;4096.160287141129;4103.774292413916;4104.610062044131;2651.4564514274525;2697.0560303893676;2761.2682639100653;2785.470760555508;2793.25978615667;825.5046971816862;848.9235968762779;872.4808738800467;876.9123087691244;883.5891310540566;9651.71044868655;9694.418334899858;9706.155830392203;9717.619183300067;9721.90278097217;3932.2135572885536;3968.66266367362;4004.839806407711;4030.3349947258375;4060.3300455424524;8378.24595786382;8400.873986890201;8401.789955251168;8402.495850249004;8409.453385529921;4183;4216.494020717472;4220.092680073799;4226.450561426995;4230.873073807791;3770.321342158438;3771.2080463102507;3772.9434058489146;3774.2640185164178;3778.8110594470168;2976.1071678496364;3041.7718671099756;3373.1735724747596;3495.405781017233;3496.6852983231634;1069.7539565899888;1090.8636420447444;1090.86909570852;1096.4188979840537;1103.332483847277;849.6941101203562;851.3997631669782;851.6295411496019;852.1691350932791;1021.2391768132788;6600.174978127734;6659.101021362054;6668.166479190101;6678.699458524378;6680;1026.830572955454;1038.870141232346;1041.7187359413067;1062.3625824505234;1068.4978060311641;5048.848534543969;5124.026434977342;5126.79492820283;5131.717755523482;5133.897322053538;8036.316913062338;8196.508209507449;8398;8549.444286121383;8658.220760131493;8266.338692904554;8419.284360829399;8423.536705481258;8434.704785332484;8435;6507.577007494498;6859.416949559243;6965.79102626922;7000.719971201197;7014.719411223596;6861.279565645735;6904.482163837632;6905.620190889549;6912.619805910723;6914.412274956484;7679.193684663253;7731.497452665559;7742.032245969254;7841.490303130278;7877;7821.217878212134;7939.245771651684;8036.67853285862;8044;8048.959755201186;6188.659623720739;6221.9377806221355;6235.657038862906;6254.906176407449;6265.154204182377;5645.661260324394;5959.791407300723;6467.223933128054;6535.934640653722;6612.239592446737;6222.875542489215;6415.839604009937;6485.0596663484475;6543.280239173592;6555.737770489127;6419.197600299963;6422.775202868064;6437.034444833313;6443.838904027437;6553.5084868635995;5927.851803704942;6369.267534233622;6414.134091897534;6436.9034464484;6450.290468048417;5984.521238300838;6050.969745151246;6059.3637668045985;6067.484263837623;6069.150318955438;6111.96944015277;6191.938080619136;6209.627422354673;6248.812535623939;6253.874922501615 04:28:18 INFO - 2015-12-14 04:28:18,714 DEBUG : BROWSER_OUTPUT: |4;prototype.html;293.18348399706815;301.77065430272984;305.39684123855375;312.6045552376243;315.82629553745437;5328.573714102872;5344.385395679493;5396.514313711765;5399.946000539993;5408.161734931082;5318.095923692972;5318.840434786953;5326.6005049621235;5332.466753324676;5347.518723314901;3969.7221194516396;4188.476440444944;4194.937075943863;4198.727082739612;4200.432941552882;4051.979740101295;4078.3066878630702;4188.141431006651;4193.81127849246;4210.789460526977;4144.171165766844;4148.8133034013545;4150.83396664133;4153.044799696072;4154;3911.9217615647526;4002.239574480839;4028.8589899353383;4155.189738001091;4162.583741625858;3659.79871107089;3661.743677942545;3672.981635091807;3673.7244706647107;3675.4303083022173;5128.948710512922;5130.7691153897795;5131.717755523445;5134.8202812901745;5147.897042059138;4798.424189097295;4805.567498925078;4808.831690890802;4811.59101476375;4816.470188279286;5512.421195774426;5644.915326270109;5658.858528536778;5659.490645841894;5672.092465205547;4023.718339716221;4027.9597204027878;4029.9194016119804;4030.45588845505;4032.697547683906;5946.286445626552;5949.732262048218;5954.583179177459;5955;5955.076963070687;4116.135611521614;4117.5176936302905;4123.319652257344;4123.958760412417;4130.504339479282;4082.559074738338;4169.395437661583;4171.791410429466;4184.937225941613;4243.27864263076;4788.784504697227;4791.425028996473;4793.520647935178;4796.544328288807;4803.159447096814;5665.575081868877;5667.234923285386;5672.716364181774;5673.120666296731;5687.7156142192725;1466.5893549806071;1491.5003473836168;1492.0898252066231;1493.2235237676348;1494.275276490901;1014.4065721552827;1020.9234307426824;1027.2347101409498;1030.2376241581326;1051.542578978147;4999.775010124553;5009.0482808266315;5009.098362294749;5015.398152221756;5021.121303771898;5869.295684517885;5870.148828419855;5877.353491115974;5880.2943646761805;5880.705964701748;4982.377202849644;5002.049610574052;5007.098722229961;5014;5015.623828212826;2925.18094933419;2986.970130298669;3107.02128829418;3132.6554079051284;3169.017604542599;5522.751476183581;5523.033469142964;5571.721413929368;5583.888322233533;5586.050371436865;6071.271447426248;6080.270367555833;6085.117657939574;6091.329953705089;6093.817185484442;5562.2490963721;5563.527100196528;5567.972160139173;5577.191307260506;5577.191307260506;5703.657780533182;5849;5900.1149827526215;5906.616069955439;5940.138679891305;5790.073588225863;5796.1305804129715;5796.275465566804;5797.710114494343;5798.391168927371;5574.665520068809;5579.414161513145;5583.050881350099;5587.3015873015875;5598.86002849932;3903.219356128729;4032.9193416130925;4066.7153299268766;4072.083781149218;4077.89805254871;5859.384764599826;5859.886621541893;5866.120081987736;5875.059990401515;5876.706164691834;5638.746256418389;5648.435156484483;5649.519790817826;5650.68921209321;5650.689212093374;5640.971795140998;5642.915356269741;5643.520300774316;5644.491995720405;5658.971705141613;5407.459254074561;5514.062609356339;5528.419515950767;5531.612787104864;5540.390557038803;5672.12082127271;5685.744141513559;5688.3742788294085;5688.886222275449;5688.971555142198;5362.865928351823;5481.808136715196;5498.147787093007;5583.469570390806;5603.467670571289 04:28:18 INFO - 2015-12-14 04:28:18,715 DEBUG : BROWSER_OUTPUT: |5;yui.html;603.8309273403446;652.6149571752667;755.5353457623563;763.0123528209016;768.753998720409;11665.24175928564;12542.184757990735;12558.937205313961;12560.120791544585;12614.117011809154;11704.297742135477;11786.7642647147;11823.172377933548;11824.527018919232;11854.407279636027;436.6681322195123;443.8690586277056;810.0724670252557;810.9189081091903;827.5613924619961;811.922867327603;812.2689579378577;818.9181081891793;819.0989911097804;819.2422009641087;541.3179393963595;851.2508992086955;859.1408591408591;859.5401460218784;860.2472836268265;544.1782907809197;836.2473773603775;840.7477756673035;849.0787495567317;850.1073872433919;631.9747210111636;633.6799916042415;633.936606339367;634.0520921222801;634.210408041986;10511.78976420475;10523.947380263126;10537.631182908639;10590;10633.840492392621;10230.590776368936;11064.834027489595;11168;11411.144164187635;11549.6535103947;9107.180353768194;9261.398009129452;9355.298352623513;9361.953190234006;9518.190953768937;3243.594550681165;3278.557394751702;3302.570665813429;3325.667433256679;3375.1730825947557;37531.624683753085;37539.4369084464;37683.43474847852;37921.81039094787;37986.24027519462;9401.294902882311;9480.383775054599;9536;9889.901100989042;10039.498025098716;16483.505494835175;16527.173641317888;16550.917245413697;16572.17139143038;16606.50180494587;6205.03821907605;6494.350564943468;6522.641254731036;6644.667766611747;6706.698198581075;3692.7415080944074;3697.648723371329;3699.6855267302044;3734.047817806442;3794.79128647927;2605.7003444604115;2627.69781475129;2637.788976881845;2639.4589109232943;2646.6559347285115;475.2253826263169;493.0508770616549;497.62926619668576;497.810831883889;503.90677724621065;465.8546355503472;483.3667895057486;509.59996402823606;585.8564651660371;620.1596836286857;7700.9614951926005;7716;8008.959955200186;8328.541930193776;8852.3803333766;466.4239664014939;487.0721275969284;503.8085527499527;526.8419474157737;637.3690046853674;3527.4356103023392;3640.526731524885;3652.7625704329134;3851.326017946848;3857.498525191707;47595.286070708964;47822.28266576004;47964.7601761989;47991.52008479871;48010.27984580164;39479.40780888289;39490;39772;41424.585754142674;43796.78101609535;40094.599054009086;40289.19421611552;40341;40954;41255.7937210312;7949.562774047483;8298.294644955246;8338.541380224146;8358.958205208935;8550.486970781772;31244.06267811969;31489.8425507871;31517.842410787798;32164.19589510281;32672.673273267916;38004.239915202095;38269.80865095657;39037.609623903394;39233.803830980665;39289.607103928596;9987.550560224661;10089;10327.638532651321;10377.481125943521;10395.896041039492;11544.422778860855;11718.414079296172;11814.645560633195;12278.07914406441;12287.56993505223;9930;10013.299069065095;10096.394216346749;10110.39337639744;10835.945820270848;10570;10621.628243011457;10798.568057277935;11076.889231107585;11091.33451992883;10601.25791194609;10855.023047925724;10954.945225273823;11125.888741112485;11140.442977851237;9036.502992335221;9139.903211614648;9225;9406.43561386319;10048.09567138961;9034.86447703272;9223.262139028728;9394.295427843075;9415.387999779992;9578.425294482353 04:28:18 INFO - 2015-12-14 04:28:18,715 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:28:18 INFO - 2015-12-14 04:28:18,715 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:28:18 INFO - 2015-12-14 04:28:18,715 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1005 04:28:18 INFO - 2015-12-14 04:28:18,715 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:28:18 INFO - 2015-12-14 04:28:18,715 DEBUG : BROWSER_OUTPUT: __startTimestamp1450096098701__endTimestamp 04:28:18 INFO - 2015-12-14 04:28:18,715 DEBUG : BROWSER_OUTPUT: 04:28:18 INFO - 2015-12-14 04:28:18,715 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:28:18 INFO - 2015-12-14 04:28:18,715 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:28:18 INFO - 2015-12-14 04:28:18,715 DEBUG : BROWSER_OUTPUT: 04:28:18 INFO - 2015-12-14 04:28:18,715 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4726.84 Median:4830.28 stddev:498.34 (10.3%) stddev-sans-first:472.04 04:28:18 INFO - 2015-12-14 04:28:18,715 DEBUG : BROWSER_OUTPUT: Values: 2633.5 2733.8 2734.4 2744.3 2771.5 4507.8 4617.8 4786.7 4792.0 4814.2 4601.7 4712.6 4768.7 4773.8 4830.3 4308.5 4391.9 4463.8 4514.8 4549.6 4469.9 4527.5 4530.7 4541.4 4575.4 4193.0 4285.8 4302.7 4402.7 4437.4 4445.7 4448.6 4458.6 4460.2 4494.3 4383.6 4403.6 4424.0 4432.5 4453.8 4557.9 4630.8 4677.9 4703.4 4764.7 5165.7 5172.9 5173.4 5178.0 5181.5 5188.1 5190.1 5199.2 5202.6 5244.6 4635.3 4738.1 4807.5 4816.2 4816.4 5108.6 5163.5 5250.9 5262.2 5302.6 5068.8 5112.1 5114.7 5116.8 5117.1 5196.7 5203.4 5207.5 5210.9 5240.6 4799.5 4975.9 4983.4 4993.3 5111.1 5026.5 5041.5 5056.9 5065.9 5117.9 4262.6 4268.4 4269.0 4269.3 4317.0 3620.5 3679.8 3729.5 3736.2 3768.8 4434.1 4441.9 4443.4 4449.6 4494.9 5130.5 5132.5 5135.7 5138.6 5185.7 4305.0 4353.6 4402.1 4405.8 4457.0 4612.9 4625.9 4630.3 4637.1 4666.6 4926.7 4939.1 4942.6 4947.6 4989.8 4919.3 5033.3 5035.6 5213.0 5228.5 4791.4 4802.4 4868.7 4891.1 4896.2 5023.5 5052.1 5101.6 5128.5 5133.9 5176.0 5205.9 5208.6 5213.7 5254.0 4729.5 4876.4 4877.9 5013.4 5041.2 4914.7 4996.9 5038.2 5046.8 5086.6 4793.0 4836.8 4861.8 4862.4 4916.6 4719.9 4839.1 4839.2 4972.4 4976.2 4769.9 4824.2 4831.2 4839.8 4882.4 04:28:18 INFO - 2015-12-14 04:28:18,716 DEBUG : BROWSER_OUTPUT: 04:28:18 INFO - 2015-12-14 04:28:18,716 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42516.24 Median:33008.78 stddev:68313.50 (207.0%) stddev-sans-first:68432.48 04:28:18 INFO - 2015-12-14 04:28:18,716 DEBUG : BROWSER_OUTPUT: Values: 554.1 559.4 564.4 570.4 573.1 27149.6 35201.6 36188.3 36274.5 36323.8 39645.8 40039.4 40089.6 40095.4 40175.4 6891.3 7009.6 7866.4 8034.8 8037.8 10189.8 10473.3 10473.9 10476.2 10480.7 10089.2 10138.4 10170.3 10196.1 10197.7 7140.9 7301.2 7307.3 7317.6 10037.8 9947.7 10140.4 10162.4 10169.1 10169.8 36528.5 37056.6 37089.6 37163.8 37174.4 2801.1 2890.4 2945.7 3104.0 3352.9 28310.0 28555.4 28709.3 29004.7 29064.1 3388.8 3468.8 3472.4 3511.9 3519.6 219078.0 221136.0 221610.0 222262.0 222528.0 52053.0 57265.4 57598.7 57656.4 57697.1 47080.0 65782.0 66776.7 67515.7 67600.0 12458.3 12596.9 12600.4 12601.2 12602.9 9641.8 9750.4 9754.7 9768.1 9769.1 19238.6 19247.4 19394.0 19511.5 19522.8 7516.3 7750.9 7833.7 7877.7 7960.7 842.9 858.3 873.9 956.9 1078.6 25089.0 25688.2 25707.9 25767.5 25788.7 912.3 949.4 1040.1 1100.2 1106.3 13224.9 13379.8 13393.3 13578.7 13586.9 309135.0 312422.0 312556.0 313393.0 314137.0 48562.3 49122.3 49160.3 49182.8 49186.8 1211.5 1213.1 1217.9 1219.0 1231.2 25095.0 25120.4 25286.6 25731.9 29816.4 43619.3 44185.3 44213.6 44250.3 44253.6 239795.0 241740.0 242483.0 242669.0 243258.0 28799.9 31368.2 34676.8 38805.8 43194.6 37579.8 38071.4 38204.8 38630.8 39117.6 32724.3 33214.2 33298.8 33487.5 33627.5 30174.2 37969.4 38330.6 39477.8 39932.0 32119.8 32712.0 32803.4 33412.7 33498.0 29032.4 29544.9 29909.0 29920.6 30080.8 22961.8 23144.8 25057.6 25191.6 26883.0 04:28:18 INFO - 2015-12-14 04:28:18,716 DEBUG : BROWSER_OUTPUT: 04:28:18 INFO - 2015-12-14 04:28:18,716 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27541.60 Median:4146.67 stddev:87934.77 (2120.6%) stddev-sans-first:88157.70 04:28:18 INFO - 2015-12-14 04:28:18,716 DEBUG : BROWSER_OUTPUT: Values: 324.6 330.4 336.0 336.1 337.0 12631.9 12925.4 14817.9 15387.9 15397.6 13813.9 14267.1 14492.9 15042.0 15055.9 4103.2 5055.5 5088.3 5117.6 5205.4 5180.9 5215.5 5223.5 5223.6 5224.7 5026.2 5087.9 5090.9 5165.8 5178.3 5083.2 5110.2 5111.9 5119.1 5120.9 4431.6 4504.6 4527.2 4568.1 4570.2 19467.2 19599.5 19777.4 19784.3 19823.5 1716.9 1813.3 1871.1 1997.6 2060.0 9209.4 9282.4 12056.4 12119.6 12834.1 1704.3 1707.5 1813.9 1839.4 1847.3 50589.7 51863.2 53522.5 56523.7 58125.7 9139.5 9377.0 9511.1 9582.6 9634.5 10796.4 11028.6 11716.9 12431.3 12438.2 6520.6 6599.5 6606.0 6636.4 6652.5 6197.5 6211.2 6221.5 6262.7 6343.7 4117.8 4119.4 4173.9 4226.2 4237.3 1678.5 1711.3 1713.5 1717.9 1757.1 833.5 902.9 978.1 994.3 1000.5 15094.6 16211.1 16212.8 16476.8 16594.3 795.6 806.3 817.1 817.3 828.7 6888.9 8965.4 9288.6 9431.2 9530.0 501053.0 508202.0 557997.0 558058.0 566158.0 55067.1 61907.7 68613.7 72849.6 73983.6 1020.9 1030.9 1044.9 1077.7 1078.0 14459.3 14703.7 14749.9 14837.3 14932.6 33883.7 33943.0 33983.5 34809.8 35599.0 43778.6 44777.6 45577.8 46037.8 47170.0 8707.3 8720.5 8824.8 8923.2 8928.2 10527.3 10557.8 10593.4 10654.7 11123.7 13166.5 13936.9 14003.5 14007.2 14028.2 12701.2 13018.2 13161.3 13549.2 13550.1 13259.3 13416.1 13472.3 13871.6 13957.1 8386.7 8861.1 8916.2 9132.6 9173.9 9452.4 12712.3 13756.3 13916.4 14524.9 04:28:18 INFO - 2015-12-14 04:28:18,716 DEBUG : BROWSER_OUTPUT: 04:28:18 INFO - 2015-12-14 04:28:18,716 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4985.73 Median:6229.27 stddev:2591.71 (41.6%) stddev-sans-first:2585.34 04:28:18 INFO - 2015-12-14 04:28:18,717 DEBUG : BROWSER_OUTPUT: Values: 1447.7 1630.3 1687.4 1695.7 1748.1 5760.7 6992.5 7247.6 7251.7 7256.5 7117.7 7281.2 7281.5 7285.3 7303.2 1765.9 1795.3 1796.8 2092.9 2147.6 2081.1 2124.6 2125.7 2127.9 2133.9 2038.6 2058.0 2063.2 2070.1 2096.8 2095.5 2105.6 2119.1 2122.8 2124.3 2097.5 2124.5 2128.2 2129.2 2131.6 7179.2 7300.5 7304.5 7312.6 7327.9 3998.9 4091.1 4096.2 4103.8 4104.6 2651.5 2697.1 2761.3 2785.5 2793.3 825.5 848.9 872.5 876.9 883.6 9651.7 9694.4 9706.2 9717.6 9721.9 3932.2 3968.7 4004.8 4030.3 4060.3 8378.2 8400.9 8401.8 8402.5 8409.5 4183.0 4216.5 4220.1 4226.5 4230.9 3770.3 3771.2 3772.9 3774.3 3778.8 2976.1 3041.8 3373.2 3495.4 3496.7 1069.8 1090.9 1090.9 1096.4 1103.3 849.7 851.4 851.6 852.2 1021.2 6600.2 6659.1 6668.2 6678.7 6680.0 1026.8 1038.9 1041.7 1062.4 1068.5 5048.8 5124.0 5126.8 5131.7 5133.9 8036.3 8196.5 8398.0 8549.4 8658.2 8266.3 8419.3 8423.5 8434.7 8435.0 6507.6 6859.4 6965.8 7000.7 7014.7 6861.3 6904.5 6905.6 6912.6 6914.4 7679.2 7731.5 7742.0 7841.5 7877.0 7821.2 7939.2 8036.7 8044.0 8049.0 6188.7 6221.9 6235.7 6254.9 6265.2 5645.7 5959.8 6467.2 6535.9 6612.2 6222.9 6415.8 6485.1 6543.3 6555.7 6419.2 6422.8 6437.0 6443.8 6553.5 5927.9 6369.3 6414.1 6436.9 6450.3 5984.5 6051.0 6059.4 6067.5 6069.2 6112.0 6191.9 6209.6 6248.8 6253.9 04:28:18 INFO - 2015-12-14 04:28:18,717 DEBUG : BROWSER_OUTPUT: 04:28:18 INFO - 2015-12-14 04:28:18,718 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4702.79 Median:5318.47 stddev:1377.41 (25.9%) stddev-sans-first:1340.92 04:28:18 INFO - 2015-12-14 04:28:18,718 DEBUG : BROWSER_OUTPUT: Values: 293.2 301.8 305.4 312.6 315.8 5328.6 5344.4 5396.5 5399.9 5408.2 5318.1 5318.8 5326.6 5332.5 5347.5 3969.7 4188.5 4194.9 4198.7 4200.4 4052.0 4078.3 4188.1 4193.8 4210.8 4144.2 4148.8 4150.8 4153.0 4154.0 3911.9 4002.2 4028.9 4155.2 4162.6 3659.8 3661.7 3673.0 3673.7 3675.4 5128.9 5130.8 5131.7 5134.8 5147.9 4798.4 4805.6 4808.8 4811.6 4816.5 5512.4 5644.9 5658.9 5659.5 5672.1 4023.7 4028.0 4029.9 4030.5 4032.7 5946.3 5949.7 5954.6 5955.0 5955.1 4116.1 4117.5 4123.3 4124.0 4130.5 4082.6 4169.4 4171.8 4184.9 4243.3 4788.8 4791.4 4793.5 4796.5 4803.2 5665.6 5667.2 5672.7 5673.1 5687.7 1466.6 1491.5 1492.1 1493.2 1494.3 1014.4 1020.9 1027.2 1030.2 1051.5 4999.8 5009.0 5009.1 5015.4 5021.1 5869.3 5870.1 5877.4 5880.3 5880.7 4982.4 5002.0 5007.1 5014.0 5015.6 2925.2 2987.0 3107.0 3132.7 3169.0 5522.8 5523.0 5571.7 5583.9 5586.1 6071.3 6080.3 6085.1 6091.3 6093.8 5562.2 5563.5 5568.0 5577.2 5577.2 5703.7 5849.0 5900.1 5906.6 5940.1 5790.1 5796.1 5796.3 5797.7 5798.4 5574.7 5579.4 5583.1 5587.3 5598.9 3903.2 4032.9 4066.7 4072.1 4077.9 5859.4 5859.9 5866.1 5875.1 5876.7 5638.7 5648.4 5649.5 5650.7 5650.7 5641.0 5642.9 5643.5 5644.5 5659.0 5407.5 5514.1 5528.4 5531.6 5540.4 5672.1 5685.7 5688.4 5688.9 5689.0 5362.9 5481.8 5498.1 5583.5 5603.5 04:28:18 INFO - 2015-12-14 04:28:18,718 DEBUG : BROWSER_OUTPUT: 04:28:18 INFO - 2015-12-14 04:28:18,718 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12056.30 Median:40647.50 stddev:13250.33 (32.6%) stddev-sans-first:13259.58 04:28:18 INFO - 2015-12-14 04:28:18,718 DEBUG : BROWSER_OUTPUT: Values: 603.8 652.6 755.5 763.0 768.8 11665.2 12542.2 12558.9 12560.1 12614.1 11704.3 11786.8 11823.2 11824.5 11854.4 436.7 443.9 810.1 810.9 827.6 811.9 812.3 818.9 819.1 819.2 541.3 851.3 859.1 859.5 860.2 544.2 836.2 840.7 849.1 850.1 632.0 633.7 633.9 634.1 634.2 10511.8 10523.9 10537.6 10590.0 10633.8 10230.6 11064.8 11168.0 11411.1 11549.7 9107.2 9261.4 9355.3 9362.0 9518.2 3243.6 3278.6 3302.6 3325.7 3375.2 37531.6 37539.4 37683.4 37921.8 37986.2 9401.3 9480.4 9536.0 9889.9 10039.5 16483.5 16527.2 16550.9 16572.2 16606.5 6205.0 6494.4 6522.6 6644.7 6706.7 3692.7 3697.6 3699.7 3734.0 3794.8 2605.7 2627.7 2637.8 2639.5 2646.7 475.2 493.1 497.6 497.8 503.9 465.9 483.4 509.6 585.9 620.2 7701.0 7716.0 8009.0 8328.5 8852.4 466.4 487.1 503.8 526.8 637.4 3527.4 3640.5 3652.8 3851.3 3857.5 47595.3 47822.3 47964.8 47991.5 48010.3 39479.4 39490.0 39772.0 41424.6 43796.8 40094.6 40289.2 40341.0 40954.0 41255.8 7949.6 8298.3 8338.5 8359.0 8550.5 31244.1 31489.8 31517.8 32164.2 32672.7 38004.2 38269.8 39037.6 39233.8 39289.6 9987.6 10089.0 10327.6 10377.5 10395.9 11544.4 11718.4 11814.6 12278.1 12287.6 9930.0 10013.3 10096.4 10110.4 10835.9 10570.0 10621.6 10798.6 11076.9 11091.3 10601.3 10855.0 10954.9 11125.9 11140.4 9036.5 9139.9 9225.0 9406.4 10048.1 9034.9 9223.3 9394.3 9415.4 9578.4 04:28:18 INFO - 2015-12-14 04:28:18,718 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:28:18 INFO - 2015-12-14 04:28:18,718 DEBUG : BROWSER_OUTPUT: 04:28:19 INFO - 2015-12-14 04:28:19,497 INFO : Browser exited with error code: 0 04:28:19 INFO - 2015-12-14 04:28:19,513 INFO : Completed test dromaeo_css (00:18:38) 04:28:19 INFO - 2015-12-14 04:28:19,514 INFO : Starting test kraken 04:28:19 INFO - 2015-12-14 04:28:19,514 DEBUG : operating with platform_type : linux_ 04:28:19 INFO - 2015-12-14 04:28:19,514 INFO : Initialising browser for kraken test... 04:28:19 INFO - 2015-12-14 04:28:19,520 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqbcTGQ/profile http://localhost:59412/getInfo.html 04:28:23 INFO - 2015-12-14 04:28:23,985 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:28:23 INFO - 2015-12-14 04:28:23,985 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:28:23 INFO - 2015-12-14 04:28:23,985 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:28:23 INFO - 2015-12-14 04:28:23,985 DEBUG : BROWSER_OUTPUT: __metrics 04:28:24 INFO - 2015-12-14 04:28:24,081 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:28:24 INFO - 2015-12-14 04:28:24,142 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:28:25 INFO - 2015-12-14 04:28:25,440 INFO : Browser initialized. 04:28:25 INFO - 2015-12-14 04:28:25,441 INFO : Running cycle 1/1 for kraken test... 04:28:25 INFO - 2015-12-14 04:28:25,441 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqbcTGQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:28:37 INFO - 2015-12-14 04:28:37,417 DEBUG : BROWSER_OUTPUT: RSS: Main: 143052800 04:28:37 INFO - 2015-12-14 04:28:37,417 DEBUG : BROWSER_OUTPUT: 04:28:40 INFO - 2015-12-14 04:28:40,019 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59412/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59412/tests/kraken/driver.html?testName=audio-beat-detection) 04:28:40 INFO - 2015-12-14 04:28:40,620 DEBUG : BROWSER_OUTPUT: RSS: Main: 179929088 04:28:40 INFO - 2015-12-14 04:28:40,621 DEBUG : BROWSER_OUTPUT: 04:28:43 INFO - 2015-12-14 04:28:43,367 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59412/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59412/tests/kraken/driver.html?testName=audio-dft) 04:28:43 INFO - 2015-12-14 04:28:43,947 DEBUG : BROWSER_OUTPUT: RSS: Main: 167096320 04:28:43 INFO - 2015-12-14 04:28:43,948 DEBUG : BROWSER_OUTPUT: 04:28:46 INFO - 2015-12-14 04:28:46,932 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59412/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59412/tests/kraken/driver.html?testName=audio-fft) 04:28:47 INFO - 2015-12-14 04:28:47,501 DEBUG : BROWSER_OUTPUT: RSS: Main: 153694208 04:28:47 INFO - 2015-12-14 04:28:47,502 DEBUG : BROWSER_OUTPUT: 04:28:49 INFO - 2015-12-14 04:28:49,556 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59412/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59412/tests/kraken/driver.html?testName=audio-oscillator) 04:28:50 INFO - 2015-12-14 04:28:50,129 DEBUG : BROWSER_OUTPUT: RSS: Main: 156131328 04:28:50 INFO - 2015-12-14 04:28:50,129 DEBUG : BROWSER_OUTPUT: 04:28:52 INFO - 2015-12-14 04:28:52,391 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59412/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59412/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:28:52 INFO - 2015-12-14 04:28:52,957 DEBUG : BROWSER_OUTPUT: RSS: Main: 157253632 04:28:52 INFO - 2015-12-14 04:28:52,957 DEBUG : BROWSER_OUTPUT: 04:28:55 INFO - 2015-12-14 04:28:55,942 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59412/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59412/tests/kraken/driver.html?testName=imaging-darkroom) 04:28:56 INFO - 2015-12-14 04:28:56,525 DEBUG : BROWSER_OUTPUT: RSS: Main: 157560832 04:28:56 INFO - 2015-12-14 04:28:56,525 DEBUG : BROWSER_OUTPUT: 04:28:59 INFO - 2015-12-14 04:28:59,912 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59412/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59412/tests/kraken/driver.html?testName=imaging-desaturate) 04:29:00 INFO - 2015-12-14 04:29:00,493 DEBUG : BROWSER_OUTPUT: RSS: Main: 157290496 04:29:00 INFO - 2015-12-14 04:29:00,494 DEBUG : BROWSER_OUTPUT: 04:29:03 INFO - 2015-12-14 04:29:03,333 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59412/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59412/tests/kraken/driver.html?testName=json-parse-financial) 04:29:03 INFO - 2015-12-14 04:29:03,907 DEBUG : BROWSER_OUTPUT: RSS: Main: 158547968 04:29:03 INFO - 2015-12-14 04:29:03,908 DEBUG : BROWSER_OUTPUT: 04:29:05 INFO - 2015-12-14 04:29:05,702 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59412/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59412/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:29:06 INFO - 2015-12-14 04:29:06,269 DEBUG : BROWSER_OUTPUT: RSS: Main: 168374272 04:29:06 INFO - 2015-12-14 04:29:06,269 DEBUG : BROWSER_OUTPUT: 04:29:08 INFO - 2015-12-14 04:29:08,171 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59412/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59412/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:29:08 INFO - 2015-12-14 04:29:08,773 DEBUG : BROWSER_OUTPUT: RSS: Main: 165486592 04:29:08 INFO - 2015-12-14 04:29:08,773 DEBUG : BROWSER_OUTPUT: 04:29:10 INFO - 2015-12-14 04:29:10,931 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59412/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59412/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:29:11 INFO - 2015-12-14 04:29:11,512 DEBUG : BROWSER_OUTPUT: RSS: Main: 182906880 04:29:11 INFO - 2015-12-14 04:29:11,512 DEBUG : BROWSER_OUTPUT: 04:29:14 INFO - 2015-12-14 04:29:14,047 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59412/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59412/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:29:14 INFO - 2015-12-14 04:29:14,628 DEBUG : BROWSER_OUTPUT: RSS: Main: 184623104 04:29:14 INFO - 2015-12-14 04:29:14,628 DEBUG : BROWSER_OUTPUT: 04:29:17 INFO - 2015-12-14 04:29:17,195 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59412/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59412/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:29:17 INFO - 2015-12-14 04:29:17,776 DEBUG : BROWSER_OUTPUT: RSS: Main: 184823808 04:29:17 INFO - 2015-12-14 04:29:17,776 DEBUG : BROWSER_OUTPUT: 04:29:19 INFO - 2015-12-14 04:29:19,565 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59412/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59412/tests/kraken/driver.html?testName=ai-astar) 04:29:19 INFO - 2015-12-14 04:29:19,811 DEBUG : BROWSER_OUTPUT: RSS: Main: 241037312 04:29:19 INFO - 2015-12-14 04:29:19,811 DEBUG : BROWSER_OUTPUT: 04:29:19 INFO - 2015-12-14 04:29:19,815 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:29:19 INFO - 2015-12-14 04:29:19,815 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:29:19 INFO - 2015-12-14 04:29:19,815 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:29:19 INFO - 2015-12-14 04:29:19,815 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:29:19 INFO - 2015-12-14 04:29:19,815 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;114;106;112;112;111;101;110;112;111 04:29:19 INFO - 2015-12-14 04:29:19,815 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;129;164;173;131;152;158;130;176;133 04:29:19 INFO - 2015-12-14 04:29:19,815 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;161;161;160;160;162;162;162;164 04:29:19 INFO - 2015-12-14 04:29:19,815 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;80;86;92;71;73;72;101;91;73 04:29:19 INFO - 2015-12-14 04:29:19,815 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;135;93;94;95;129;96;95;129 04:29:19 INFO - 2015-12-14 04:29:19,816 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;109;110;110;110;109;110;110 04:29:19 INFO - 2015-12-14 04:29:19,816 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;146;146;146;146;147;146;146;146 04:29:19 INFO - 2015-12-14 04:29:19,816 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;96;96;95;95;96;99;95 04:29:19 INFO - 2015-12-14 04:29:19,816 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;72;72;71;73;73;73;80;69;70 04:29:19 INFO - 2015-12-14 04:29:19,816 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;68;68;69;68;68;68;68 04:29:19 INFO - 2015-12-14 04:29:19,816 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;86;85;86;91;83;89;85;84;85 04:29:19 INFO - 2015-12-14 04:29:19,816 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;119;120;119;126;117;127;130;120;127 04:29:19 INFO - 2015-12-14 04:29:19,816 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;140;151;147;152;135;148;146;138;137 04:29:19 INFO - 2015-12-14 04:29:19,816 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;68;74;76;69;69;70;68;69;68 04:29:19 INFO - 2015-12-14 04:29:19,816 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:29:19 INFO - 2015-12-14 04:29:19,816 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:29:19 INFO - 2015-12-14 04:29:19,816 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,992 04:29:19 INFO - 2015-12-14 04:29:19,816 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:29:19 INFO - 2015-12-14 04:29:19,816 DEBUG : BROWSER_OUTPUT: __startTimestamp1450096159813__endTimestamp 04:29:19 INFO - 2015-12-14 04:29:19,816 DEBUG : BROWSER_OUTPUT: 04:29:19 INFO - 2015-12-14 04:29:19,820 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:29:19 INFO - 2015-12-14 04:29:19,820 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:29:19 INFO - 2015-12-14 04:29:19,820 DEBUG : BROWSER_OUTPUT: 04:29:19 INFO - 2015-12-14 04:29:19,820 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.90 Median:111.50 stddev:3.75 (3.4%) stddev-sans-first:3.98 04:29:19 INFO - 2015-12-14 04:29:19,820 DEBUG : BROWSER_OUTPUT: Values: 110.0 114.0 106.0 112.0 112.0 111.0 101.0 110.0 112.0 111.0 04:29:19 INFO - 2015-12-14 04:29:19,820 DEBUG : BROWSER_OUTPUT: 04:29:19 INFO - 2015-12-14 04:29:19,820 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.30 Median:157.50 stddev:18.28 (11.6%) stddev-sans-first:19.23 04:29:19 INFO - 2015-12-14 04:29:19,820 DEBUG : BROWSER_OUTPUT: Values: 157.0 129.0 164.0 173.0 131.0 152.0 158.0 130.0 176.0 133.0 04:29:19 INFO - 2015-12-14 04:29:19,820 DEBUG : BROWSER_OUTPUT: 04:29:19 INFO - 2015-12-14 04:29:19,820 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.18 (0.7%) stddev-sans-first:1.24 04:29:19 INFO - 2015-12-14 04:29:19,820 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 161.0 161.0 160.0 160.0 162.0 162.0 162.0 164.0 04:29:19 INFO - 2015-12-14 04:29:19,820 DEBUG : BROWSER_OUTPUT: 04:29:19 INFO - 2015-12-14 04:29:19,821 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.10 Median:76.50 stddev:10.73 (14.0%) stddev-sans-first:10.87 04:29:19 INFO - 2015-12-14 04:29:19,821 DEBUG : BROWSER_OUTPUT: Values: 72.0 80.0 86.0 92.0 71.0 73.0 72.0 101.0 91.0 73.0 04:29:19 INFO - 2015-12-14 04:29:19,821 DEBUG : BROWSER_OUTPUT: 04:29:19 INFO - 2015-12-14 04:29:19,821 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.60 Median:95.00 stddev:17.62 (18.5%) stddev-sans-first:18.27 04:29:19 INFO - 2015-12-14 04:29:19,821 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 135.0 93.0 94.0 95.0 129.0 96.0 95.0 129.0 04:29:19 INFO - 2015-12-14 04:29:19,821 DEBUG : BROWSER_OUTPUT: 04:29:19 INFO - 2015-12-14 04:29:19,821 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 04:29:19 INFO - 2015-12-14 04:29:19,821 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 109.0 110.0 110.0 110.0 109.0 110.0 110.0 04:29:19 INFO - 2015-12-14 04:29:19,821 DEBUG : BROWSER_OUTPUT: 04:29:19 INFO - 2015-12-14 04:29:19,821 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 04:29:19 INFO - 2015-12-14 04:29:19,821 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 04:29:19 INFO - 2015-12-14 04:29:19,821 DEBUG : BROWSER_OUTPUT: 04:29:19 INFO - 2015-12-14 04:29:19,822 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:1.23 (1.3%) stddev-sans-first:1.30 04:29:19 INFO - 2015-12-14 04:29:19,822 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 96.0 96.0 95.0 95.0 96.0 99.0 95.0 04:29:19 INFO - 2015-12-14 04:29:19,822 DEBUG : BROWSER_OUTPUT: 04:29:19 INFO - 2015-12-14 04:29:19,822 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.70 Median:73.00 stddev:2.98 (4.1%) stddev-sans-first:3.13 04:29:19 INFO - 2015-12-14 04:29:19,822 DEBUG : BROWSER_OUTPUT: Values: 74.0 72.0 72.0 71.0 73.0 73.0 73.0 80.0 69.0 70.0 04:29:19 INFO - 2015-12-14 04:29:19,822 DEBUG : BROWSER_OUTPUT: 04:29:19 INFO - 2015-12-14 04:29:19,822 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 04:29:19 INFO - 2015-12-14 04:29:19,822 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 68.0 68.0 69.0 68.0 68.0 68.0 68.0 04:29:19 INFO - 2015-12-14 04:29:19,823 DEBUG : BROWSER_OUTPUT: 04:29:19 INFO - 2015-12-14 04:29:19,823 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:85.50 stddev:2.44 (2.9%) stddev-sans-first:2.50 04:29:19 INFO - 2015-12-14 04:29:19,823 DEBUG : BROWSER_OUTPUT: Values: 84.0 86.0 85.0 86.0 91.0 83.0 89.0 85.0 84.0 85.0 04:29:19 INFO - 2015-12-14 04:29:19,823 DEBUG : BROWSER_OUTPUT: 04:29:19 INFO - 2015-12-14 04:29:19,823 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.30 Median:126.50 stddev:4.72 (3.7%) stddev-sans-first:4.68 04:29:19 INFO - 2015-12-14 04:29:19,823 DEBUG : BROWSER_OUTPUT: Values: 128.0 119.0 120.0 119.0 126.0 117.0 127.0 130.0 120.0 127.0 04:29:19 INFO - 2015-12-14 04:29:19,823 DEBUG : BROWSER_OUTPUT: 04:29:19 INFO - 2015-12-14 04:29:19,823 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.90 Median:146.50 stddev:6.61 (4.5%) stddev-sans-first:6.36 04:29:19 INFO - 2015-12-14 04:29:19,823 DEBUG : BROWSER_OUTPUT: Values: 135.0 140.0 151.0 147.0 152.0 135.0 148.0 146.0 138.0 137.0 04:29:19 INFO - 2015-12-14 04:29:19,823 DEBUG : BROWSER_OUTPUT: 04:29:19 INFO - 2015-12-14 04:29:19,823 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:69.50 stddev:2.74 (3.9%) stddev-sans-first:2.89 04:29:19 INFO - 2015-12-14 04:29:19,824 DEBUG : BROWSER_OUTPUT: Values: 71.0 68.0 74.0 76.0 69.0 69.0 70.0 68.0 69.0 68.0 04:29:19 INFO - 2015-12-14 04:29:19,824 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:29:19 INFO - 2015-12-14 04:29:19,824 DEBUG : BROWSER_OUTPUT: 04:29:20 INFO - 2015-12-14 04:29:20,745 INFO : Browser exited with error code: 0 04:29:20 INFO - 2015-12-14 04:29:20,796 INFO : Completed test kraken (00:01:01) 04:29:20 INFO - 2015-12-14 04:29:20,796 INFO : Starting test v8_7 04:29:20 INFO - 2015-12-14 04:29:20,796 DEBUG : operating with platform_type : linux_ 04:29:20 INFO - 2015-12-14 04:29:20,796 INFO : Initialising browser for v8_7 test... 04:29:20 INFO - 2015-12-14 04:29:20,802 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPNHIct/profile http://localhost:59412/getInfo.html 04:29:25 INFO - 2015-12-14 04:29:25,213 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:29:25 INFO - 2015-12-14 04:29:25,214 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:29:25 INFO - 2015-12-14 04:29:25,214 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:29:25 INFO - 2015-12-14 04:29:25,214 DEBUG : BROWSER_OUTPUT: __metrics 04:29:25 INFO - 2015-12-14 04:29:25,336 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:29:25 INFO - 2015-12-14 04:29:25,412 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:29:26 INFO - 2015-12-14 04:29:26,673 INFO : Browser initialized. 04:29:26 INFO - 2015-12-14 04:29:26,674 INFO : Running cycle 1/1 for v8_7 test... 04:29:26 INFO - 2015-12-14 04:29:26,674 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPNHIct/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:29:38 INFO - 2015-12-14 04:29:38,690 DEBUG : BROWSER_OUTPUT: RSS: Main: 143126528 04:29:38 INFO - 2015-12-14 04:29:38,690 DEBUG : BROWSER_OUTPUT: 04:30:00 INFO - 2015-12-14 04:30:00,072 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59412/tests/v8_7/run.html (next: http://localhost:59412/tests/v8_7/run.html) 04:30:00 INFO - 2015-12-14 04:30:00,322 DEBUG : BROWSER_OUTPUT: RSS: Main: 443609088 04:30:00 INFO - 2015-12-14 04:30:00,322 DEBUG : BROWSER_OUTPUT: 04:30:00 INFO - 2015-12-14 04:30:00,322 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:30:00 INFO - 2015-12-14 04:30:00,323 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:30:00 INFO - 2015-12-14 04:30:00,323 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:30:00 INFO - 2015-12-14 04:30:00,323 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:30:00 INFO - 2015-12-14 04:30:00,323 DEBUG : BROWSER_OUTPUT: |0;Richards;167.81339150864238 04:30:00 INFO - 2015-12-14 04:30:00,323 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.15089798185522 04:30:00 INFO - 2015-12-14 04:30:00,323 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.55153203342616 04:30:00 INFO - 2015-12-14 04:30:00,323 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5175.257731958763 04:30:00 INFO - 2015-12-14 04:30:00,324 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1968.5039370078741 04:30:00 INFO - 2015-12-14 04:30:00,324 DEBUG : BROWSER_OUTPUT: |5;Earley;791.7656373713381 04:30:00 INFO - 2015-12-14 04:30:00,324 DEBUG : BROWSER_OUTPUT: |6;Boyer;12108.43373493976 04:30:00 INFO - 2015-12-14 04:30:00,324 DEBUG : BROWSER_OUTPUT: |7;RegExp;26605.263157894737 04:30:00 INFO - 2015-12-14 04:30:00,324 DEBUG : BROWSER_OUTPUT: |8;Splay;604.9606775559589 04:30:00 INFO - 2015-12-14 04:30:00,324 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 04:30:00 INFO - 2015-12-14 04:30:00,324 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:30:00 INFO - 2015-12-14 04:30:00,325 DEBUG : BROWSER_OUTPUT: __startTimestamp1450096200320__endTimestamp 04:30:00 INFO - 2015-12-14 04:30:00,325 DEBUG : BROWSER_OUTPUT: 04:30:00 INFO - 2015-12-14 04:30:00,325 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:30:00 INFO - 2015-12-14 04:30:00,326 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:30:00 INFO - 2015-12-14 04:30:00,326 DEBUG : BROWSER_OUTPUT: 04:30:00 INFO - 2015-12-14 04:30:00,327 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.81 Median:167.81 stddev:0.00 (0.0%) 04:30:00 INFO - 2015-12-14 04:30:00,327 DEBUG : BROWSER_OUTPUT: Values: 167.8 04:30:00 INFO - 2015-12-14 04:30:00,327 DEBUG : BROWSER_OUTPUT: 04:30:00 INFO - 2015-12-14 04:30:00,327 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.15 Median:185.15 stddev:0.00 (0.0%) 04:30:00 INFO - 2015-12-14 04:30:00,327 DEBUG : BROWSER_OUTPUT: Values: 185.2 04:30:00 INFO - 2015-12-14 04:30:00,327 DEBUG : BROWSER_OUTPUT: 04:30:00 INFO - 2015-12-14 04:30:00,328 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.55 Median:278.55 stddev:0.00 (0.0%) 04:30:00 INFO - 2015-12-14 04:30:00,328 DEBUG : BROWSER_OUTPUT: Values: 278.6 04:30:00 INFO - 2015-12-14 04:30:00,328 DEBUG : BROWSER_OUTPUT: 04:30:00 INFO - 2015-12-14 04:30:00,328 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 04:30:00 INFO - 2015-12-14 04:30:00,328 DEBUG : BROWSER_OUTPUT: Values: 5175.3 04:30:00 INFO - 2015-12-14 04:30:00,329 DEBUG : BROWSER_OUTPUT: 04:30:00 INFO - 2015-12-14 04:30:00,329 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1968.50 Median:1968.50 stddev:0.00 (0.0%) 04:30:00 INFO - 2015-12-14 04:30:00,329 DEBUG : BROWSER_OUTPUT: Values: 1968.5 04:30:00 INFO - 2015-12-14 04:30:00,329 DEBUG : BROWSER_OUTPUT: 04:30:00 INFO - 2015-12-14 04:30:00,329 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:791.77 Median:791.77 stddev:0.00 (0.0%) 04:30:00 INFO - 2015-12-14 04:30:00,329 DEBUG : BROWSER_OUTPUT: Values: 791.8 04:30:00 INFO - 2015-12-14 04:30:00,329 DEBUG : BROWSER_OUTPUT: 04:30:00 INFO - 2015-12-14 04:30:00,329 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12108.43 Median:12108.43 stddev:0.00 (0.0%) 04:30:00 INFO - 2015-12-14 04:30:00,329 DEBUG : BROWSER_OUTPUT: Values: 12108.4 04:30:00 INFO - 2015-12-14 04:30:00,329 DEBUG : BROWSER_OUTPUT: 04:30:00 INFO - 2015-12-14 04:30:00,329 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26605.26 Median:26605.26 stddev:0.00 (0.0%) 04:30:00 INFO - 2015-12-14 04:30:00,329 DEBUG : BROWSER_OUTPUT: Values: 26605.3 04:30:00 INFO - 2015-12-14 04:30:00,329 DEBUG : BROWSER_OUTPUT: 04:30:00 INFO - 2015-12-14 04:30:00,330 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:604.96 Median:604.96 stddev:0.00 (0.0%) 04:30:00 INFO - 2015-12-14 04:30:00,330 DEBUG : BROWSER_OUTPUT: Values: 605.0 04:30:00 INFO - 2015-12-14 04:30:00,330 DEBUG : BROWSER_OUTPUT: 04:30:00 INFO - 2015-12-14 04:30:00,330 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 04:30:00 INFO - 2015-12-14 04:30:00,330 DEBUG : BROWSER_OUTPUT: Values: 4830.9 04:30:00 INFO - 2015-12-14 04:30:00,330 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:30:00 INFO - 2015-12-14 04:30:00,330 DEBUG : BROWSER_OUTPUT: 04:30:01 INFO - 2015-12-14 04:30:01,225 INFO : Browser exited with error code: 0 04:30:01 INFO - 2015-12-14 04:30:01,242 INFO : Completed test v8_7 (00:00:40) 04:30:01 INFO - 2015-12-14 04:30:01,381 INFO : Completed test suite (00:20:20) 04:30:01 INFO - 2015-12-14 04:30:01,381 DEBUG : Working with test: dromaeo_css 04:30:01 INFO - 2015-12-14 04:30:01,382 DEBUG : Generating results file: dromaeo_css 04:30:01 INFO - 2015-12-14 04:30:01,383 DEBUG : Working with test: kraken 04:30:01 INFO - 2015-12-14 04:30:01,383 DEBUG : Generating results file: kraken 04:30:01 INFO - 2015-12-14 04:30:01,383 INFO : javascript benchmark 04:30:01 INFO - 2015-12-14 04:30:01,383 DEBUG : Working with test: v8_7 04:30:01 INFO - 2015-12-14 04:30:01,383 DEBUG : Generating results file: v8_7 04:30:01 INFO - 2015-12-14 04:30:01,384 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:30:01 INFO - 2015-12-14 04:30:01,436 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 04:30:01 INFO - 2015-12-14 04:30:01,436 DEBUG : process_Request line: dromaeo_css 6360.95 graph.html#tests=[[72,94,35]] 04:30:01 INFO - 2015-12-14 04:30:01,436 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:30:01 INFO - 2015-12-14 04:30:01,467 DEBUG : process_Request line: kraken 1523.10 graph.html#tests=[[232,94,35]] 04:30:01 INFO - 2015-12-14 04:30:01,467 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:30:01 INFO - 2015-12-14 04:30:01,495 DEBUG : process_Request line: v8_7 19844.70 graph.html#tests=[[230,94,35]] 04:30:01 INFO - 2015-12-14 04:30:01,496 INFO : javascript benchmark 04:30:01 INFO - 2015-12-14 04:30:01,500 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2633.5391306521356, 2733.83596984181, 2734.371094648232, 2744.2727677165544, 2771.5149848776464, 4507.774611269431, 4617.769111544418, 4786.688865223758, 4792.041591681665, 4814.229723244282, 4601.654875884314, 4712.552307530787, 4768.690035147713, 4773.80904763809, 4830.2754586812, 4308.547602501739, 4391.890202744941, 4463.799129039185, 4514.8194072237075, 4549.61328287096, 4469.865904022869, 4527.4567051953645, 4530.66020048496, 4541.386912766784, 4575.359449677031, 4192.9790351048205, 4285.764282964436, 4302.677299202541, 4402.735835849827, 4437.356583295436, 4445.666575006888, 4448.5773851484055, 4458.621017213508, 4460.241758900995, 4494.303382975644, 4383.630053184855, 4403.6256918162, 4424.0, 4432.490263619693, 4453.799579018952, 4557.908841823178, 4630.83792067276, 4677.859664210079, 4703.412073490814, 4764.737939413331, 5165.66423182492, 5172.896542069175, 5173.430922598549, 5178.042062218502, 5181.53366197044, 5188.066148093341, 5190.06578815813, 5199.194124910645, 5202.635815492917, 5244.632875698702, 4635.281531362644, 4738.147133516, 4807.471178170398, 4816.20532612115, 4816.4220293564995, 5108.642395032312, 5163.535281824654, 5250.894982100413, 5262.158054711228, 5302.602304827154, 5068.82259120929, 5112.079825631347, 5114.744262786846, 5116.846494605168, 5117.078925793393, 5196.662216955886, 5203.375594928632, 5207.453217412193, 5210.8957820844125, 5240.580753539708, 4799.544043315879, 4975.850724478271, 4983.352164218701, 4993.300937868701, 5111.131107711698, 5026.52248036436, 5041.470645582234, 5056.873578160502, 5065.924011139836, 5117.897642047138, 4262.6376757975295, 4268.359746038119, 4269.039466120098, 4269.274223382033, 4317.028668549551, 3620.5474315710535, 3679.8344074516713, 3729.5151630287887, 3736.1593641431004, 3768.8304026318883, 4434.091011342732, 4441.933370999438, 4443.37792709021, 4449.621782148553, 4494.865154045384, 5130.48695130484, 5132.486751324912, 5135.743212839343, 5138.640295179302, 5185.662931909414, 4304.978475107604, 4353.564643535621, 4402.119576084796, 4405.845795397146, 4456.952616135206, 4612.884677883013, 4625.861224163281, 4630.259158534618, 4637.095766325534, 4666.626669866402, 4926.679765815211, 4939.061578300111, 4942.6293028023765, 4947.628927830499, 4989.750512474289, 4919.262110683426, 5033.2701758245585, 5035.59715222774, 5213.0, 5228.45101264377, 4791.401074865642, 4802.423709154924, 4868.683535570177, 4891.070696567641, 4896.167651499325, 5023.522765337287, 5052.115879720961, 5101.591872650253, 5128.538431541179, 5133.921876405997, 5176.0, 5205.92191117126, 5208.557272631869, 5213.713245771367, 5253.973730131478, 4729.527047295243, 4876.414830220397, 4877.878053048702, 5013.373328333958, 5041.168207245763, 4914.729689867092, 4996.900061998667, 5038.244263360525, 5046.84859454217, 5086.618503612318, 4792.976035119802, 4836.758162091952, 4861.829835955866, 4862.3922009748785, 4916.557509824133, 4719.905601888012, 4839.128956787671, 4839.177339852163, 4972.378452693413, 4976.2286845539, 4769.8790784165, 4824.179889418737, 4831.227003679394, 4839.758012099311, 4882.36529251195], "unit": "ms", "name": "dojo.html", "value": 4695.48433282357}, {"lowerIsBetter": false, "replicates": [554.1272495819085, 559.3679142568898, 564.3848205456052, 570.4466667332691, 573.0659025787965, 27149.59275610865, 35201.64798352015, 36188.27623447529, 36274.455883161776, 36323.81838090806, 39645.80177099118, 40039.399409008816, 40089.59910400895, 40095.39856902142, 40175.397369039485, 6891.276415976326, 7009.649517524129, 7866.370690344758, 8034.758957231264, 8037.758867233963, 10189.847152292721, 10473.31923424975, 10473.895261047368, 10476.161907047417, 10480.685579432591, 10089.243306751987, 10138.442385668784, 10170.288079834414, 10196.082352588266, 10197.745056373613, 7140.928590714104, 7301.1603665578605, 7307.3058059484265, 7317.634118294064, 10037.849432258485, 9947.701568952943, 10140.442275674835, 10162.441065741381, 10169.135623472013, 10169.847452288222, 36528.45207321892, 37056.62943370586, 37089.62910370916, 37163.81418092919, 37174.442383364, 2801.089645865102, 2890.4363649088436, 2945.661248956376, 3103.953440698391, 3352.8826491072696, 28310.0, 28555.428891422263, 28709.28226794326, 29004.709952900623, 29064.12807615775, 3388.762786604939, 3468.7745296555645, 3472.4444088945647, 3511.929761404783, 3519.63043880394, 219078.0, 221136.0, 221610.0, 222262.0, 222528.0, 52053.0, 57265.427345726006, 57598.7120064397, 57656.423435765944, 57697.13454298189, 47080.0, 65782.0, 66776.6661166691, 67515.66242168758, 67600.0, 12458.252504849737, 12596.874031259571, 12600.4329805159, 12601.180923240143, 12602.936985315015, 9641.807163856824, 9750.366226195416, 9754.658586949423, 9768.07203315684, 9769.071938165864, 19238.61522769537, 19247.422577322704, 19394.0, 19511.512212194524, 19522.804771952382, 7516.285952834472, 7750.922490775133, 7833.686652533835, 7877.724279650185, 7960.726283794681, 842.8609279468942, 858.2533196119416, 873.9257163141205, 956.8995255498212, 1078.5955266774959, 25089.0, 25688.229353119437, 25707.87146064258, 25767.484650306887, 25788.74211257901, 912.2610685344891, 949.4493193947494, 1040.089921318846, 1100.1693721240413, 1106.25880659958, 13224.867751322556, 13379.799303010463, 13393.330333483287, 13578.660533486543, 13586.864131358758, 309135.0, 312422.0, 312556.0, 313393.0, 314137.0, 48562.27156592654, 49122.26316605254, 49160.26259606109, 49182.75408622934, 49186.75406622944, 1211.5032836536977, 1213.0841214882707, 1217.8903898649164, 1218.994329678019, 1231.205872212436, 25095.0, 25120.37199070038, 25286.620700689873, 25731.871340643178, 29816.403671926873, 43619.34570981501, 44185.33721994237, 44213.55786442223, 44250.33624495571, 44253.55746442494, 239795.0, 241740.0, 242483.0, 242669.0, 243258.0, 28799.85600071986, 31368.215794605316, 34676.826615867765, 38805.80597096997, 43194.568054319054, 37579.805716514406, 38071.42892856554, 38204.80897595494, 38630.80684596559, 39117.608823911396, 32724.34551309008, 33214.16964575905, 33298.833505832314, 33487.49768753422, 33627.49558756669, 30174.245643859078, 37969.4304585437, 38330.61669383271, 39477.802610986764, 39932.0, 32119.839400802848, 32712.0, 32803.391626920544, 33412.665873341924, 33498.0, 29032.41935161243, 29544.852275738485, 29909.0, 29920.55119173258, 30080.849595752756, 22961.770382296632, 23144.768552314934, 25057.624135637616, 25191.622125667764, 26883.0], "unit": "ms", "name": "ext.html", "value": 17485.067729892937}, {"lowerIsBetter": false, "replicates": [324.6347858659009, 330.39537646107624, 335.9916002099947, 336.07076433660933, 337.03607682029406, 12631.873681263185, 12925.418356173972, 14817.851821481796, 15387.923060384697, 15397.6150596235, 13813.861861381383, 14267.1439713617, 14492.927535362334, 15042.022268552537, 15055.92472037641, 4103.179364127186, 5055.494450554934, 5088.287639730441, 5117.590592752571, 5205.427402985669, 5180.896382072357, 5215.504527069941, 5223.477652234784, 5223.608229382792, 5224.7387630618505, 5026.195808670614, 5087.898242035157, 5090.949090509084, 5165.845024649267, 5178.300929374524, 5083.212102124176, 5110.156824124015, 5111.923321150186, 5119.10415677255, 5120.92318615221, 4431.5789999950275, 4504.6396288296855, 4527.1624749421135, 4568.063546972896, 4570.154521413549, 19467.221311147678, 19599.510012249666, 19777.40667779969, 19784.30754923585, 19823.504412389662, 1716.9399071032453, 1813.3200049981258, 1871.129924585061, 1997.6204521141083, 2060.042080432606, 9209.401388909766, 9282.396644218104, 12056.397180140957, 12119.636410907688, 12834.101612887102, 1704.3012364930444, 1707.5133586927666, 1813.882097663661, 1839.4389711138097, 1847.3257261099602, 50589.74705126488, 51863.22205166963, 53522.464775352135, 56523.71738141324, 58125.7093714533, 9139.543022848964, 9377.0, 9511.096445837635, 9582.616695332108, 9634.470104144339, 10796.352218866894, 11028.613998510014, 11716.94141529287, 12431.254124752544, 12438.19151755133, 6520.576162549419, 6599.538032337787, 6606.042123892009, 6636.402723754885, 6652.467802575782, 6197.504199664016, 6211.16149319836, 6221.47117495018, 6262.655553944577, 6343.746250150035, 4117.794110294473, 4119.402686610425, 4173.937390939138, 4226.239276930182, 4237.343211802176, 1678.4880611413637, 1711.3325802936865, 1713.468824664358, 1717.8883372580742, 1757.1390018890652, 833.5082301442178, 902.873597696323, 978.0610613810821, 994.3387647214521, 1000.4847503535685, 15094.622634434227, 16211.108389038716, 16212.75680864788, 16476.83523164777, 16594.253258603392, 795.5544894858782, 806.2864365036985, 817.0767033252387, 817.2603793566832, 828.6643909216776, 6888.896666550006, 8965.413984129438, 9288.628454861864, 9431.198348140484, 9530.0, 501053.0, 508202.0, 557997.0, 558058.0, 566158.0, 55067.07265245697, 61907.690461547405, 68613.65693171503, 72849.6357518209, 73983.63008185032, 1020.938743675367, 1030.8659874216303, 1044.9007344302279, 1077.6605369308643, 1077.983830242547, 14459.349329279998, 14703.705925881637, 14749.852501474848, 14837.332320045409, 14932.62668433298, 33883.661163389035, 33943.0, 33983.49024764581, 34809.8259508711, 35599.0, 43778.562214377445, 44777.55222447734, 45577.77211113923, 46037.76981115073, 47170.0, 8707.259882910024, 8720.476771393736, 8824.823503530022, 8923.196912277926, 8928.196462318423, 10527.263091583516, 10557.841632375366, 10593.417362045162, 10654.680359589225, 11123.666290011313, 13166.539171128965, 13936.928783825462, 14003.50987715425, 14007.159570425807, 14028.22844743508, 12701.174423662433, 13018.15382000167, 13161.27612981257, 13549.187048777105, 13550.119242249222, 13259.337033148111, 13416.060875738995, 13472.259025753285, 13871.583852484442, 13957.092788968685, 8386.706465273686, 8861.113888611088, 8916.242119419663, 9132.589033493376, 9173.908260917573, 9452.385594936308, 12712.3008234548, 13756.312184390541, 13916.443342266197, 14524.927375363055], "unit": "ms", "name": "jquery.html", "value": 8169.292738901204}, {"lowerIsBetter": false, "replicates": [1447.652563384788, 1630.290823491781, 1687.3672372860178, 1695.7032519309118, 1748.1434097292322, 5760.7407666655, 6992.47556433267, 7247.565146091239, 7251.7461888833905, 7256.528325658828, 7117.679704413301, 7281.162666293378, 7281.453890958172, 7285.344319011288, 7303.233160518135, 1765.8763886527947, 1795.3446991847948, 1796.7843858736906, 2092.884891330976, 2147.5919575280723, 2081.0739221046642, 2124.5538436928264, 2125.6811478278305, 2127.914883404662, 2133.9146434142694, 2038.6024725178597, 2057.9794202057938, 2063.1541068162055, 2070.109852763311, 2096.8427367947465, 2095.486605781578, 2105.5558866178008, 2119.141747592212, 2122.7664956854655, 2124.2671278409002, 2097.5070858348276, 2124.5007423255524, 2128.2019242783954, 2129.169623846701, 2131.5523740014614, 7179.246179151219, 7300.525465844757, 7304.525205861655, 7312.561246325237, 7327.853442931165, 3998.8800335989968, 4091.079507110906, 4096.160287141129, 4103.774292413916, 4104.610062044131, 2651.4564514274525, 2697.0560303893676, 2761.2682639100653, 2785.470760555508, 2793.25978615667, 825.5046971816862, 848.9235968762779, 872.4808738800467, 876.9123087691244, 883.5891310540566, 9651.71044868655, 9694.418334899858, 9706.155830392203, 9717.619183300067, 9721.90278097217, 3932.2135572885536, 3968.66266367362, 4004.839806407711, 4030.3349947258375, 4060.3300455424524, 8378.24595786382, 8400.873986890201, 8401.789955251168, 8402.495850249004, 8409.453385529921, 4183.0, 4216.494020717472, 4220.092680073799, 4226.450561426995, 4230.873073807791, 3770.321342158438, 3771.2080463102507, 3772.9434058489146, 3774.2640185164178, 3778.8110594470168, 2976.1071678496364, 3041.7718671099756, 3373.1735724747596, 3495.405781017233, 3496.6852983231634, 1069.7539565899888, 1090.8636420447444, 1090.86909570852, 1096.4188979840537, 1103.332483847277, 849.6941101203562, 851.3997631669782, 851.6295411496019, 852.1691350932791, 1021.2391768132788, 6600.174978127734, 6659.101021362054, 6668.166479190101, 6678.699458524378, 6680.0, 1026.830572955454, 1038.870141232346, 1041.7187359413067, 1062.3625824505234, 1068.4978060311641, 5048.848534543969, 5124.026434977342, 5126.79492820283, 5131.717755523482, 5133.897322053538, 8036.316913062338, 8196.508209507449, 8398.0, 8549.444286121383, 8658.220760131493, 8266.338692904554, 8419.284360829399, 8423.536705481258, 8434.704785332484, 8435.0, 6507.577007494498, 6859.416949559243, 6965.79102626922, 7000.719971201197, 7014.719411223596, 6861.279565645735, 6904.482163837632, 6905.620190889549, 6912.619805910723, 6914.412274956484, 7679.193684663253, 7731.497452665559, 7742.032245969254, 7841.490303130278, 7877.0, 7821.217878212134, 7939.245771651684, 8036.67853285862, 8044.0, 8048.959755201186, 6188.659623720739, 6221.9377806221355, 6235.657038862906, 6254.906176407449, 6265.154204182377, 5645.661260324394, 5959.791407300723, 6467.223933128054, 6535.934640653722, 6612.239592446737, 6222.875542489215, 6415.839604009937, 6485.0596663484475, 6543.280239173592, 6555.737770489127, 6419.197600299963, 6422.775202868064, 6437.034444833313, 6443.838904027437, 6553.5084868635995, 5927.851803704942, 6369.267534233622, 6414.134091897534, 6436.9034464484, 6450.290468048417, 5984.521238300838, 6050.969745151246, 6059.3637668045985, 6067.484263837623, 6069.150318955438, 6111.96944015277, 6191.938080619136, 6209.627422354673, 6248.812535623939, 6253.874922501615], "unit": "ms", "name": "mootools.html", "value": 4085.1624467362435}, {"lowerIsBetter": false, "replicates": [293.18348399706815, 301.77065430272984, 305.39684123855375, 312.6045552376243, 315.82629553745437, 5328.573714102872, 5344.385395679493, 5396.514313711765, 5399.946000539993, 5408.161734931082, 5318.095923692972, 5318.840434786953, 5326.6005049621235, 5332.466753324676, 5347.518723314901, 3969.7221194516396, 4188.476440444944, 4194.937075943863, 4198.727082739612, 4200.432941552882, 4051.979740101295, 4078.3066878630702, 4188.141431006651, 4193.81127849246, 4210.789460526977, 4144.171165766844, 4148.8133034013545, 4150.83396664133, 4153.044799696072, 4154.0, 3911.9217615647526, 4002.239574480839, 4028.8589899353383, 4155.189738001091, 4162.583741625858, 3659.79871107089, 3661.743677942545, 3672.981635091807, 3673.7244706647107, 3675.4303083022173, 5128.948710512922, 5130.7691153897795, 5131.717755523445, 5134.8202812901745, 5147.897042059138, 4798.424189097295, 4805.567498925078, 4808.831690890802, 4811.59101476375, 4816.470188279286, 5512.421195774426, 5644.915326270109, 5658.858528536778, 5659.490645841894, 5672.092465205547, 4023.718339716221, 4027.9597204027878, 4029.9194016119804, 4030.45588845505, 4032.697547683906, 5946.286445626552, 5949.732262048218, 5954.583179177459, 5955.0, 5955.076963070687, 4116.135611521614, 4117.5176936302905, 4123.319652257344, 4123.958760412417, 4130.504339479282, 4082.559074738338, 4169.395437661583, 4171.791410429466, 4184.937225941613, 4243.27864263076, 4788.784504697227, 4791.425028996473, 4793.520647935178, 4796.544328288807, 4803.159447096814, 5665.575081868877, 5667.234923285386, 5672.716364181774, 5673.120666296731, 5687.7156142192725, 1466.5893549806071, 1491.5003473836168, 1492.0898252066231, 1493.2235237676348, 1494.275276490901, 1014.4065721552827, 1020.9234307426824, 1027.2347101409498, 1030.2376241581326, 1051.542578978147, 4999.775010124553, 5009.0482808266315, 5009.098362294749, 5015.398152221756, 5021.121303771898, 5869.295684517885, 5870.148828419855, 5877.353491115974, 5880.2943646761805, 5880.705964701748, 4982.377202849644, 5002.049610574052, 5007.098722229961, 5014.0, 5015.623828212826, 2925.18094933419, 2986.970130298669, 3107.02128829418, 3132.6554079051284, 3169.017604542599, 5522.751476183581, 5523.033469142964, 5571.721413929368, 5583.888322233533, 5586.050371436865, 6071.271447426248, 6080.270367555833, 6085.117657939574, 6091.329953705089, 6093.817185484442, 5562.2490963721, 5563.527100196528, 5567.972160139173, 5577.191307260506, 5577.191307260506, 5703.657780533182, 5849.0, 5900.1149827526215, 5906.616069955439, 5940.138679891305, 5790.073588225863, 5796.1305804129715, 5796.275465566804, 5797.710114494343, 5798.391168927371, 5574.665520068809, 5579.414161513145, 5583.050881350099, 5587.3015873015875, 5598.86002849932, 3903.219356128729, 4032.9193416130925, 4066.7153299268766, 4072.083781149218, 4077.89805254871, 5859.384764599826, 5859.886621541893, 5866.120081987736, 5875.059990401515, 5876.706164691834, 5638.746256418389, 5648.435156484483, 5649.519790817826, 5650.68921209321, 5650.689212093374, 5640.971795140998, 5642.915356269741, 5643.520300774316, 5644.491995720405, 5658.971705141613, 5407.459254074561, 5514.062609356339, 5528.419515950767, 5531.612787104864, 5540.390557038803, 5672.12082127271, 5685.744141513559, 5688.3742788294085, 5688.886222275449, 5688.971555142198, 5362.865928351823, 5481.808136715196, 5498.147787093007, 5583.469570390806, 5603.467670571289], "unit": "ms", "name": "prototype.html", "value": 4262.646661685038}, {"lowerIsBetter": false, "replicates": [603.8309273403446, 652.6149571752667, 755.5353457623563, 763.0123528209016, 768.753998720409, 11665.24175928564, 12542.184757990735, 12558.937205313961, 12560.120791544585, 12614.117011809154, 11704.297742135477, 11786.7642647147, 11823.172377933548, 11824.527018919232, 11854.407279636027, 436.6681322195123, 443.8690586277056, 810.0724670252557, 810.9189081091903, 827.5613924619961, 811.922867327603, 812.2689579378577, 818.9181081891793, 819.0989911097804, 819.2422009641087, 541.3179393963595, 851.2508992086955, 859.1408591408591, 859.5401460218784, 860.2472836268265, 544.1782907809197, 836.2473773603775, 840.7477756673035, 849.0787495567317, 850.1073872433919, 631.9747210111636, 633.6799916042415, 633.936606339367, 634.0520921222801, 634.210408041986, 10511.78976420475, 10523.947380263126, 10537.631182908639, 10590.0, 10633.840492392621, 10230.590776368936, 11064.834027489595, 11168.0, 11411.144164187635, 11549.6535103947, 9107.180353768194, 9261.398009129452, 9355.298352623513, 9361.953190234006, 9518.190953768937, 3243.594550681165, 3278.557394751702, 3302.570665813429, 3325.667433256679, 3375.1730825947557, 37531.624683753085, 37539.4369084464, 37683.43474847852, 37921.81039094787, 37986.24027519462, 9401.294902882311, 9480.383775054599, 9536.0, 9889.901100989042, 10039.498025098716, 16483.505494835175, 16527.173641317888, 16550.917245413697, 16572.17139143038, 16606.50180494587, 6205.03821907605, 6494.350564943468, 6522.641254731036, 6644.667766611747, 6706.698198581075, 3692.7415080944074, 3697.648723371329, 3699.6855267302044, 3734.047817806442, 3794.79128647927, 2605.7003444604115, 2627.69781475129, 2637.788976881845, 2639.4589109232943, 2646.6559347285115, 475.2253826263169, 493.0508770616549, 497.62926619668576, 497.810831883889, 503.90677724621065, 465.8546355503472, 483.3667895057486, 509.59996402823606, 585.8564651660371, 620.1596836286857, 7700.9614951926005, 7716.0, 8008.959955200186, 8328.541930193776, 8852.3803333766, 466.4239664014939, 487.0721275969284, 503.8085527499527, 526.8419474157737, 637.3690046853674, 3527.4356103023392, 3640.526731524885, 3652.7625704329134, 3851.326017946848, 3857.498525191707, 47595.286070708964, 47822.28266576004, 47964.7601761989, 47991.52008479871, 48010.27984580164, 39479.40780888289, 39490.0, 39772.0, 41424.585754142674, 43796.78101609535, 40094.599054009086, 40289.19421611552, 40341.0, 40954.0, 41255.7937210312, 7949.562774047483, 8298.294644955246, 8338.541380224146, 8358.958205208935, 8550.486970781772, 31244.06267811969, 31489.8425507871, 31517.842410787798, 32164.19589510281, 32672.673273267916, 38004.239915202095, 38269.80865095657, 39037.609623903394, 39233.803830980665, 39289.607103928596, 9987.550560224661, 10089.0, 10327.638532651321, 10377.481125943521, 10395.896041039492, 11544.422778860855, 11718.414079296172, 11814.645560633195, 12278.07914406441, 12287.56993505223, 9930.0, 10013.299069065095, 10096.394216346749, 10110.39337639744, 10835.945820270848, 10570.0, 10621.628243011457, 10798.568057277935, 11076.889231107585, 11091.33451992883, 10601.25791194609, 10855.023047925724, 10954.945225273823, 11125.888741112485, 11140.442977851237, 9036.502992335221, 9139.903211614648, 9225.0, 9406.43561386319, 10048.09567138961, 9034.86447703272, 9223.262139028728, 9394.295427843075, 9415.387999779992, 9578.425294482353], "unit": "ms", "name": "yui.html", "value": 5671.099958153428}], "name": "dromaeo_css", "value": 6360.954523020341}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 114.0, 106.0, 112.0, 112.0, 111.0, 101.0, 110.0, 112.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 109.9}, {"lowerIsBetter": true, "replicates": [157.0, 129.0, 164.0, 173.0, 131.0, 152.0, 158.0, 130.0, 176.0, 133.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.3}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 161.0, 161.0, 160.0, 160.0, 162.0, 162.0, 162.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [72.0, 80.0, 86.0, 92.0, 71.0, 73.0, 72.0, 101.0, 91.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 81.1}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 135.0, 93.0, 94.0, 95.0, 129.0, 96.0, 95.0, 129.0], "unit": "ms", "name": "audio-oscillator", "value": 105.6}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 109.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.2}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 99.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 72.0, 71.0, 73.0, 73.0, 73.0, 80.0, 69.0, 70.0], "unit": "ms", "name": "json-parse-financial", "value": 72.7}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 85.0, 86.0, 91.0, 83.0, 89.0, 85.0, 84.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.8}, {"lowerIsBetter": true, "replicates": [128.0, 119.0, 120.0, 119.0, 126.0, 117.0, 127.0, 130.0, 120.0, 127.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.3}, {"lowerIsBetter": true, "replicates": [135.0, 140.0, 151.0, 147.0, 152.0, 135.0, 148.0, 146.0, 138.0, 137.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 142.9}, {"lowerIsBetter": true, "replicates": [71.0, 68.0, 74.0, 76.0, 69.0, 69.0, 70.0, 68.0, 69.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.2}], "name": "kraken", "value": 1523.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.81339150864238], "unit": "score", "name": "Richards", "value": 210.36461799999995}, {"lowerIsBetter": false, "replicates": [185.15089798185522], "unit": "score", "name": "DeltaBlue", "value": 357.10331800000006}, {"lowerIsBetter": false, "replicates": [278.55153203342616], "unit": "score", "name": "Encrypt", "value": 955.5897900000004}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [1968.5039370078741], "unit": "score", "name": "RayTrace", "value": 375.9144119999999}, {"lowerIsBetter": false, "replicates": [791.7656373713381], "unit": "score", "name": "Earley", "value": 841.7427690000002}, {"lowerIsBetter": false, "replicates": [12108.43373493976], "unit": "score", "name": "Boyer", "value": 55.0412228855721}, {"lowerIsBetter": false, "replicates": [26605.263157894737], "unit": "score", "name": "RegExp", "value": 34.24078140454997}, {"lowerIsBetter": false, "replicates": [604.9606775559589], "unit": "score", "name": "Splay", "value": 134.70462300000003}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19844.701977258945}]} 04:30:01 INFO - RETURN: dromaeo_css: 6360.95 04:30:01 INFO - RETURN: kraken: 1523.10 04:30:01 INFO - RETURN: v8_7: 19844.70 04:30:01 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19844.70"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1523.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6360.95"}}} 04:30:01 INFO - Return code: 0 04:30:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:30:01 INFO - # TBPL SUCCESS # 04:30:01 INFO - Running post-action listener: _resource_record_post_action 04:30:01 INFO - Running post-run listener: _resource_record_post_run 04:30:02 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 4096; Write bytes: 505909248; Read time: 24; Write time: 665616 04:30:02 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 232075264; Read time: 0; Write time: 420768 04:30:02 INFO - run-tests - Wall time: 1222s; CPU: 13.0%; Read bytes: 4096; Write bytes: 273833984; Read time: 24; Write time: 244848 04:30:02 INFO - Running post-run listener: _upload_blobber_files 04:30:02 INFO - Blob upload gear active. 04:30:02 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:30:02 INFO - Copying logs to upload dir... 04:30:02 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1285.591072 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2015-12-14 04:30:00.979137) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-14 04:30:00.982740) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1450094187.277993-2019549519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009946 build_url: 'https://queue.taskcluster.net/v1/task/2NQ69-ULQ1CAR88N_0lw1w/artifacts/public/build/firefox-45.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-14 04:30:01.033338) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 04:30:01.033699) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1450094187.277993-2019549519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004526 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 04:30:01.083214) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-14 04:30:01.083560) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-14 04:30:01.083858) ========= ========= Total master_lag: 0.25 =========