builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-043 starttime: 1449231960.44 results: success (0) buildid: 20151204025717 builduid: 5f2df271dc324214adb2143de4cc12cc revision: a36cc9262f70b95c830ce1ff3bd415f346b46415 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-04 04:26:00.442216) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-04 04:26:00.442744) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-04 04:26:00.443074) ========= 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=ae8083fbfc14dfa356ee9053000001f7-1449230908.547643-1619566471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006449 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-04 04:26:00.482820) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-04 04:26:00.483133) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-04 04:26:00.546954) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 04:26:00.547258) ========= 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=ae8083fbfc14dfa356ee9053000001f7-1449230908.547643-1619566471 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-04 04:26:00.604861) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-04 04:26:00.605180) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-04 04:26:00.605612) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 04:26:00.605931) ========= 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=ae8083fbfc14dfa356ee9053000001f7-1449230908.547643-1619566471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-04 04:26:01-- 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% 96.0M=0s 2015-12-04 04:26:01 (96.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.194298 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 04:26:00.833034) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 04:26:00.833356) ========= 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=ae8083fbfc14dfa356ee9053000001f7-1449230908.547643-1619566471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019395 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 04:26:00.883870) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 04:26:00.884228) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a36cc9262f70b95c830ce1ff3bd415f346b46415 --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 a36cc9262f70b95c830ce1ff3bd415f346b46415 --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=ae8083fbfc14dfa356ee9053000001f7-1449230908.547643-1619566471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-04 04:26:01,470 truncating revision to first 12 chars 2015-12-04 04:26:01,470 Setting DEBUG logging. 2015-12-04 04:26:01,470 attempt 1/10 2015-12-04 04:26:01,470 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a36cc9262f70?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-04 04:26:01,877 unpacking tar archive at: mozilla-central-a36cc9262f70/testing/mozharness/ program finished with exit code 0 elapsedTime=0.702681 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 04:26:01.602861) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-04 04:26:01.603290) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-04 04:26:01.620857) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-04 04:26:01.621244) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-04 04:26:01.621799) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2015-12-04 04:26:01.622159) ========= /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=ae8083fbfc14dfa356ee9053000001f7-1449230908.547643-1619566471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:26:02 INFO - MultiFileLogger online at 20151204 04:26:02 in /builds/slave/test 04:26:02 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:26:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:26:02 INFO - {'append_to_log': False, 04:26:02 INFO - 'base_work_dir': '/builds/slave/test', 04:26:02 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:26:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:26:02 INFO - 'branch': 'Firefox-Non-PGO', 04:26:02 INFO - 'buildbot_json_path': 'buildprops.json', 04:26:02 INFO - 'config_files': ('talos/linux_config.py',), 04:26:02 INFO - 'default_actions': ('clobber', 04:26:02 INFO - 'read-buildbot-config', 04:26:02 INFO - 'download-and-extract', 04:26:02 INFO - 'populate-webroot', 04:26:02 INFO - 'create-virtualenv', 04:26:02 INFO - 'install', 04:26:02 INFO - 'run-tests'), 04:26:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:26:02 INFO - 'download_minidump_stackwalk': True, 04:26:02 INFO - 'download_symbols': 'ondemand', 04:26:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:26:02 INFO - 'tooltool.py': '/tools/tooltool.py', 04:26:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:26:02 INFO - '/tools/misc-python/virtualenv.py')}, 04:26:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:26:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:26:02 INFO - 'installer_path': 'installer.exe', 04:26:02 INFO - 'log_level': 'info', 04:26:02 INFO - 'log_name': 'talos', 04:26:02 INFO - 'log_to_console': True, 04:26:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:26:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:26:02 INFO - 'opt_config_files': (), 04:26:02 INFO - 'pip_index': False, 04:26:02 INFO - 'sps_profile': False, 04:26:02 INFO - 'sps_profile_interval': 0, 04:26:02 INFO - 'suite': 'dromaeojs', 04:26:02 INFO - 'system_bits': '64', 04:26:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:26:02 INFO - 'title': 'talos-linux64-ix-043', 04:26:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:26:02 INFO - 'use_talos_json': True, 04:26:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:26:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:26:02 INFO - 'work_dir': 'build'} 04:26:02 INFO - ##### 04:26:02 INFO - ##### Running clobber step. 04:26:02 INFO - ##### 04:26:02 INFO - Running pre-action listener: _resource_record_pre_action 04:26:02 INFO - Running main action method: clobber 04:26:02 INFO - rmtree: /builds/slave/test/build 04:26:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:26:02 INFO - Running post-action listener: _resource_record_post_action 04:26:02 INFO - ##### 04:26:02 INFO - ##### Running read-buildbot-config step. 04:26:02 INFO - ##### 04:26:02 INFO - Running pre-action listener: _resource_record_pre_action 04:26:02 INFO - Running main action method: read_buildbot_config 04:26:02 INFO - Using buildbot properties: 04:26:02 INFO - { 04:26:02 INFO - "properties": { 04:26:02 INFO - "buildnumber": 228, 04:26:02 INFO - "product": "firefox", 04:26:02 INFO - "script_repo_revision": "production", 04:26:02 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:26:02 INFO - "repository": "", 04:26:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:26:02 INFO - "buildid": "20151204025717", 04:26:02 INFO - "slavename": "talos-linux64-ix-043", 04:26:02 INFO - "pgo_build": "False", 04:26:02 INFO - "basedir": "/builds/slave/test", 04:26:02 INFO - "project": "", 04:26:02 INFO - "platform": "ubuntu64_hw", 04:26:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:26:02 INFO - "slavebuilddir": "test", 04:26:02 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:26:02 INFO - "branch": "mozilla-central", 04:26:02 INFO - "repo_path": "mozilla-central", 04:26:02 INFO - "stage_platform": "linux64", 04:26:02 INFO - "builduid": "5f2df271dc324214adb2143de4cc12cc", 04:26:02 INFO - "revision": "a36cc9262f70b95c830ce1ff3bd415f346b46415" 04:26:02 INFO - }, 04:26:02 INFO - "sourcestamp": { 04:26:02 INFO - "repository": "", 04:26:02 INFO - "hasPatch": false, 04:26:02 INFO - "project": "", 04:26:02 INFO - "branch": "mozilla-central-linux64-talos", 04:26:02 INFO - "changes": [ 04:26:02 INFO - { 04:26:02 INFO - "category": null, 04:26:02 INFO - "files": [ 04:26:02 INFO - { 04:26:02 INFO - "url": null, 04:26:02 INFO - "name": "https://queue.taskcluster.net/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 04:26:02 INFO - } 04:26:02 INFO - ], 04:26:02 INFO - "repository": "", 04:26:02 INFO - "rev": "a36cc9262f70b95c830ce1ff3bd415f346b46415", 04:26:02 INFO - "who": "cbook@mozilla.com", 04:26:02 INFO - "when": 1449231905, 04:26:02 INFO - "number": 6743900, 04:26:02 INFO - "comments": "merge fx-team to mozilla-central a=merge", 04:26:02 INFO - "project": "", 04:26:02 INFO - "at": "Fri 04 Dec 2015 04:25:05", 04:26:02 INFO - "branch": "mozilla-central-linux64-talos", 04:26:02 INFO - "revlink": "", 04:26:02 INFO - "properties": [ 04:26:02 INFO - [ 04:26:02 INFO - "buildid", 04:26:02 INFO - "20151204025717", 04:26:02 INFO - "Change" 04:26:02 INFO - ], 04:26:02 INFO - [ 04:26:02 INFO - "builduid", 04:26:02 INFO - "5f2df271dc324214adb2143de4cc12cc", 04:26:02 INFO - "Change" 04:26:02 INFO - ], 04:26:02 INFO - [ 04:26:02 INFO - "pgo_build", 04:26:02 INFO - "False", 04:26:02 INFO - "Change" 04:26:02 INFO - ] 04:26:02 INFO - ], 04:26:02 INFO - "revision": "a36cc9262f70b95c830ce1ff3bd415f346b46415" 04:26:02 INFO - } 04:26:02 INFO - ], 04:26:02 INFO - "revision": "a36cc9262f70b95c830ce1ff3bd415f346b46415" 04:26:02 INFO - } 04:26:02 INFO - } 04:26:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 04:26:02 INFO - Running post-action listener: _resource_record_post_action 04:26:02 INFO - ##### 04:26:02 INFO - ##### Running download-and-extract step. 04:26:02 INFO - ##### 04:26:02 INFO - Running pre-action listener: _resource_record_pre_action 04:26:02 INFO - Running main action method: download_and_extract 04:26:02 INFO - mkdir: /builds/slave/test/build/tests 04:26:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:02 INFO - https://queue.taskcluster.net/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:26:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/test_packages.json 04:26:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/test_packages.json 04:26:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:26:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:26:11 INFO - Downloaded 1302 bytes. 04:26:11 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:26:11 INFO - Using the following test package requirements: 04:26:11 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:26:11 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:11 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:26:11 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:11 INFO - u'jsshell-linux-x86_64.zip'], 04:26:11 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:11 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:26:11 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:26:11 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:11 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:26:11 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:11 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:26:11 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:11 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:26:11 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:26:11 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:11 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:26:11 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:26:11 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:26:11 INFO - https://queue.taskcluster.net/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:26:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:26:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:26:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z2L0-EeSQdGCw-ehUn5ohw/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:26:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z2L0-EeSQdGCw-ehUn5ohw/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:26:19 INFO - Downloaded 21791534 bytes. 04:26:19 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:26:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:26:19 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:26:20 INFO - Return code: 0 04:26:20 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:26:20 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:26:20 INFO - https://queue.taskcluster.net/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:26:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:26:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:26:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z2L0-EeSQdGCw-ehUn5ohw/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:26:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z2L0-EeSQdGCw-ehUn5ohw/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:26:22 INFO - Downloaded 21791534 bytes. 04:26:22 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:26:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:26:22 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:26:23 INFO - Return code: 0 04:26:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:23 INFO - https://queue.taskcluster.net/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:26:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:26:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:26:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z2L0-EeSQdGCw-ehUn5ohw/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:26:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z2L0-EeSQdGCw-ehUn5ohw/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:26:24 INFO - Downloaded 11132001 bytes. 04:26:24 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:26:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:26:24 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:26:24 INFO - Return code: 0 04:26:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:24 INFO - https://queue.taskcluster.net/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:26:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:26:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:26:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z2L0-EeSQdGCw-ehUn5ohw/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:26:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z2L0-EeSQdGCw-ehUn5ohw/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:26:26 INFO - Downloaded 57695064 bytes. 04:26:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:26:26 INFO - mkdir: /builds/slave/test/properties 04:26:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:26:26 INFO - Writing to file /builds/slave/test/properties/build_url 04:26:26 INFO - Contents: 04:26:26 INFO - build_url:https://queue.taskcluster.net/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:26:26 INFO - Running post-action listener: _resource_record_post_action 04:26:26 INFO - Running post-action listener: set_extra_try_arguments 04:26:26 INFO - ##### 04:26:26 INFO - ##### Running populate-webroot step. 04:26:26 INFO - ##### 04:26:26 INFO - Running pre-action listener: _resource_record_pre_action 04:26:26 INFO - Running main action method: populate_webroot 04:26:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:26:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:26:26 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:26:26 INFO - '../fennec_ids.txt'], 04:26:26 INFO - 'tests': ['tcheck2']}, 04:26:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:26:26 INFO - '--tppagecycles', 04:26:26 INFO - '7'], 04:26:26 INFO - 'tests': ['tsvgm']}}, 04:26:26 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:26:26 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:26:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:26:26 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:26:26 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:26:26 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:26:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:26:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:26 INFO - 'talos_options': ['--e10s'], 04:26:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:26:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:26 INFO - 'tests': ['damp', 'tps']}, 04:26:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:26 INFO - 'talos_options': ['--e10s'], 04:26:26 INFO - 'tests': ['damp', 'tps']}, 04:26:26 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:26:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:26:26 INFO - 'other': {'tests': ['a11yr', 04:26:26 INFO - 'ts_paint', 04:26:26 INFO - 'tpaint', 04:26:26 INFO - 'sessionrestore', 04:26:26 INFO - 'sessionrestore_no_auto_restore']}, 04:26:26 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:26:26 INFO - 'tests': ['a11yr', 04:26:26 INFO - 'ts_paint', 04:26:26 INFO - 'tpaint', 04:26:26 INFO - 'sessionrestore', 04:26:26 INFO - 'sessionrestore_no_auto_restore']}, 04:26:26 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:26:26 INFO - 'tests': ['a11yr', 04:26:26 INFO - 'ts_paint', 04:26:26 INFO - 'tpaint', 04:26:26 INFO - 'sessionrestore', 04:26:26 INFO - 'sessionrestore_no_auto_restore']}, 04:26:26 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:26:26 INFO - 'tests': ['a11yr', 04:26:26 INFO - 'ts_paint', 04:26:26 INFO - 'tpaint', 04:26:26 INFO - 'sessionrestore', 04:26:26 INFO - 'sessionrestore_no_auto_restore']}, 04:26:26 INFO - 'other_l64': {'tests': ['a11yr', 04:26:26 INFO - 'ts_paint', 04:26:26 INFO - 'tpaint', 04:26:26 INFO - 'sessionrestore', 04:26:26 INFO - 'sessionrestore_no_auto_restore']}, 04:26:26 INFO - 'other_nol64': {'tests': ['a11yr', 04:26:26 INFO - 'ts_paint', 04:26:26 INFO - 'tpaint', 04:26:26 INFO - 'sessionrestore', 04:26:26 INFO - 'sessionrestore_no_auto_restore']}, 04:26:26 INFO - 'svgr': {'tests': ['tsvgx', 04:26:26 INFO - 'tsvgr_opacity', 04:26:26 INFO - 'tart', 04:26:26 INFO - 'tscrollx', 04:26:26 INFO - 'cart']}, 04:26:26 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:26:26 INFO - 'tests': ['tsvgx', 04:26:26 INFO - 'tsvgr_opacity', 04:26:26 INFO - 'tart', 04:26:26 INFO - 'tscrollx', 04:26:26 INFO - 'cart']}, 04:26:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:26 INFO - 'tests': ['tp5o']}, 04:26:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:26 INFO - 'talos_options': ['--e10s'], 04:26:26 INFO - 'tests': ['tp5o']}, 04:26:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:26 INFO - 'talos_options': ['--xperf_path', 04:26:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:26:26 INFO - 'tests': ['tp5n']}, 04:26:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:26 INFO - 'talos_options': ['--e10s', 04:26:26 INFO - '--xperf_path', 04:26:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:26:26 INFO - 'tests': ['tp5n']}}, 04:26:26 INFO - 'talos.zip': {'path': '', 04:26:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:26:26 INFO - Running post-action listener: _resource_record_post_action 04:26:26 INFO - ##### 04:26:26 INFO - ##### Running create-virtualenv step. 04:26:26 INFO - ##### 04:26:26 INFO - Running pre-action listener: _resource_record_pre_action 04:26:26 INFO - Running main action method: create_virtualenv 04:26:26 INFO - Creating virtualenv /builds/slave/test/build/venv 04:26:26 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:26:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:26:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:26:26 INFO - Using real prefix '/usr' 04:26:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:26:26 INFO - Installing distribute.............................................................................................................................................................................................done. 04:26:28 INFO - Installing pip.................done. 04:26:28 INFO - Return code: 0 04:26:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:26:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:28 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 0x7fbae9625f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22410b0>, '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 0x2241fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242440>, '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': 'ae8083fbfc14dfa356ee9053000001f7-1449230908.547643-1619566471', '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:26:28 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:26:28 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:26:28 INFO - Using env: {'DISPLAY': ':0', 04:26:28 INFO - 'HOME': '/home/cltbld', 04:26:28 INFO - 'LANG': 'en_US.UTF-8', 04:26:28 INFO - 'LANGUAGE': 'en_US:en', 04:26:28 INFO - 'LOGNAME': 'cltbld', 04:26:28 INFO - 'MAIL': '/var/mail/cltbld', 04:26:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:28 INFO - 'MOZ_NO_REMOTE': '1', 04:26:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:28 INFO - 'NO_EM_RESTART': '1', 04:26:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:28 INFO - 'PWD': '/builds/slave/test', 04:26:28 INFO - 'SHELL': '/bin/bash', 04:26:28 INFO - 'SHLVL': '1', 04:26:28 INFO - 'TERM': 'linux', 04:26:28 INFO - 'TMOUT': '86400', 04:26:28 INFO - 'USER': 'cltbld', 04:26:28 INFO - 'XDG_SESSION_COOKIE': 'ae8083fbfc14dfa356ee9053000001f7-1449230908.547643-1619566471', 04:26:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:28 INFO - '_': '/tools/buildbot/bin/python'} 04:26:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:29 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:26:29 INFO - Cleaning up... 04:26:29 INFO - Return code: 0 04:26:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:26:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:29 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 0x7fbae9625f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22410b0>, '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 0x2241fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242440>, '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': 'ae8083fbfc14dfa356ee9053000001f7-1449230908.547643-1619566471', '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:26:29 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:26:29 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:26:29 INFO - Using env: {'DISPLAY': ':0', 04:26:29 INFO - 'HOME': '/home/cltbld', 04:26:29 INFO - 'LANG': 'en_US.UTF-8', 04:26:29 INFO - 'LANGUAGE': 'en_US:en', 04:26:29 INFO - 'LOGNAME': 'cltbld', 04:26:29 INFO - 'MAIL': '/var/mail/cltbld', 04:26:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:29 INFO - 'MOZ_NO_REMOTE': '1', 04:26:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:29 INFO - 'NO_EM_RESTART': '1', 04:26:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:29 INFO - 'PWD': '/builds/slave/test', 04:26:29 INFO - 'SHELL': '/bin/bash', 04:26:29 INFO - 'SHLVL': '1', 04:26:29 INFO - 'TERM': 'linux', 04:26:29 INFO - 'TMOUT': '86400', 04:26:29 INFO - 'USER': 'cltbld', 04:26:29 INFO - 'XDG_SESSION_COOKIE': 'ae8083fbfc14dfa356ee9053000001f7-1449230908.547643-1619566471', 04:26:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:29 INFO - '_': '/tools/buildbot/bin/python'} 04:26:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:29 INFO - Downloading/unpacking psutil>=0.7.1 04:26:29 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:26:29 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:26:29 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:26:29 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:26:29 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:26:29 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:26:30 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:26:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:26:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:26:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:26:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:26:31 INFO - Installing collected packages: psutil 04:26:31 INFO - Running setup.py install for psutil 04:26:31 INFO - building 'psutil._psutil_linux' extension 04:26:31 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:26:31 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:26:31 INFO - building 'psutil._psutil_posix' extension 04:26:31 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:26:31 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:26:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:26:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:26:31 INFO - Successfully installed psutil 04:26:31 INFO - Cleaning up... 04:26:31 INFO - Return code: 0 04:26:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:26:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:31 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 0x7fbae9625f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22410b0>, '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 0x2241fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242440>, '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': 'ae8083fbfc14dfa356ee9053000001f7-1449230908.547643-1619566471', '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:26:31 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:26:31 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:26:31 INFO - Using env: {'DISPLAY': ':0', 04:26:31 INFO - 'HOME': '/home/cltbld', 04:26:31 INFO - 'LANG': 'en_US.UTF-8', 04:26:31 INFO - 'LANGUAGE': 'en_US:en', 04:26:31 INFO - 'LOGNAME': 'cltbld', 04:26:31 INFO - 'MAIL': '/var/mail/cltbld', 04:26:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:31 INFO - 'MOZ_NO_REMOTE': '1', 04:26:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:31 INFO - 'NO_EM_RESTART': '1', 04:26:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:31 INFO - 'PWD': '/builds/slave/test', 04:26:31 INFO - 'SHELL': '/bin/bash', 04:26:31 INFO - 'SHLVL': '1', 04:26:31 INFO - 'TERM': 'linux', 04:26:31 INFO - 'TMOUT': '86400', 04:26:31 INFO - 'USER': 'cltbld', 04:26:31 INFO - 'XDG_SESSION_COOKIE': 'ae8083fbfc14dfa356ee9053000001f7-1449230908.547643-1619566471', 04:26:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:31 INFO - '_': '/tools/buildbot/bin/python'} 04:26:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:26:31 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:26:31 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:26:31 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:26:31 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:26:31 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:26:31 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:26:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:26:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:26:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:26:33 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:26:33 INFO - Installing collected packages: mozsystemmonitor 04:26:33 INFO - Running setup.py install for mozsystemmonitor 04:26:33 INFO - Successfully installed mozsystemmonitor 04:26:33 INFO - Cleaning up... 04:26:33 INFO - Return code: 0 04:26:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:26:33 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:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:33 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:26:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:33 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 0x7fbae9625f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22410b0>, '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 0x2241fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242440>, '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': 'ae8083fbfc14dfa356ee9053000001f7-1449230908.547643-1619566471', '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:26:33 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:26:33 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:26:33 INFO - Using env: {'DISPLAY': ':0', 04:26:33 INFO - 'HOME': '/home/cltbld', 04:26:33 INFO - 'LANG': 'en_US.UTF-8', 04:26:33 INFO - 'LANGUAGE': 'en_US:en', 04:26:33 INFO - 'LOGNAME': 'cltbld', 04:26:33 INFO - 'MAIL': '/var/mail/cltbld', 04:26:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:33 INFO - 'MOZ_NO_REMOTE': '1', 04:26:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:33 INFO - 'NO_EM_RESTART': '1', 04:26:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:33 INFO - 'PWD': '/builds/slave/test', 04:26:33 INFO - 'SHELL': '/bin/bash', 04:26:33 INFO - 'SHLVL': '1', 04:26:33 INFO - 'TERM': 'linux', 04:26:33 INFO - 'TMOUT': '86400', 04:26:33 INFO - 'USER': 'cltbld', 04:26:33 INFO - 'XDG_SESSION_COOKIE': 'ae8083fbfc14dfa356ee9053000001f7-1449230908.547643-1619566471', 04:26:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:33 INFO - '_': '/tools/buildbot/bin/python'} 04:26:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:34 INFO - Downloading/unpacking blobuploader==1.2.4 04:26:34 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:26:34 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:26:34 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:26:34 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:26:34 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:26:34 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:26:35 INFO - Downloading blobuploader-1.2.4.tar.gz 04:26:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:26:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:26:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:26:35 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:26:35 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:26:35 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:26:35 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:26:35 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:26:35 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:26:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:26:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:26:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:36 INFO - Downloading docopt-0.6.1.tar.gz 04:26:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:26:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:26:36 INFO - Installing collected packages: blobuploader, requests, docopt 04:26:36 INFO - Running setup.py install for blobuploader 04:26:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:26:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:26:36 INFO - Running setup.py install for requests 04:26:36 INFO - Running setup.py install for docopt 04:26:37 INFO - Successfully installed blobuploader requests docopt 04:26:37 INFO - Cleaning up... 04:26:37 INFO - Return code: 0 04:26:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:37 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 0x7fbae9625f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22410b0>, '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 0x2241fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242440>, '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': 'ae8083fbfc14dfa356ee9053000001f7-1449230908.547643-1619566471', '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:26:37 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:26:37 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:26:37 INFO - Using env: {'DISPLAY': ':0', 04:26:37 INFO - 'HOME': '/home/cltbld', 04:26:37 INFO - 'LANG': 'en_US.UTF-8', 04:26:37 INFO - 'LANGUAGE': 'en_US:en', 04:26:37 INFO - 'LOGNAME': 'cltbld', 04:26:37 INFO - 'MAIL': '/var/mail/cltbld', 04:26:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:37 INFO - 'MOZ_NO_REMOTE': '1', 04:26:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:37 INFO - 'NO_EM_RESTART': '1', 04:26:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:37 INFO - 'PWD': '/builds/slave/test', 04:26:37 INFO - 'SHELL': '/bin/bash', 04:26:37 INFO - 'SHLVL': '1', 04:26:37 INFO - 'TERM': 'linux', 04:26:37 INFO - 'TMOUT': '86400', 04:26:37 INFO - 'USER': 'cltbld', 04:26:37 INFO - 'XDG_SESSION_COOKIE': 'ae8083fbfc14dfa356ee9053000001f7-1449230908.547643-1619566471', 04:26:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:37 INFO - '_': '/tools/buildbot/bin/python'} 04:26:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:26:37 INFO - Running setup.py (path:/tmp/pip-oWytTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:26:37 INFO - Running setup.py (path:/tmp/pip-it0Zjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:26:37 INFO - Running setup.py (path:/tmp/pip-arsyyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:26:37 INFO - Running setup.py (path:/tmp/pip-IBNRQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:26:37 INFO - Running setup.py (path:/tmp/pip-3vsfD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:26:37 INFO - Running setup.py (path:/tmp/pip-GTGaN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:26:37 INFO - Running setup.py (path:/tmp/pip-18MLTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:26:37 INFO - Running setup.py (path:/tmp/pip-fyAjKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:26:37 INFO - Running setup.py (path:/tmp/pip-kerOWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:26:37 INFO - Running setup.py (path:/tmp/pip-RFE_ri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:26:38 INFO - Running setup.py (path:/tmp/pip-zSf0qJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:26:38 INFO - Running setup.py (path:/tmp/pip-P2c6he-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:26:38 INFO - Running setup.py (path:/tmp/pip-ysx9kX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:26:38 INFO - Running setup.py (path:/tmp/pip-2TJC8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:38 INFO - Running setup.py (path:/tmp/pip-ZeM6hx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:26:38 INFO - Running setup.py (path:/tmp/pip-H1tWwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:26:38 INFO - Running setup.py (path:/tmp/pip-Jifung-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:26:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:26:38 INFO - Running setup.py install for manifestparser 04:26:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:26:38 INFO - Running setup.py install for mozcrash 04:26:38 INFO - Running setup.py install for mozdebug 04:26:38 INFO - Running setup.py install for mozdevice 04:26:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:26:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:26:38 INFO - Running setup.py install for mozfile 04:26:39 INFO - Running setup.py install for mozhttpd 04:26:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:26:39 INFO - Running setup.py install for mozinfo 04:26:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:26:39 INFO - Running setup.py install for mozInstall 04:26:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:26:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:26:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:26:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:26:39 INFO - Running setup.py install for mozleak 04:26:39 INFO - Running setup.py install for mozlog 04:26:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:26:39 INFO - Running setup.py install for moznetwork 04:26:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:26:39 INFO - Running setup.py install for mozprocess 04:26:39 INFO - Running setup.py install for mozprofile 04:26:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:26:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:26:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:26:39 INFO - Running setup.py install for mozrunner 04:26:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:26:39 INFO - Running setup.py install for mozscreenshot 04:26:40 INFO - Running setup.py install for moztest 04:26:40 INFO - Running setup.py install for mozversion 04:26:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:26:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:26:40 INFO - Cleaning up... 04:26:40 INFO - Return code: 0 04:26:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:26: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:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26: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:26:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:40 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 0x7fbae9625f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22410b0>, '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 0x2241fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242440>, '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': 'ae8083fbfc14dfa356ee9053000001f7-1449230908.547643-1619566471', '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:26:40 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:26:40 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:26:40 INFO - Using env: {'DISPLAY': ':0', 04:26:40 INFO - 'HOME': '/home/cltbld', 04:26:40 INFO - 'LANG': 'en_US.UTF-8', 04:26:40 INFO - 'LANGUAGE': 'en_US:en', 04:26:40 INFO - 'LOGNAME': 'cltbld', 04:26:40 INFO - 'MAIL': '/var/mail/cltbld', 04:26:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:40 INFO - 'MOZ_NO_REMOTE': '1', 04:26:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:40 INFO - 'NO_EM_RESTART': '1', 04:26:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:40 INFO - 'PWD': '/builds/slave/test', 04:26:40 INFO - 'SHELL': '/bin/bash', 04:26:40 INFO - 'SHLVL': '1', 04:26:40 INFO - 'TERM': 'linux', 04:26:40 INFO - 'TMOUT': '86400', 04:26:40 INFO - 'USER': 'cltbld', 04:26:40 INFO - 'XDG_SESSION_COOKIE': 'ae8083fbfc14dfa356ee9053000001f7-1449230908.547643-1619566471', 04:26:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:40 INFO - '_': '/tools/buildbot/bin/python'} 04:26:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:26:40 INFO - Running setup.py (path:/tmp/pip-aWpG4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:26:40 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:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:26:40 INFO - Running setup.py (path:/tmp/pip-7n701M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:26:40 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:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:26:40 INFO - Running setup.py (path:/tmp/pip-Limk1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:26:40 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:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:26:40 INFO - Running setup.py (path:/tmp/pip-gd1Exf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:26:40 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:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:26:40 INFO - Running setup.py (path:/tmp/pip-Dhicnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:26:40 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:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:26:40 INFO - Running setup.py (path:/tmp/pip-Mdlpat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:26:40 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:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:26:40 INFO - Running setup.py (path:/tmp/pip-Wb6FGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:26:41 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:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:26:41 INFO - Running setup.py (path:/tmp/pip-1Ki2MN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:26:41 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:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:26:41 INFO - Running setup.py (path:/tmp/pip-OWJgfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:26:41 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:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:26:41 INFO - Running setup.py (path:/tmp/pip-vRi2iX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:26:41 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:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:26:41 INFO - Running setup.py (path:/tmp/pip-7R5qGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:26:41 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:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:26:41 INFO - Running setup.py (path:/tmp/pip-QzdolX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:26:41 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:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:26:41 INFO - Running setup.py (path:/tmp/pip-nAiugV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:26:41 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:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:26:41 INFO - Running setup.py (path:/tmp/pip-35xZYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:26:41 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:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:41 INFO - Running setup.py (path:/tmp/pip-cVLbzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:41 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:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:26:41 INFO - Running setup.py (path:/tmp/pip-lk9BAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:26:41 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:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:26:41 INFO - Running setup.py (path:/tmp/pip-ZeVoWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:26:41 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:26:41 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:26:41 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:26:41 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:26:41 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:26:41 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:26:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:26:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:43 INFO - Downloading blessings-1.5.1.tar.gz 04:26:43 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:26:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:26:43 INFO - Installing collected packages: blessings 04:26:43 INFO - Running setup.py install for blessings 04:26:43 INFO - Successfully installed blessings 04:26:43 INFO - Cleaning up... 04:26:43 INFO - Return code: 0 04:26:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:26:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:26:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:26:43 INFO - Reading from file tmpfile_stdout 04:26:43 INFO - Current package versions: 04:26:43 INFO - argparse == 1.2.1 04:26:43 INFO - blessings == 1.5.1 04:26:43 INFO - blobuploader == 1.2.4 04:26:43 INFO - docopt == 0.6.1 04:26:43 INFO - manifestparser == 1.1 04:26:43 INFO - mozInstall == 1.12 04:26:43 INFO - mozcrash == 0.16 04:26:43 INFO - mozdebug == 0.1 04:26:43 INFO - mozdevice == 0.47 04:26:43 INFO - mozfile == 1.2 04:26:43 INFO - mozhttpd == 0.7 04:26:43 INFO - mozinfo == 0.9 04:26:43 INFO - mozleak == 0.1 04:26:43 INFO - mozlog == 3.1 04:26:43 INFO - moznetwork == 0.27 04:26:43 INFO - mozprocess == 0.22 04:26:43 INFO - mozprofile == 0.27 04:26:43 INFO - mozrunner == 6.11 04:26:43 INFO - mozscreenshot == 0.1 04:26:43 INFO - mozsystemmonitor == 0.0 04:26:43 INFO - moztest == 0.7 04:26:43 INFO - mozversion == 1.4 04:26:43 INFO - psutil == 3.1.1 04:26:43 INFO - requests == 1.2.3 04:26:43 INFO - wsgiref == 0.1.2 04:26:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:26:43 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:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:43 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:26:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:43 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 0x7fbae9625f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22410b0>, '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 0x2241fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242440>, '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': 'ae8083fbfc14dfa356ee9053000001f7-1449230908.547643-1619566471', '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:26:43 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:26:43 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:26:43 INFO - Using env: {'DISPLAY': ':0', 04:26:43 INFO - 'HOME': '/home/cltbld', 04:26:43 INFO - 'LANG': 'en_US.UTF-8', 04:26:43 INFO - 'LANGUAGE': 'en_US:en', 04:26:43 INFO - 'LOGNAME': 'cltbld', 04:26:43 INFO - 'MAIL': '/var/mail/cltbld', 04:26:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:43 INFO - 'MOZ_NO_REMOTE': '1', 04:26:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:43 INFO - 'NO_EM_RESTART': '1', 04:26:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:43 INFO - 'PWD': '/builds/slave/test', 04:26:43 INFO - 'SHELL': '/bin/bash', 04:26:43 INFO - 'SHLVL': '1', 04:26:43 INFO - 'TERM': 'linux', 04:26:43 INFO - 'TMOUT': '86400', 04:26:43 INFO - 'USER': 'cltbld', 04:26:43 INFO - 'XDG_SESSION_COOKIE': 'ae8083fbfc14dfa356ee9053000001f7-1449230908.547643-1619566471', 04:26:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:43 INFO - '_': '/tools/buildbot/bin/python'} 04:26:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:44 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:26:44 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:26:44 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:26:44 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:26:44 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:26:44 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:26:44 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:26:44 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:26:44 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:26:44 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:26:44 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:26:44 INFO - Cleaning up... 04:26:44 INFO - Return code: 0 04:26:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:26:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:44 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 0x7fbae9625f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22410b0>, '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 0x2241fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242440>, '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': 'ae8083fbfc14dfa356ee9053000001f7-1449230908.547643-1619566471', '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:26:44 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:26:44 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:26:44 INFO - Using env: {'DISPLAY': ':0', 04:26:44 INFO - 'HOME': '/home/cltbld', 04:26:44 INFO - 'LANG': 'en_US.UTF-8', 04:26:44 INFO - 'LANGUAGE': 'en_US:en', 04:26:44 INFO - 'LOGNAME': 'cltbld', 04:26:44 INFO - 'MAIL': '/var/mail/cltbld', 04:26:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:44 INFO - 'MOZ_NO_REMOTE': '1', 04:26:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:44 INFO - 'NO_EM_RESTART': '1', 04:26:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:44 INFO - 'PWD': '/builds/slave/test', 04:26:44 INFO - 'SHELL': '/bin/bash', 04:26:44 INFO - 'SHLVL': '1', 04:26:44 INFO - 'TERM': 'linux', 04:26:44 INFO - 'TMOUT': '86400', 04:26:44 INFO - 'USER': 'cltbld', 04:26:44 INFO - 'XDG_SESSION_COOKIE': 'ae8083fbfc14dfa356ee9053000001f7-1449230908.547643-1619566471', 04:26:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:44 INFO - '_': '/tools/buildbot/bin/python'} 04:26:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:44 INFO - Downloading/unpacking jsonschema 04:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:26:46 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:26:46 INFO - Downloading/unpacking functools32 (from jsonschema) 04:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:46 INFO - Downloading functools32-3.2.3-2.tar.gz 04:26:46 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:26:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:26:46 INFO - warning: no files found matching '*.txt' 04:26:46 INFO - no previously-included directories found matching 'build' 04:26:46 INFO - no previously-included directories found matching 'dist' 04:26:46 INFO - no previously-included directories found matching '.git*' 04:26:46 INFO - Installing collected packages: jsonschema, functools32 04:26:46 INFO - Running setup.py install for functools32 04:26:46 INFO - warning: no files found matching '*.txt' 04:26:46 INFO - no previously-included directories found matching 'build' 04:26:46 INFO - no previously-included directories found matching 'dist' 04:26:46 INFO - no previously-included directories found matching '.git*' 04:26:46 INFO - Successfully installed jsonschema functools32 04:26:46 INFO - Cleaning up... 04:26:46 INFO - Return code: 0 04:26:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:46 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 0x7fbae9625f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22410b0>, '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 0x2241fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242440>, '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': 'ae8083fbfc14dfa356ee9053000001f7-1449230908.547643-1619566471', '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:26:46 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:26:46 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:26:46 INFO - Using env: {'DISPLAY': ':0', 04:26:46 INFO - 'HOME': '/home/cltbld', 04:26:46 INFO - 'LANG': 'en_US.UTF-8', 04:26:46 INFO - 'LANGUAGE': 'en_US:en', 04:26:46 INFO - 'LOGNAME': 'cltbld', 04:26:46 INFO - 'MAIL': '/var/mail/cltbld', 04:26:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:46 INFO - 'MOZ_NO_REMOTE': '1', 04:26:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:46 INFO - 'NO_EM_RESTART': '1', 04:26:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:46 INFO - 'PWD': '/builds/slave/test', 04:26:46 INFO - 'SHELL': '/bin/bash', 04:26:46 INFO - 'SHLVL': '1', 04:26:46 INFO - 'TERM': 'linux', 04:26:46 INFO - 'TMOUT': '86400', 04:26:46 INFO - 'USER': 'cltbld', 04:26:46 INFO - 'XDG_SESSION_COOKIE': 'ae8083fbfc14dfa356ee9053000001f7-1449230908.547643-1619566471', 04:26:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:46 INFO - '_': '/tools/buildbot/bin/python'} 04:26:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:46 INFO - Downloading/unpacking flake8 04:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:26:48 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:26:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:26:48 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:26:48 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:26:48 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:26:48 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:26:48 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:26:48 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:26:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:26:48 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:26:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:26:48 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:26:48 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:26:48 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:26:48 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:26:48 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:26:48 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:26:48 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:26:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:26:48 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:26:48 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:26:48 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:26:48 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:26:48 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:26:48 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:26:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:26:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:26:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:26:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:26:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:26:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:26:48 INFO - no previously-included directories found matching 'docs/_build' 04:26:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:26:49 INFO - Running setup.py install for pep8 04:26:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:26:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:26:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:26:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:26:49 INFO - no previously-included directories found matching 'docs/_build' 04:26:49 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:26:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:26:49 INFO - Cleaning up... 04:26:49 INFO - Return code: 0 04:26:49 INFO - Running post-action listener: _resource_record_post_action 04:26:49 INFO - Running post-action listener: _start_resource_monitoring 04:26:49 INFO - Starting resource monitoring. 04:26:49 INFO - ##### 04:26:49 INFO - ##### Running install step. 04:26:49 INFO - ##### 04:26:49 INFO - Running pre-action listener: _resource_record_pre_action 04:26:49 INFO - Running main action method: install 04:26:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:26:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:26:49 INFO - Reading from file tmpfile_stdout 04:26:49 INFO - Detecting whether we're running mozinstall >=1.0... 04:26:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:26:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:26:49 INFO - Reading from file tmpfile_stdout 04:26:49 INFO - Output received: 04:26:49 INFO - Usage: mozinstall [options] installer 04:26:49 INFO - Options: 04:26:49 INFO - -h, --help show this help message and exit 04:26:49 INFO - -d DEST, --destination=DEST 04:26:49 INFO - Directory to install application into. [default: 04:26:49 INFO - "/builds/slave/test"] 04:26:49 INFO - --app=APP Application being installed. [default: firefox] 04:26:49 INFO - mkdir: /builds/slave/test/build/application 04:26:49 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:26:49 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:27:04 INFO - Reading from file tmpfile_stdout 04:27:04 INFO - Output received: 04:27:04 INFO - /builds/slave/test/build/application/firefox/firefox 04:27:04 INFO - Running post-action listener: _resource_record_post_action 04:27:04 INFO - ##### 04:27:04 INFO - ##### Running run-tests step. 04:27:04 INFO - ##### 04:27:04 INFO - Running pre-action listener: _resource_record_pre_action 04:27:04 INFO - Running main action method: run_tests 04:27:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:27:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:27:04 INFO - Python 2.7.3 04:27:04 INFO - Return code: 0 04:27:04 INFO - grabbing minidump binary from tooltool 04:27: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:27:04 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 0x22410b0>, '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 0x2241fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:27:04 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:27:04 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:27:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:27:04 INFO - Return code: 0 04:27:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:27:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:27:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:27:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:27:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:27:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:27:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:27:05 INFO - Return code: 0 04:27:05 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/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost'] in /builds/slave/test/build 04:27:05 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/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --webServer localhost 04:27:05 INFO - Using env: {'DISPLAY': ':0', 04:27:05 INFO - 'HOME': '/home/cltbld', 04:27:05 INFO - 'LANG': 'en_US.UTF-8', 04:27:05 INFO - 'LANGUAGE': 'en_US:en', 04:27:05 INFO - 'LOGNAME': 'cltbld', 04:27:05 INFO - 'MAIL': '/var/mail/cltbld', 04:27:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:27:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:27:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:05 INFO - 'MOZ_NO_REMOTE': '1', 04:27:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:27:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:05 INFO - 'NO_EM_RESTART': '1', 04:27:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:05 INFO - 'PWD': '/builds/slave/test', 04:27:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:27:05 INFO - 'SHELL': '/bin/bash', 04:27:05 INFO - 'SHLVL': '1', 04:27:05 INFO - 'TERM': 'linux', 04:27:05 INFO - 'TMOUT': '86400', 04:27:05 INFO - 'USER': 'cltbld', 04:27:05 INFO - 'XDG_SESSION_COOKIE': 'ae8083fbfc14dfa356ee9053000001f7-1449230908.547643-1619566471', 04:27:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:05 INFO - '_': '/tools/buildbot/bin/python'} 04:27:05 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/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost'] with output_timeout 3600 04:27:05 INFO - mozversion INFO | application_buildid: 20151204025717 04:27:05 INFO - mozversion INFO | application_changeset: a36cc9262f70b95c830ce1ff3bd415f346b46415 04:27:05 INFO - mozversion INFO | application_display_name: Nightly 04:27:05 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:27:05 INFO - mozversion INFO | application_name: Firefox 04:27:05 INFO - mozversion INFO | application_remotingname: firefox 04:27:05 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 04:27:05 INFO - mozversion INFO | application_vendor: Mozilla 04:27:05 INFO - mozversion INFO | application_version: 45.0a1 04:27:05 INFO - mozversion INFO | platform_buildid: 20151204025717 04:27:05 INFO - mozversion INFO | platform_changeset: a36cc9262f70b95c830ce1ff3bd415f346b46415 04:27:05 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 04:27:05 INFO - mozversion INFO | platform_version: 45.0a1 04:27:05 INFO - 2015-12-04 04:27:05,298 DEBUG : using testdate: 1449232025 04:27:05 INFO - 2015-12-04 04:27:05,298 DEBUG : actual date: 1449232025 04:27:05 INFO - 2015-12-04 04:27:05,307 INFO : starting webserver on 'localhost:55491' 04:27:05 INFO - 2015-12-04 04:27:05,308 INFO : Starting test suite talos-linux64-ix-043 04:27:05 INFO - 2015-12-04 04:27:05,308 INFO : Starting test dromaeo_css 04:27:05 INFO - 2015-12-04 04:27:05,308 DEBUG : operating with platform_type : linux_ 04:27:05 INFO - 2015-12-04 04:27:05,309 INFO : Initialising browser for dromaeo_css test... 04:27:05 INFO - 2015-12-04 04:27:05,325 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwJzv8C/profile http://localhost:55491/getInfo.html 04:27:09 INFO - 2015-12-04 04:27:09,675 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:27:09 INFO - 2015-12-04 04:27:09,675 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:27:09 INFO - 2015-12-04 04:27:09,675 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:27:09 INFO - 2015-12-04 04:27:09,675 DEBUG : BROWSER_OUTPUT: __metrics 04:27:09 INFO - 2015-12-04 04:27:09,853 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:27:09 INFO - 2015-12-04 04:27:09,909 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:27:11 INFO - 2015-12-04 04:27:11,046 INFO : Browser initialized. 04:27:11 INFO - 2015-12-04 04:27:11,046 INFO : Running cycle 1/1 for dromaeo_css test... 04:27:11 INFO - 2015-12-04 04:27:11,046 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwJzv8C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:27:23 INFO - 2015-12-04 04:27:23,057 DEBUG : BROWSER_OUTPUT: RSS: Main: 142098432 04:27:23 INFO - 2015-12-04 04:27:23,057 DEBUG : BROWSER_OUTPUT: 04:28:14 INFO - 2015-12-04 04:28:14,350 DEBUG : BROWSER_OUTPUT: 1449232094346 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:30:26 INFO - 2015-12-04 04:30:26,207 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55491/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55491/tests/dromaeo/cssquery-ext.html) 04:30:27 INFO - 2015-12-04 04:30:27,360 DEBUG : BROWSER_OUTPUT: RSS: Main: 246837248 04:30:27 INFO - 2015-12-04 04:30:27,360 DEBUG : BROWSER_OUTPUT: 04:33:29 INFO - 2015-12-04 04:33:29,859 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55491/tests/dromaeo/cssquery-ext.html (next: http://localhost:55491/tests/dromaeo/cssquery-jquery.html) 04:33:30 INFO - 2015-12-04 04:33:30,432 DEBUG : BROWSER_OUTPUT: RSS: Main: 217456640 04:33:30 INFO - 2015-12-04 04:33:30,432 DEBUG : BROWSER_OUTPUT: 04:36:32 INFO - 2015-12-04 04:36:32,473 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55491/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55491/tests/dromaeo/cssquery-mootools.html) 04:36:33 INFO - 2015-12-04 04:36:33,059 DEBUG : BROWSER_OUTPUT: RSS: Main: 205959168 04:36:33 INFO - 2015-12-04 04:36:33,059 DEBUG : BROWSER_OUTPUT: 04:39:35 INFO - 2015-12-04 04:39:35,114 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55491/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55491/tests/dromaeo/cssquery-prototype.html) 04:39:35 INFO - 2015-12-04 04:39:35,679 DEBUG : BROWSER_OUTPUT: RSS: Main: 198656000 04:39:35 INFO - 2015-12-04 04:39:35,679 DEBUG : BROWSER_OUTPUT: 04:42:38 INFO - 2015-12-04 04:42:38,518 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55491/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55491/tests/dromaeo/cssquery-yui.html) 04:42:39 INFO - 2015-12-04 04:42:39,119 DEBUG : BROWSER_OUTPUT: RSS: Main: 205279232 04:42:39 INFO - 2015-12-04 04:42:39,119 DEBUG : BROWSER_OUTPUT: 04:45:41 INFO - 2015-12-04 04:45:41,543 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55491/tests/dromaeo/cssquery-yui.html (next: http://localhost:55491/tests/dromaeo/cssquery-dojo.html) 04:45:41 INFO - 2015-12-04 04:45:41,794 DEBUG : BROWSER_OUTPUT: RSS: Main: 247992320 04:45:41 INFO - 2015-12-04 04:45:41,794 DEBUG : BROWSER_OUTPUT: 04:45:41 INFO - 2015-12-04 04:45:41,795 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:45:41 INFO - 2015-12-04 04:45:41,795 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:45:41 INFO - 2015-12-04 04:45:41,795 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:45:41 INFO - 2015-12-04 04:45:41,795 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:45:41 INFO - 2015-12-04 04:45:41,797 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2611.947761044779;2714.8506832124226;2718.8096833221684;2722.4963381774373;2745.1490038088186;4480;4613.100445413137;4661.324108004337;4686.6953648012895;4695.107929493398;4525.660575456837;4546.886012926838;4616.67683262171;4622.473172259197;4622.491525932153;4239.025024244425;4248.511421186572;4267.914641707164;4425.203463376591;4430.556944305576;4117.485314335708;4369.016971181474;4379.146066517031;4431.313146462304;4441.5336389679105;4193.559676233982;4193.895152621194;4220.53574106848;4330.891727706801;4341.761203133827;4328.588784065509;4342.869713908556;4345.435093437833;4345.73925564464;4402.581754733327;4322.135572885404;4330.025744207528;4336.262835318003;4356.041670832412;4356.629686476654;4351.412559304516;4456.384954956746;4459.175052615276;4475.753833539154;4597.816087356502;5005.624578156617;5009.248612708123;5011.373578302712;5013.0725815723845;5064.113780088506;5038.294638750578;5038.899222015576;5038.924416133761;5043.596512279046;5081.517255860687;4362.607365337135;4475.261581838992;4476.932846007313;4531.932021019687;4650.906981860411;5098.5411312982005;5152.871178220575;5156.9742151289;5161.122609156452;5164.715940623302;4939.950600493949;4963.875903102379;4966.304717339575;4966.577840883565;5000.799968001312;4699.95300047002;4800.3759511263315;4803.375561177025;4809.278608208797;4919.655624106278;4917;4967.4784147664695;4977.726225057657;4991.650584459053;4996.175631020914;4952.331435256195;4972.179590367549;4975.054739599537;4979.3277907482025;5015.774290156952;3914.8042597869994;3995.5005624296964;4032.858849940238;4166.479190101238;4191.7694526801315;3584.444411116281;3635;3653.050206946213;3676.0809797550614;3693.7045036397026;4247.936280955726;4277.957220427818;4280.89297767552;4316.611504964569;4322.135572885372;4689.648276379286;4805.927911081267;4807.990322032342;5000.349954505891;5002.299678045077;4181.749095054306;4247.787610619456;4254.553271906467;4290.89272768177;4291.377750226262;4388.692791504628;4432.534583868647;4435.423394958635;4441.978344980673;4482.618977386958;4516.751578663205;4637.76811159434;4644.651651126247;4742.19382704941;4798.7840547174765;4864.92702609454;4939.135651261086;4957.876053098701;4962.727050012139;4999.275105109811;4735.502772208868;4748.667593268438;4752.073345697556;4754.096721622881;4789.712617242837;4599;4710.552497512731;4723.197056500472;4932.4327702314695;4966.553010229097;4921.876953076202;5009.77456014473;5029.170186919264;5031.144705400164;5071.670341427795;4825.203841366135;4829;4839.9836034431755;4846.830360937351;4882.438519570295;4589.885252868571;4709.740964246999;4711.387519622427;4848.903021939612;4891.951080489292;4601.815927362868;4699.2481203007355;4742.5731684148595;4764.809407623657;4773.64197685182;4800.35195248637;4827.348307978518;4831.371921650163;4835.927461088017;4881.731504767272;4546.681732278708;4672.5327467253;4732.313814496947;4733.053389322081;4783.832565860178 04:45:41 INFO - 2015-12-04 04:45:41,798 DEBUG : BROWSER_OUTPUT: |1;ext.html;573.4867293772074;576.7375843990984;587.6562211106501;588.2470437839567;597.980443344098;26191.73808261917;37329.81335093328;37688.24623507528;37771.43342849852;37794.8110259449;39394.21211575767;39967;40046.39930401046;40079;40146.59853401472;7022.227554968975;7131.108611423572;7887.723929662448;8049.396295277848;8058.073321568007;10086.142677872389;10360.067593916547;10365.067143957041;10365.326253793517;10366.326188797742;9999.900000999969;10024.699259022242;10094.394336339807;10128.645497407591;10139;7194.892076618855;7354.852902941965;7356.411487081021;9938.9503052485;10129.594816207344;9788.461634610094;9917.801643967081;9919.867228545825;9921.404715717008;9925.057119573628;36376.81811590952;36533.817330913174;36576.268474630626;36773;36795.448068278994;2843.076000299911;2887.581300711385;2938.030449951511;3463.8268086595567;3663.761855479412;27993.30016749577;27997.720022799716;28161.85919070412;28598;28615.57076643852;3433.570803649544;3455.740819438527;3462.722982161421;3516.507688923553;3552.946705799415;223633;224919;225663;225711.8714406434;226348;50592.74703626458;51647.48352516502;53951.730241348545;54455.18317225245;55423.722881386144;56841;57205.713971429876;57235;57486;57492;13332.200067995756;13524.256165910772;13526.661833454242;13540.796888046687;13603.115797473132;9919.65281215154;9950.35322704022;9967.651132210483;9970.302078854556;9981.900180998242;18900.05499725008;19028.66799324062;19065.42803715891;19132.808671913102;19185.52036199106;7211.783646490614;7437.51656142349;7476.514026588255;7497.700091996259;7511.248875112445;831.7005877883956;868.8957325121025;905.0270958719403;908.2597682888425;977.7066879935991;25847.224583262534;26979.32551686184;27181.45637087247;27262.5910611341;27883.442331153263;926.6525053105086;979.8530220466845;996.2179688944144;1010.838265877456;1059.3537941855461;12233.755324893453;12288.692782680326;12396.876031239752;12477.438515266835;12547;266249;270986;271119;272490;272516;44684.19105516327;44815.55184448179;44890;44905.10189796186;45050;1220.9633710988685;1242.099477878531;1250.9687257818446;1254.0719867298133;1255.0712472770085;20715;27127.457450851267;28095;28149.71850281471;28321.15036548907;40490.79754601208;40977;41023.58976410198;41035.38446923239;41083;216698;218071;218449;219064;219105;24093.277201683977;28152.155435336972;28910.566341504473;30088.247793804454;30954.380912382076;36742.8162859184;37136.62863371332;37266.441003384425;37607;38968.6103138965;29535.55696664595;30455.390892182477;31602;32798.18004549905;33023.66976330302;29865.55201671933;30479.390412192075;30570;30600.693993059784;30657.693423065484;30343.696563034086;32827.34345313128;33073.669263307056;33301;33316.00155985973;26340.736592633828;29361.70638293675;29507.409851803273;29790.255243618216;29971.250718732204;22098.779012210314;22887.198948037403;23361;23401;25555.36111597225 04:45:41 INFO - 2015-12-04 04:45:41,799 DEBUG : BROWSER_OUTPUT: |2;jquery.html;323.2129764024599;329.9620543637482;330.7205411427343;334.0396360463667;334.19959197721465;12461.563845265395;12725.809112863291;14572.56282311531;15296;15298.923505382458;12104.455299511521;13754;13903.721925561482;13907.374168162432;14206.218657973808;3972.781497017663;4782.7608619569055;4888.144574699431;4916.729579873106;4940.382452193476;4836.637252206098;4868.245421959602;4869.415670119591;4874.707517548941;4885.364902562662;4837.709737415748;4849.660523763338;4934.481879402665;4939.703617782927;4954.30639710439;4857.854264372075;4873.195922672755;4884;4891.559759621633;4892.926606100911;4342.34864770287;4377.102693947765;4381.978090109561;4383.035732138925;4384.298512238059;18750.0624968751;18839;19122.139503722366;19940.800591994186;19966;1731.6017316017387;1901.3630433804692;1914.15777058094;1918.6258679557493;1935.2162374238455;8568.528730919797;8735.519546424945;8740.781480462976;10450.68647940563;12072.09459290548;1759.0764848454535;1775.6803775320566;1790.4539115569746;1817.8000419953794;1818.6271814278173;47323.76338118322;48569.51430485685;49208;53656;56686.43313566853;8916.331275154389;9074.500902450296;9124.361294709439;9125.36122471434;9154.450732956044;11135.888641113646;11138.665840024812;11350.09199264057;11440.313581185155;11471.541138354372;6283.560150789401;6392;6421.3578642136345;6431.614103153825;6535.44448721864;5915.704214789243;6096.847578810565;6144.8771024579255;6182.876342473125;6199.070139479114;3868.323043467382;3888.6889048876023;3912.5891781362548;3913.8434462621176;3950.8617198398492;1604.630934884983;1687.7130887749113;1694.737315716066;1712.6917154911987;1728.809830918598;806.1535387842741;812.6627449608346;874.9762777550281;892.3262936483044;990.346371394876;16014.359425622844;16030;16049.67900642004;16237.756433653505;16319.67360652804;786.1980779604771;824.0646865807232;841.2176675691666;854.7178043072984;919.3748251189122;8726.912730872737;9044;9099.181073703267;9123.087691230823;9161.77095572616;471448;478269;480382;480959;501089;69516;69965.30034699588;70796.64601676959;70868;71485.64257178681;1060.4326685223368;1068.385678235018;1073.3184427888348;1073.7476692977143;1077.0145317034826;13537.796933045815;13918.164910105426;14948.028378155384;14980;15089.396424142911;23740.694261815766;25505.234842954742;26751.598726018736;31542;32202.38988050635;33826.49260261049;34575.82712086423;35518.822405887804;37645.62354376421;41703.79148104361;8647.654093836427;8656.567171641518;8683.348748843735;8706.216440520384;8716.128387161232;11546.884531154918;13288.335583220995;15555.988860724017;16111.838881611035;16853.073080980663;13016.414261358072;13234.073614847253;13492.460301587827;13616.18302901829;13661.38523766413;12282.570110046105;12425.31660758667;12532.686682833002;13031.283279419344;13126.14680045794;13583.660408489866;13847.86152138506;13993.720125597634;14098.647533811327;14232.644183895485;8356.707515236938;8424.157584241771;8580.570971451278;8759.956200218958;8766.254868336007;13096.607101786962;13303.135296205715;13529.526466573623;13624.65938351549;13839.930800346337 04:45:41 INFO - 2015-12-04 04:45:41,803 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1247.9188852724578;1659.941902033429;1706.5733566608349;1731.8527925126364;1742.3030787684925;5983.3717459666705;7035.2612975637585;7250.601216933067;7252.129744430676;7252.311030452099;6645.867082658344;6788.592684438925;6791.864162716743;6792.286809884965;6799.150106236721;1757.6660434517464;1792.06812457522;1792.5429015601069;2034.2574960139555;2053.8664986775884;2072.3990042887544;2129.37183530858;2130.9786902131013;2133.7332833395826;2134.061013154215;2060.7424071991;2072.5958438104576;2119.629064913634;2136.711543941571;2139.529303553216;1744.7819022622173;1781.6703909776604;2043.6627956387326;2081.864678795881;2097.643400621898;2046.8464865135024;2051.0155125539677;2054.8356131509445;2057.7942205779304;2057.855950083495;7024.262452442522;7139.571625702474;7154.1415030196185;7156.92843071573;7158.105236845395;4230.915381692349;4246.2356775780345;4247.108107297471;4292.570742925714;4316.050468896838;2776.5557510798176;2810.2271875234474;2839.162447078096;2839.5882597023315;2847.572864070385;924.2328867040341;931.222429271559;945.6028468043438;950.8288508068545;955.1212884146602;9636.566354514063;9654.420734755937;9665.081817227352;9665.565049572786;9668.564914578861;3994.500687414073;4057.6145266199665;4092.631663150331;4096.610821971908;4117.670586353084;8279.296259817862;8295.8340833183;8299.502029878106;8303.418760686814;8305;4224.070704445017;4231.576842315744;4244.10873716523;4253.659707223414;4257.318828987347;3860.6332398422105;3861;3864.594217607167;3866.1881004988704;3871.96128038716;3438.7420943429343;3448.327576122632;3481.4255647817827;3486.8082255476193;3500.4224302989724;1105.3588918427292;1120.4509790202742;1127.177160672697;1134.0643968725835;1138.8348689439986;1104.4808939798281;1119.5465836336298;1133.6315697398213;1134.4384529657707;1135.460656188304;6437.678116094176;6493.577917435352;6494.220693516808;6523.934760652428;6546.312637173123;391.93141200289836;447.88355027693035;450.6259804362371;453.0485979443209;455.5262526971912;4412.691111622155;5388.676679399248;5473.835784926379;5481.314835645544;5484.067708489566;8118.066422361386;8120.187981201832;8227.876581851277;8264.173582641688;8294.004719433706;8088.676452941934;8103.946486956658;8112.959435202786;8122;8207.917920820715;6117.418845209698;6117.694115294217;6156.07658851167;6200.3799620037635;6227.782027629011;6643;6706.463482921452;6710.698018589273;6711.127553418024;6713.462922966249;7436.516626419266;7476.710167647001;7531.623418829146;7588.127365353055;7599.240075992578;7658.387329013777;7695.076590809139;7784.610769461618;7817.101033381234;7908.485948413335;6057.57596968208;6103.328633850184;6111.663858487826;6117.541184411098;6117.908231376444;6780.355866192704;6825.146856642919;6864.862702746017;6868.690908909011;6870.519063665695;6225.097360882737;6283.403076707706;6316.715747791269;6373.968130159319;6384.808455746335;6218.347073557392;6267.96866015667;6355.3326900674765;6395.136656551306;6424.196975378078;6259.123722678738;6269.247690277196;6372.968135159294;6434.8391290218115;6438.935610643834;5964.194833697396;5971.970140149271;5991.820245392645;5998.070299103646;6001.639901605918;5326.147816349366;5435.483629055233;5865.208196893364;5912.438318359749;5919.970400147971 04:45:41 INFO - 2015-12-04 04:45:41,803 DEBUG : BROWSER_OUTPUT: |4;prototype.html;287.6936063092806;297.3339719029374;299.0251779199808;300.1386022116526;301.77065430272984;5290.603204759639;5312;5341.359036915571;5362.678239305645;5380.031594313022;5245.10833158363;5252.474752524755;5256.579473642109;5261.947380526203;5270.314859068316;4113.794310284488;4122.50529936408;4127.4427952226515;4135.359019351998;4139.6895232857505;3901.453796468497;4038.1116154445976;4101.220768054075;4130.752154870717;4132.2768515509815;3881.7282790204695;3994.4807175067344;4004.3392840181336;4006.1386801837743;4006.8597599084037;3820.5033345665024;3861.092643228839;3918.608139186087;3942.093318536724;3969.0672691917375;3432.0733401981324;3434.553508043963;3509.3332266869215;3577.6780089791782;3599.3521166190076;4935.087008903364;5036.395632524084;5116.923246151311;5123.359580052494;5140;4680.017196388729;4693.084848454553;4696.647751418657;4696.81212751493;4703.6942598730975;5307.52232299095;5379.542738867201;5418.512333889968;5567.777288908439;5575.996320662279;3881.0879443331078;3894.279558281727;3898.376259798447;3900.9219815603815;3915.686745060388;5801.332846722638;5812.912806307909;5816.243888294537;5819.156222347779;5825.300963884319;4007.158496715664;4007.6593489553134;4009.8997525062105;4011.0373510357304;4017.1764788218347;3966.4050392441363;4079.082206503513;4079.898427424638;4082.9795851020554;4093.201825643971;4651.906961860744;4653.232216684277;4656.185167595725;4657.115148121846;4657.278121891112;5528.474794894559;5539.529140023063;5540.833774986757;5545.251391062155;5547.694876781735;1408.6548795544952;1421.459845258795;1421.4882642248783;1421.7583010888175;1421.8364888038009;969.544314172352;987.5852142100335;988.3328753091778;1001.244060734141;1003.172382784206;4845.466998630148;4846.345743324606;4851.660383773102;4854.708717476963;4859.343988561499;5761.251037365116;5768.2501274834;5770.047942089592;5770.336411312753;5770.971145144247;4846.07924494352;4851.56335929768;4854.247591623304;4854.490278520704;4855.465898751135;3006.113196607006;3065.7700672449655;3098.9225269368444;3101.17818778024;3118.9844050780057;5504.0643090674685;5510.6969116698165;5513.42109078549;5519.806806761744;5526.198701188305;5945.197398351167;5976.402359763989;5985.396352586638;5987.760489580368;5994.850128746729;5509.520715677961;5510.862228444321;5513.283273174622;5514.6691198528215;5518.558515318765;5536.0865457200725;5677.971610141923;5715.914261286167;5813.738381772746;5821.76712931478;5518.2826232589505;5615.073512870494;5633.126865335879;5656.915146272727;5672.064109421899;5497.862553436036;5500;5500.4224556420995;5500.477454641803;5501.394846566955;3891.8443262269193;3930.744501607386;3932.2528719543197;3932.9606703932595;3933.645971862546;5671.574631902541;5815.5929084963645;5825.825225243249;5834.883302334015;5837.182794408701;5606.6636001840025;5609.943900560942;5611.270534830446;5611.298587676541;5611.438856114356;5542.944570554404;5556.305461817273;5578.525825304732;5593.412691667317;5596.244506991504;5366.490183432567;5465.508104270635;5486.423925487767;5487.75305111279;5494.670319780826;5592.133219351007;5599.664020158803;5627.43725627434;5632.5212356950115;5642.689652069175;5432.9185062223305;5452.972735136299;5458.4541545845095;5519.475649813261;5520.475554822286 04:45:41 INFO - 2015-12-04 04:45:41,803 DEBUG : BROWSER_OUTPUT: |5;yui.html;752.4920678541982;793.6745934166993;797.7726347990822;800.9159038300982;819.8114433680249;14394;14728.116313021214;14736.557903262892;14748.926255368708;14774.926125369358;14039.157650540974;14042.508512202076;14100.083494572846;14161.645958851008;14190.503332383369;631.1132858334048;646.1341801985338;805.3074356053804;821.1172989036779;821.6549049399237;636.1666217255387;778.2256654628652;801.0067516279801;804.0512195609178;804.5775967616989;845.7716416567523;858.3390789092396;858.4505916213628;859.2867919626694;860.5396113079504;652.9706163222619;667.956582822115;817.284875733733;849.2314455417857;855.3841234311286;620.88203241384;621.6829416997318;622.4304761143549;623.0094150300998;623.7910300049489;12832.973362131008;12961.675958101028;12978.415971281314;12982.675433114153;13005.414756335987;10891.455427228608;11163.218574699775;11303.660890173307;11399.202055856093;11782.823257651142;9439.292053096045;9648;9649.90350096497;9748.95125524375;9791.167750741124;3234.530993006001;3253.2842774589553;3272.067460773692;3276.6887145721357;3316.1046517440154;42157.57842421567;42262;42635.786821065696;42679.57320426818;42689.786551067045;9372.718818435458;9437.622495100257;9460.195883349854;9465.479398633004;9530.332876698703;16469.752953705465;16490.17549122539;16494.092824894746;16495.91752041256;16528.83471165273;6158.445739883432;6193.38066193377;6275.3724627537795;6312.179416675803;6452.483801295885;3484.0767196692896;3554.91112722184;3598.838052287653;3618.7105031597407;3625.3293140768515;2697.8516181609807;2701.8378897266225;2706.2422521693957;2724.209979106037;2733.945321093567;501.30819469132365;508.9440161582223;509.40654137928897;510.8544064941474;513.1148768374524;514.7014731455821;553.1122548309985;600.8557946092906;603.499095750526;615.6213928434071;7396.667149978264;7426.480146389809;7439.330460258495;7620.314171724572;7683.692652293846;468.8687167593079;492.9975350123298;519.7655568025939;581.5318668471837;605.1376788076973;3707.6663100321102;3783.138666813187;3886.3004659161056;3952.545457272393;3962;46640.300395494094;46945.765271173426;47131.29303060388;47480;47677;42313.57686423158;42683;42740.57259427428;42760.3585946211;43080.78459607682;40446.79776601157;40512.79743601263;40921.79539102285;40929;41222;7655.272749088827;7690.307872291521;7728;7739.845203095794;7827.686892524235;30454;30526;30974.38051239008;31181.53227701541;31193.68806311908;36158.276834463686;36441.453378199876;36858;39709.60290397175;39746.2050758989;8508.149185081442;8983.955080224558;9086.091390860862;9588.808223835345;9602.519084348354;10158.89841101609;10163.771218079723;10243.641472548425;10368.326058806153;10700.625478108228;9545.809083818145;9568.952155239458;9690.75773105678;9866.605335786488;10133.08802207805;9522.619095236112;9528.52357382142;9612.086851749073;9779.755506112404;9909.702708918743;9830.623712680374;9917.206623469961;9941.502924853872;9996.750081248027;10028.448435336126;8527.53098579584;8570.271526920033;8594.65621375163;8727.476351418934;8901.465912045298;8166.754997350089;8215.917840821516;8438.367122465963;8822.86765698528;9302.395344302598 04:45:41 INFO - 2015-12-04 04:45:41,803 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:45:41 INFO - 2015-12-04 04:45:41,803 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:45:41 INFO - 2015-12-04 04:45:41,803 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,972 04:45:41 INFO - 2015-12-04 04:45:41,804 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:45:41 INFO - 2015-12-04 04:45:41,804 DEBUG : BROWSER_OUTPUT: __startTimestamp1449233141794__endTimestamp 04:45:41 INFO - 2015-12-04 04:45:41,804 DEBUG : BROWSER_OUTPUT: 04:45:41 INFO - 2015-12-04 04:45:41,804 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:45:41 INFO - 2015-12-04 04:45:41,804 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:45:41 INFO - 2015-12-04 04:45:41,804 DEBUG : BROWSER_OUTPUT: 04:45:41 INFO - 2015-12-04 04:45:41,804 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4575.74 Median:4689.65 stddev:471.79 (10.1%) stddev-sans-first:447.38 04:45:41 INFO - 2015-12-04 04:45:41,806 DEBUG : BROWSER_OUTPUT: Values: 2611.9 2714.9 2718.8 2722.5 2745.1 4480.0 4613.1 4661.3 4686.7 4695.1 4525.7 4546.9 4616.7 4622.5 4622.5 4239.0 4248.5 4267.9 4425.2 4430.6 4117.5 4369.0 4379.1 4431.3 4441.5 4193.6 4193.9 4220.5 4330.9 4341.8 4328.6 4342.9 4345.4 4345.7 4402.6 4322.1 4330.0 4336.3 4356.0 4356.6 4351.4 4456.4 4459.2 4475.8 4597.8 5005.6 5009.2 5011.4 5013.1 5064.1 5038.3 5038.9 5038.9 5043.6 5081.5 4362.6 4475.3 4476.9 4531.9 4650.9 5098.5 5152.9 5157.0 5161.1 5164.7 4940.0 4963.9 4966.3 4966.6 5000.8 4700.0 4800.4 4803.4 4809.3 4919.7 4917.0 4967.5 4977.7 4991.7 4996.2 4952.3 4972.2 4975.1 4979.3 5015.8 3914.8 3995.5 4032.9 4166.5 4191.8 3584.4 3635.0 3653.1 3676.1 3693.7 4247.9 4278.0 4280.9 4316.6 4322.1 4689.6 4805.9 4808.0 5000.3 5002.3 4181.7 4247.8 4254.6 4290.9 4291.4 4388.7 4432.5 4435.4 4442.0 4482.6 4516.8 4637.8 4644.7 4742.2 4798.8 4864.9 4939.1 4957.9 4962.7 4999.3 4735.5 4748.7 4752.1 4754.1 4789.7 4599.0 4710.6 4723.2 4932.4 4966.6 4921.9 5009.8 5029.2 5031.1 5071.7 4825.2 4829.0 4840.0 4846.8 4882.4 4589.9 4709.7 4711.4 4848.9 4892.0 4601.8 4699.2 4742.6 4764.8 4773.6 4800.4 4827.3 4831.4 4835.9 4881.7 4546.7 4672.5 4732.3 4733.1 4783.8 04:45:41 INFO - 2015-12-04 04:45:41,806 DEBUG : BROWSER_OUTPUT: 04:45:41 INFO - 2015-12-04 04:45:41,806 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39891.16 Median:32812.76 stddev:62206.00 (189.6%) stddev-sans-first:62310.45 04:45:41 INFO - 2015-12-04 04:45:41,806 DEBUG : BROWSER_OUTPUT: Values: 573.5 576.7 587.7 588.2 598.0 26191.7 37329.8 37688.2 37771.4 37794.8 39394.2 39967.0 40046.4 40079.0 40146.6 7022.2 7131.1 7887.7 8049.4 8058.1 10086.1 10360.1 10365.1 10365.3 10366.3 9999.9 10024.7 10094.4 10128.6 10139.0 7194.9 7354.9 7356.4 9939.0 10129.6 9788.5 9917.8 9919.9 9921.4 9925.1 36376.8 36533.8 36576.3 36773.0 36795.4 2843.1 2887.6 2938.0 3463.8 3663.8 27993.3 27997.7 28161.9 28598.0 28615.6 3433.6 3455.7 3462.7 3516.5 3552.9 223633.0 224919.0 225663.0 225711.9 226348.0 50592.7 51647.5 53951.7 54455.2 55423.7 56841.0 57205.7 57235.0 57486.0 57492.0 13332.2 13524.3 13526.7 13540.8 13603.1 9919.7 9950.4 9967.7 9970.3 9981.9 18900.1 19028.7 19065.4 19132.8 19185.5 7211.8 7437.5 7476.5 7497.7 7511.2 831.7 868.9 905.0 908.3 977.7 25847.2 26979.3 27181.5 27262.6 27883.4 926.7 979.9 996.2 1010.8 1059.4 12233.8 12288.7 12396.9 12477.4 12547.0 266249.0 270986.0 271119.0 272490.0 272516.0 44684.2 44815.6 44890.0 44905.1 45050.0 1221.0 1242.1 1251.0 1254.1 1255.1 20715.0 27127.5 28095.0 28149.7 28321.2 40490.8 40977.0 41023.6 41035.4 41083.0 216698.0 218071.0 218449.0 219064.0 219105.0 24093.3 28152.2 28910.6 30088.2 30954.4 36742.8 37136.6 37266.4 37607.0 38968.6 29535.6 30455.4 31602.0 32798.2 33023.7 29865.6 30479.4 30570.0 30600.7 30657.7 30343.7 32827.3 33073.7 33301.0 33316.0 26340.7 29361.7 29507.4 29790.3 29971.3 22098.8 22887.2 23361.0 23401.0 25555.4 04:45:41 INFO - 2015-12-04 04:45:41,806 DEBUG : BROWSER_OUTPUT: 04:45:41 INFO - 2015-12-04 04:45:41,806 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25540.22 Median:20756.97 stddev:78749.91 (379.4%) stddev-sans-first:78948.06 04:45:41 INFO - 2015-12-04 04:45:41,806 DEBUG : BROWSER_OUTPUT: Values: 323.2 330.0 330.7 334.0 334.2 12461.6 12725.8 14572.6 15296.0 15298.9 12104.5 13754.0 13903.7 13907.4 14206.2 3972.8 4782.8 4888.1 4916.7 4940.4 4836.6 4868.2 4869.4 4874.7 4885.4 4837.7 4849.7 4934.5 4939.7 4954.3 4857.9 4873.2 4884.0 4891.6 4892.9 4342.3 4377.1 4382.0 4383.0 4384.3 18750.1 18839.0 19122.1 19940.8 19966.0 1731.6 1901.4 1914.2 1918.6 1935.2 8568.5 8735.5 8740.8 10450.7 12072.1 1759.1 1775.7 1790.5 1817.8 1818.6 47323.8 48569.5 49208.0 53656.0 56686.4 8916.3 9074.5 9124.4 9125.4 9154.5 11135.9 11138.7 11350.1 11440.3 11471.5 6283.6 6392.0 6421.4 6431.6 6535.4 5915.7 6096.8 6144.9 6182.9 6199.1 3868.3 3888.7 3912.6 3913.8 3950.9 1604.6 1687.7 1694.7 1712.7 1728.8 806.2 812.7 875.0 892.3 990.3 16014.4 16030.0 16049.7 16237.8 16319.7 786.2 824.1 841.2 854.7 919.4 8726.9 9044.0 9099.2 9123.1 9161.8 471448.0 478269.0 480382.0 480959.0 501089.0 69516.0 69965.3 70796.6 70868.0 71485.6 1060.4 1068.4 1073.3 1073.7 1077.0 13537.8 13918.2 14948.0 14980.0 15089.4 23740.7 25505.2 26751.6 31542.0 32202.4 33826.5 34575.8 35518.8 37645.6 41703.8 8647.7 8656.6 8683.3 8706.2 8716.1 11546.9 13288.3 15556.0 16111.8 16853.1 13016.4 13234.1 13492.5 13616.2 13661.4 12282.6 12425.3 12532.7 13031.3 13126.1 13583.7 13847.9 13993.7 14098.6 14232.6 8356.7 8424.2 8580.6 8760.0 8766.3 13096.6 13303.1 13529.5 13624.7 13839.9 04:45:41 INFO - 2015-12-04 04:45:41,807 DEBUG : BROWSER_OUTPUT: 04:45:41 INFO - 2015-12-04 04:45:41,807 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4910.22 Median:6029.61 stddev:2533.75 (42.0%) stddev-sans-first:2525.90 04:45:41 INFO - 2015-12-04 04:45:41,808 DEBUG : BROWSER_OUTPUT: Values: 1247.9 1659.9 1706.6 1731.9 1742.3 5983.4 7035.3 7250.6 7252.1 7252.3 6645.9 6788.6 6791.9 6792.3 6799.2 1757.7 1792.1 1792.5 2034.3 2053.9 2072.4 2129.4 2131.0 2133.7 2134.1 2060.7 2072.6 2119.6 2136.7 2139.5 1744.8 1781.7 2043.7 2081.9 2097.6 2046.8 2051.0 2054.8 2057.8 2057.9 7024.3 7139.6 7154.1 7156.9 7158.1 4230.9 4246.2 4247.1 4292.6 4316.1 2776.6 2810.2 2839.2 2839.6 2847.6 924.2 931.2 945.6 950.8 955.1 9636.6 9654.4 9665.1 9665.6 9668.6 3994.5 4057.6 4092.6 4096.6 4117.7 8279.3 8295.8 8299.5 8303.4 8305.0 4224.1 4231.6 4244.1 4253.7 4257.3 3860.6 3861.0 3864.6 3866.2 3872.0 3438.7 3448.3 3481.4 3486.8 3500.4 1105.4 1120.5 1127.2 1134.1 1138.8 1104.5 1119.5 1133.6 1134.4 1135.5 6437.7 6493.6 6494.2 6523.9 6546.3 391.9 447.9 450.6 453.0 455.5 4412.7 5388.7 5473.8 5481.3 5484.1 8118.1 8120.2 8227.9 8264.2 8294.0 8088.7 8103.9 8113.0 8122.0 8207.9 6117.4 6117.7 6156.1 6200.4 6227.8 6643.0 6706.5 6710.7 6711.1 6713.5 7436.5 7476.7 7531.6 7588.1 7599.2 7658.4 7695.1 7784.6 7817.1 7908.5 6057.6 6103.3 6111.7 6117.5 6117.9 6780.4 6825.1 6864.9 6868.7 6870.5 6225.1 6283.4 6316.7 6374.0 6384.8 6218.3 6268.0 6355.3 6395.1 6424.2 6259.1 6269.2 6373.0 6434.8 6438.9 5964.2 5972.0 5991.8 5998.1 6001.6 5326.1 5435.5 5865.2 5912.4 5920.0 04:45:41 INFO - 2015-12-04 04:45:41,808 DEBUG : BROWSER_OUTPUT: 04:45:41 INFO - 2015-12-04 04:45:41,808 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4609.00 Median:5266.13 stddev:1363.85 (25.9%) stddev-sans-first:1328.55 04:45:41 INFO - 2015-12-04 04:45:41,809 DEBUG : BROWSER_OUTPUT: Values: 287.7 297.3 299.0 300.1 301.8 5290.6 5312.0 5341.4 5362.7 5380.0 5245.1 5252.5 5256.6 5261.9 5270.3 4113.8 4122.5 4127.4 4135.4 4139.7 3901.5 4038.1 4101.2 4130.8 4132.3 3881.7 3994.5 4004.3 4006.1 4006.9 3820.5 3861.1 3918.6 3942.1 3969.1 3432.1 3434.6 3509.3 3577.7 3599.4 4935.1 5036.4 5116.9 5123.4 5140.0 4680.0 4693.1 4696.6 4696.8 4703.7 5307.5 5379.5 5418.5 5567.8 5576.0 3881.1 3894.3 3898.4 3900.9 3915.7 5801.3 5812.9 5816.2 5819.2 5825.3 4007.2 4007.7 4009.9 4011.0 4017.2 3966.4 4079.1 4079.9 4083.0 4093.2 4651.9 4653.2 4656.2 4657.1 4657.3 5528.5 5539.5 5540.8 5545.3 5547.7 1408.7 1421.5 1421.5 1421.8 1421.8 969.5 987.6 988.3 1001.2 1003.2 4845.5 4846.3 4851.7 4854.7 4859.3 5761.3 5768.3 5770.0 5770.3 5771.0 4846.1 4851.6 4854.2 4854.5 4855.5 3006.1 3065.8 3098.9 3101.2 3119.0 5504.1 5510.7 5513.4 5519.8 5526.2 5945.2 5976.4 5985.4 5987.8 5994.9 5509.5 5510.9 5513.3 5514.7 5518.6 5536.1 5678.0 5715.9 5813.7 5821.8 5518.3 5615.1 5633.1 5656.9 5672.1 5497.9 5500.0 5500.4 5500.5 5501.4 3891.8 3930.7 3932.3 3933.0 3933.6 5671.6 5815.6 5825.8 5834.9 5837.2 5606.7 5609.9 5611.3 5611.3 5611.4 5542.9 5556.3 5578.5 5593.4 5596.2 5366.5 5465.5 5486.4 5487.8 5494.7 5592.1 5599.7 5627.4 5632.5 5642.7 5432.9 5453.0 5458.5 5519.5 5520.5 04:45:41 INFO - 2015-12-04 04:45:41,809 DEBUG : BROWSER_OUTPUT: 04:45:41 INFO - 2015-12-04 04:45:41,809 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12158.21 Median:536.44 stddev:13557.17 (2527.3%) stddev-sans-first:13568.14 04:45:41 INFO - 2015-12-04 04:45:41,810 DEBUG : BROWSER_OUTPUT: Values: 752.5 793.7 797.8 800.9 819.8 14394.0 14728.1 14736.6 14748.9 14774.9 14039.2 14042.5 14100.1 14161.6 14190.5 631.1 646.1 805.3 821.1 821.7 636.2 778.2 801.0 804.1 804.6 845.8 858.3 858.5 859.3 860.5 653.0 668.0 817.3 849.2 855.4 620.9 621.7 622.4 623.0 623.8 12833.0 12961.7 12978.4 12982.7 13005.4 10891.5 11163.2 11303.7 11399.2 11782.8 9439.3 9648.0 9649.9 9749.0 9791.2 3234.5 3253.3 3272.1 3276.7 3316.1 42157.6 42262.0 42635.8 42679.6 42689.8 9372.7 9437.6 9460.2 9465.5 9530.3 16469.8 16490.2 16494.1 16495.9 16528.8 6158.4 6193.4 6275.4 6312.2 6452.5 3484.1 3554.9 3598.8 3618.7 3625.3 2697.9 2701.8 2706.2 2724.2 2733.9 501.3 508.9 509.4 510.9 513.1 514.7 553.1 600.9 603.5 615.6 7396.7 7426.5 7439.3 7620.3 7683.7 468.9 493.0 519.8 581.5 605.1 3707.7 3783.1 3886.3 3952.5 3962.0 46640.3 46945.8 47131.3 47480.0 47677.0 42313.6 42683.0 42740.6 42760.4 43080.8 40446.8 40512.8 40921.8 40929.0 41222.0 7655.3 7690.3 7728.0 7739.8 7827.7 30454.0 30526.0 30974.4 31181.5 31193.7 36158.3 36441.5 36858.0 39709.6 39746.2 8508.1 8984.0 9086.1 9588.8 9602.5 10158.9 10163.8 10243.6 10368.3 10700.6 9545.8 9569.0 9690.8 9866.6 10133.1 9522.6 9528.5 9612.1 9779.8 9909.7 9830.6 9917.2 9941.5 9996.8 10028.4 8527.5 8570.3 8594.7 8727.5 8901.5 8166.8 8215.9 8438.4 8822.9 9302.4 04:45:41 INFO - 2015-12-04 04:45:41,810 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:45:41 INFO - 2015-12-04 04:45:41,811 DEBUG : BROWSER_OUTPUT: 04:45:42 INFO - 2015-12-04 04:45:42,538 INFO : Browser exited with error code: 0 04:45:42 INFO - 2015-12-04 04:45:42,554 INFO : Completed test dromaeo_css (00:18:37) 04:45:42 INFO - 2015-12-04 04:45:42,554 INFO : Starting test kraken 04:45:42 INFO - 2015-12-04 04:45:42,554 DEBUG : operating with platform_type : linux_ 04:45:42 INFO - 2015-12-04 04:45:42,554 INFO : Initialising browser for kraken test... 04:45:42 INFO - 2015-12-04 04:45:42,560 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgukYDM/profile http://localhost:55491/getInfo.html 04:45:46 INFO - 2015-12-04 04:45:46,644 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:45:46 INFO - 2015-12-04 04:45:46,644 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:45:46 INFO - 2015-12-04 04:45:46,645 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:45:46 INFO - 2015-12-04 04:45:46,645 DEBUG : BROWSER_OUTPUT: __metrics 04:45:46 INFO - 2015-12-04 04:45:46,726 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:45:46 INFO - 2015-12-04 04:45:46,802 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:45:47 INFO - 2015-12-04 04:45:47,930 INFO : Browser initialized. 04:45:47 INFO - 2015-12-04 04:45:47,930 INFO : Running cycle 1/1 for kraken test... 04:45:47 INFO - 2015-12-04 04:45:47,930 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgukYDM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:45:59 INFO - 2015-12-04 04:45:59,896 DEBUG : BROWSER_OUTPUT: RSS: Main: 143417344 04:45:59 INFO - 2015-12-04 04:45:59,896 DEBUG : BROWSER_OUTPUT: 04:46:02 INFO - 2015-12-04 04:46:02,533 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55491/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55491/tests/kraken/driver.html?testName=audio-beat-detection) 04:46:03 INFO - 2015-12-04 04:46:03,114 DEBUG : BROWSER_OUTPUT: RSS: Main: 177975296 04:46:03 INFO - 2015-12-04 04:46:03,114 DEBUG : BROWSER_OUTPUT: 04:46:05 INFO - 2015-12-04 04:46:05,843 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55491/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55491/tests/kraken/driver.html?testName=audio-dft) 04:46:06 INFO - 2015-12-04 04:46:06,424 DEBUG : BROWSER_OUTPUT: RSS: Main: 167022592 04:46:06 INFO - 2015-12-04 04:46:06,424 DEBUG : BROWSER_OUTPUT: 04:46:09 INFO - 2015-12-04 04:46:09,435 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55491/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55491/tests/kraken/driver.html?testName=audio-fft) 04:46:10 INFO - 2015-12-04 04:46:10,002 DEBUG : BROWSER_OUTPUT: RSS: Main: 153821184 04:46:10 INFO - 2015-12-04 04:46:10,002 DEBUG : BROWSER_OUTPUT: 04:46:12 INFO - 2015-12-04 04:46:12,066 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55491/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55491/tests/kraken/driver.html?testName=audio-oscillator) 04:46:12 INFO - 2015-12-04 04:46:12,640 DEBUG : BROWSER_OUTPUT: RSS: Main: 155250688 04:46:12 INFO - 2015-12-04 04:46:12,640 DEBUG : BROWSER_OUTPUT: 04:46:14 INFO - 2015-12-04 04:46:14,893 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55491/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55491/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:46:15 INFO - 2015-12-04 04:46:15,453 DEBUG : BROWSER_OUTPUT: RSS: Main: 156712960 04:46:15 INFO - 2015-12-04 04:46:15,454 DEBUG : BROWSER_OUTPUT: 04:46:18 INFO - 2015-12-04 04:46:18,424 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55491/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55491/tests/kraken/driver.html?testName=imaging-darkroom) 04:46:19 INFO - 2015-12-04 04:46:19,005 DEBUG : BROWSER_OUTPUT: RSS: Main: 156594176 04:46:19 INFO - 2015-12-04 04:46:19,005 DEBUG : BROWSER_OUTPUT: 04:46:22 INFO - 2015-12-04 04:46:22,488 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55491/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55491/tests/kraken/driver.html?testName=imaging-desaturate) 04:46:23 INFO - 2015-12-04 04:46:23,075 DEBUG : BROWSER_OUTPUT: RSS: Main: 154169344 04:46:23 INFO - 2015-12-04 04:46:23,076 DEBUG : BROWSER_OUTPUT: 04:46:26 INFO - 2015-12-04 04:46:26,034 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55491/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55491/tests/kraken/driver.html?testName=json-parse-financial) 04:46:26 INFO - 2015-12-04 04:46:26,604 DEBUG : BROWSER_OUTPUT: RSS: Main: 156160000 04:46:26 INFO - 2015-12-04 04:46:26,604 DEBUG : BROWSER_OUTPUT: 04:46:28 INFO - 2015-12-04 04:46:28,374 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55491/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55491/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:46:28 INFO - 2015-12-04 04:46:28,943 DEBUG : BROWSER_OUTPUT: RSS: Main: 166920192 04:46:28 INFO - 2015-12-04 04:46:28,943 DEBUG : BROWSER_OUTPUT: 04:46:30 INFO - 2015-12-04 04:46:30,820 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55491/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55491/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:46:31 INFO - 2015-12-04 04:46:31,409 DEBUG : BROWSER_OUTPUT: RSS: Main: 166793216 04:46:31 INFO - 2015-12-04 04:46:31,409 DEBUG : BROWSER_OUTPUT: 04:46:33 INFO - 2015-12-04 04:46:33,589 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55491/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55491/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:46:34 INFO - 2015-12-04 04:46:34,174 DEBUG : BROWSER_OUTPUT: RSS: Main: 177405952 04:46:34 INFO - 2015-12-04 04:46:34,175 DEBUG : BROWSER_OUTPUT: 04:46:36 INFO - 2015-12-04 04:46:36,759 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55491/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55491/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:46:37 INFO - 2015-12-04 04:46:37,345 DEBUG : BROWSER_OUTPUT: RSS: Main: 183623680 04:46:37 INFO - 2015-12-04 04:46:37,345 DEBUG : BROWSER_OUTPUT: 04:46:39 INFO - 2015-12-04 04:46:39,945 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55491/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55491/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:46:40 INFO - 2015-12-04 04:46:40,528 DEBUG : BROWSER_OUTPUT: RSS: Main: 183111680 04:46:40 INFO - 2015-12-04 04:46:40,528 DEBUG : BROWSER_OUTPUT: 04:46:42 INFO - 2015-12-04 04:46:42,299 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55491/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55491/tests/kraken/driver.html?testName=ai-astar) 04:46:42 INFO - 2015-12-04 04:46:42,549 DEBUG : BROWSER_OUTPUT: RSS: Main: 241659904 04:46:42 INFO - 2015-12-04 04:46:42,550 DEBUG : BROWSER_OUTPUT: 04:46:42 INFO - 2015-12-04 04:46:42,553 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:46:42 INFO - 2015-12-04 04:46:42,553 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:46:42 INFO - 2015-12-04 04:46:42,554 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:46:42 INFO - 2015-12-04 04:46:42,554 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:46:42 INFO - 2015-12-04 04:46:42,554 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;114;106;112;112;113;102;112;114;119 04:46:42 INFO - 2015-12-04 04:46:42,554 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;129;152;170;130;152;160;129;179;130 04:46:42 INFO - 2015-12-04 04:46:42,554 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;162;162;163;161;162;162;162;161 04:46:42 INFO - 2015-12-04 04:46:42,555 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;90;91;72;78;73;105;97;72 04:46:42 INFO - 2015-12-04 04:46:42,555 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;129;94;94;94;136;94;95;129 04:46:42 INFO - 2015-12-04 04:46:42,555 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;109;110;110;109;110;109;109 04:46:42 INFO - 2015-12-04 04:46:42,555 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;148;146;147;146;147;147;146;147 04:46:42 INFO - 2015-12-04 04:46:42,555 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;96;95;95;95;95;95;96 04:46:42 INFO - 2015-12-04 04:46:42,555 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;71;72;72;72;71;72;81;71;71 04:46:42 INFO - 2015-12-04 04:46:42,555 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;69;67;69;69;69;68;68;68;69 04:46:42 INFO - 2015-12-04 04:46:42,555 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;84;84;85;83;84;84;86;83;87 04:46:42 INFO - 2015-12-04 04:46:42,556 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;131;120;127;119;131;130;129;129;138;121 04:46:42 INFO - 2015-12-04 04:46:42,556 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;154;150;147;139;136;149;149;149;137 04:46:42 INFO - 2015-12-04 04:46:42,556 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;70;70;70;71;72;70;69;71;71 04:46:42 INFO - 2015-12-04 04:46:42,556 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:46:42 INFO - 2015-12-04 04:46:42,556 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:46:42 INFO - 2015-12-04 04:46:42,556 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,970 04:46:42 INFO - 2015-12-04 04:46:42,556 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:46:42 INFO - 2015-12-04 04:46:42,557 DEBUG : BROWSER_OUTPUT: __startTimestamp1449233202551__endTimestamp 04:46:42 INFO - 2015-12-04 04:46:42,557 DEBUG : BROWSER_OUTPUT: 04:46:42 INFO - 2015-12-04 04:46:42,560 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:46:42 INFO - 2015-12-04 04:46:42,560 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:46:42 INFO - 2015-12-04 04:46:42,560 DEBUG : BROWSER_OUTPUT: 04:46:42 INFO - 2015-12-04 04:46:42,560 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.60 Median:112.50 stddev:4.62 (4.1%) stddev-sans-first:4.90 04:46:42 INFO - 2015-12-04 04:46:42,560 DEBUG : BROWSER_OUTPUT: Values: 112.0 114.0 106.0 112.0 112.0 113.0 102.0 112.0 114.0 119.0 04:46:42 INFO - 2015-12-04 04:46:42,560 DEBUG : BROWSER_OUTPUT: 04:46:42 INFO - 2015-12-04 04:46:42,561 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.60 Median:153.50 stddev:18.37 (12.0%) stddev-sans-first:19.34 04:46:42 INFO - 2015-12-04 04:46:42,561 DEBUG : BROWSER_OUTPUT: Values: 155.0 129.0 152.0 170.0 130.0 152.0 160.0 129.0 179.0 130.0 04:46:42 INFO - 2015-12-04 04:46:42,561 DEBUG : BROWSER_OUTPUT: 04:46:42 INFO - 2015-12-04 04:46:42,561 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.67 (0.4%) stddev-sans-first:0.67 04:46:42 INFO - 2015-12-04 04:46:42,561 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 162.0 162.0 163.0 161.0 162.0 162.0 162.0 161.0 04:46:42 INFO - 2015-12-04 04:46:42,561 DEBUG : BROWSER_OUTPUT: 04:46:42 INFO - 2015-12-04 04:46:42,561 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.30 Median:75.50 stddev:12.37 (16.4%) stddev-sans-first:12.54 04:46:42 INFO - 2015-12-04 04:46:42,561 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 90.0 91.0 72.0 78.0 73.0 105.0 97.0 72.0 04:46:42 INFO - 2015-12-04 04:46:42,561 DEBUG : BROWSER_OUTPUT: 04:46:42 INFO - 2015-12-04 04:46:42,561 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.30 Median:94.00 stddev:18.07 (19.2%) stddev-sans-first:18.70 04:46:42 INFO - 2015-12-04 04:46:42,562 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 129.0 94.0 94.0 94.0 136.0 94.0 95.0 129.0 04:46:42 INFO - 2015-12-04 04:46:42,562 DEBUG : BROWSER_OUTPUT: 04:46:42 INFO - 2015-12-04 04:46:42,562 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 04:46:42 INFO - 2015-12-04 04:46:42,562 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 109.0 110.0 110.0 109.0 110.0 109.0 109.0 04:46:42 INFO - 2015-12-04 04:46:42,562 DEBUG : BROWSER_OUTPUT: 04:46:42 INFO - 2015-12-04 04:46:42,563 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 04:46:42 INFO - 2015-12-04 04:46:42,563 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 148.0 146.0 147.0 146.0 147.0 147.0 146.0 147.0 04:46:42 INFO - 2015-12-04 04:46:42,563 DEBUG : BROWSER_OUTPUT: 04:46:42 INFO - 2015-12-04 04:46:42,563 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 04:46:42 INFO - 2015-12-04 04:46:42,563 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 04:46:42 INFO - 2015-12-04 04:46:42,563 DEBUG : BROWSER_OUTPUT: 04:46:42 INFO - 2015-12-04 04:46:42,563 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.60 Median:72.00 stddev:3.03 (4.2%) stddev-sans-first:3.21 04:46:42 INFO - 2015-12-04 04:46:42,564 DEBUG : BROWSER_OUTPUT: Values: 73.0 71.0 72.0 72.0 72.0 71.0 72.0 81.0 71.0 71.0 04:46:42 INFO - 2015-12-04 04:46:42,564 DEBUG : BROWSER_OUTPUT: 04:46:42 INFO - 2015-12-04 04:46:42,564 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:69.00 stddev:0.82 (1.2%) stddev-sans-first:0.73 04:46:42 INFO - 2015-12-04 04:46:42,564 DEBUG : BROWSER_OUTPUT: Values: 67.0 69.0 67.0 69.0 69.0 69.0 68.0 68.0 68.0 69.0 04:46:42 INFO - 2015-12-04 04:46:42,564 DEBUG : BROWSER_OUTPUT: 04:46:42 INFO - 2015-12-04 04:46:42,564 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:84.00 stddev:1.34 (1.6%) stddev-sans-first:1.33 04:46:42 INFO - 2015-12-04 04:46:42,564 DEBUG : BROWSER_OUTPUT: Values: 83.0 84.0 84.0 85.0 83.0 84.0 84.0 86.0 83.0 87.0 04:46:42 INFO - 2015-12-04 04:46:42,564 DEBUG : BROWSER_OUTPUT: 04:46:42 INFO - 2015-12-04 04:46:42,564 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.50 Median:129.50 stddev:5.93 (4.6%) stddev-sans-first:6.15 04:46:42 INFO - 2015-12-04 04:46:42,564 DEBUG : BROWSER_OUTPUT: Values: 131.0 120.0 127.0 119.0 131.0 130.0 129.0 129.0 138.0 121.0 04:46:42 INFO - 2015-12-04 04:46:42,565 DEBUG : BROWSER_OUTPUT: 04:46:42 INFO - 2015-12-04 04:46:42,565 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.70 Median:149.00 stddev:6.68 (4.5%) stddev-sans-first:6.48 04:46:42 INFO - 2015-12-04 04:46:42,565 DEBUG : BROWSER_OUTPUT: Values: 137.0 154.0 150.0 147.0 139.0 136.0 149.0 149.0 149.0 137.0 04:46:42 INFO - 2015-12-04 04:46:42,565 DEBUG : BROWSER_OUTPUT: 04:46:42 INFO - 2015-12-04 04:46:42,565 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:71.00 stddev:0.85 (1.2%) stddev-sans-first:0.88 04:46:42 INFO - 2015-12-04 04:46:42,565 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 70.0 70.0 71.0 72.0 70.0 69.0 71.0 71.0 04:46:42 INFO - 2015-12-04 04:46:42,565 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:46:42 INFO - 2015-12-04 04:46:42,565 DEBUG : BROWSER_OUTPUT: 04:46:43 INFO - 2015-12-04 04:46:43,490 INFO : Browser exited with error code: 0 04:46:43 INFO - 2015-12-04 04:46:43,543 INFO : Completed test kraken (00:01:00) 04:46:43 INFO - 2015-12-04 04:46:43,543 INFO : Starting test v8_7 04:46:43 INFO - 2015-12-04 04:46:43,543 DEBUG : operating with platform_type : linux_ 04:46:43 INFO - 2015-12-04 04:46:43,543 INFO : Initialising browser for v8_7 test... 04:46:43 INFO - 2015-12-04 04:46:43,549 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6p3yj0/profile http://localhost:55491/getInfo.html 04:46:47 INFO - 2015-12-04 04:46:47,679 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:46:47 INFO - 2015-12-04 04:46:47,679 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:46:47 INFO - 2015-12-04 04:46:47,680 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:46:47 INFO - 2015-12-04 04:46:47,680 DEBUG : BROWSER_OUTPUT: __metrics 04:46:47 INFO - 2015-12-04 04:46:47,878 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:46:47 INFO - 2015-12-04 04:46:47,954 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:46:49 INFO - 2015-12-04 04:46:49,018 INFO : Browser initialized. 04:46:49 INFO - 2015-12-04 04:46:49,019 INFO : Running cycle 1/1 for v8_7 test... 04:46:49 INFO - 2015-12-04 04:46:49,019 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6p3yj0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:47:01 INFO - 2015-12-04 04:47:01,024 DEBUG : BROWSER_OUTPUT: RSS: Main: 142127104 04:47:01 INFO - 2015-12-04 04:47:01,024 DEBUG : BROWSER_OUTPUT: 04:47:22 INFO - 2015-12-04 04:47:22,375 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55491/tests/v8_7/run.html (next: http://localhost:55491/tests/v8_7/run.html) 04:47:22 INFO - 2015-12-04 04:47:22,621 DEBUG : BROWSER_OUTPUT: RSS: Main: 443834368 04:47:22 INFO - 2015-12-04 04:47:22,621 DEBUG : BROWSER_OUTPUT: 04:47:22 INFO - 2015-12-04 04:47:22,622 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:47:22 INFO - 2015-12-04 04:47:22,623 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:47:22 INFO - 2015-12-04 04:47:22,623 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:47:22 INFO - 2015-12-04 04:47:22,623 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:47:22 INFO - 2015-12-04 04:47:22,623 DEBUG : BROWSER_OUTPUT: |0;Richards;166.16816218012627 04:47:22 INFO - 2015-12-04 04:47:22,623 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.3238308179616 04:47:22 INFO - 2015-12-04 04:47:22,623 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.01785714285717 04:47:22 INFO - 2015-12-04 04:47:22,623 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5138.461538461538 04:47:22 INFO - 2015-12-04 04:47:22,623 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1978.2608695652175 04:47:22 INFO - 2015-12-04 04:47:22,624 DEBUG : BROWSER_OUTPUT: |5;Earley;793.6507936507936 04:47:22 INFO - 2015-12-04 04:47:22,624 DEBUG : BROWSER_OUTPUT: |6;Boyer;12108.43373493976 04:47:22 INFO - 2015-12-04 04:47:22,624 DEBUG : BROWSER_OUTPUT: |7;RegExp;27027.027027027027 04:47:22 INFO - 2015-12-04 04:47:22,624 DEBUG : BROWSER_OUTPUT: |8;Splay;617.283950617284 04:47:22 INFO - 2015-12-04 04:47:22,624 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 04:47:22 INFO - 2015-12-04 04:47:22,624 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:47:22 INFO - 2015-12-04 04:47:22,624 DEBUG : BROWSER_OUTPUT: __startTimestamp1449233242621__endTimestamp 04:47:22 INFO - 2015-12-04 04:47:22,624 DEBUG : BROWSER_OUTPUT: 04:47:22 INFO - 2015-12-04 04:47:22,624 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:47:22 INFO - 2015-12-04 04:47:22,626 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:47:22 INFO - 2015-12-04 04:47:22,626 DEBUG : BROWSER_OUTPUT: 04:47:22 INFO - 2015-12-04 04:47:22,626 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.17 Median:166.17 stddev:0.00 (0.0%) 04:47:22 INFO - 2015-12-04 04:47:22,626 DEBUG : BROWSER_OUTPUT: Values: 166.2 04:47:22 INFO - 2015-12-04 04:47:22,626 DEBUG : BROWSER_OUTPUT: 04:47:22 INFO - 2015-12-04 04:47:22,626 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.32 Median:186.32 stddev:0.00 (0.0%) 04:47:22 INFO - 2015-12-04 04:47:22,626 DEBUG : BROWSER_OUTPUT: Values: 186.3 04:47:22 INFO - 2015-12-04 04:47:22,626 DEBUG : BROWSER_OUTPUT: 04:47:22 INFO - 2015-12-04 04:47:22,626 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.02 Median:279.02 stddev:0.00 (0.0%) 04:47:22 INFO - 2015-12-04 04:47:22,626 DEBUG : BROWSER_OUTPUT: Values: 279.0 04:47:22 INFO - 2015-12-04 04:47:22,626 DEBUG : BROWSER_OUTPUT: 04:47:22 INFO - 2015-12-04 04:47:22,626 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5138.46 Median:5138.46 stddev:0.00 (0.0%) 04:47:22 INFO - 2015-12-04 04:47:22,626 DEBUG : BROWSER_OUTPUT: Values: 5138.5 04:47:22 INFO - 2015-12-04 04:47:22,626 DEBUG : BROWSER_OUTPUT: 04:47:22 INFO - 2015-12-04 04:47:22,626 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1978.26 Median:1978.26 stddev:0.00 (0.0%) 04:47:22 INFO - 2015-12-04 04:47:22,626 DEBUG : BROWSER_OUTPUT: Values: 1978.3 04:47:22 INFO - 2015-12-04 04:47:22,627 DEBUG : BROWSER_OUTPUT: 04:47:22 INFO - 2015-12-04 04:47:22,627 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:793.65 Median:793.65 stddev:0.00 (0.0%) 04:47:22 INFO - 2015-12-04 04:47:22,627 DEBUG : BROWSER_OUTPUT: Values: 793.7 04:47:22 INFO - 2015-12-04 04:47:22,627 DEBUG : BROWSER_OUTPUT: 04:47:22 INFO - 2015-12-04 04:47:22,627 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12108.43 Median:12108.43 stddev:0.00 (0.0%) 04:47:22 INFO - 2015-12-04 04:47:22,627 DEBUG : BROWSER_OUTPUT: Values: 12108.4 04:47:22 INFO - 2015-12-04 04:47:22,627 DEBUG : BROWSER_OUTPUT: 04:47:22 INFO - 2015-12-04 04:47:22,627 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27027.03 Median:27027.03 stddev:0.00 (0.0%) 04:47:22 INFO - 2015-12-04 04:47:22,627 DEBUG : BROWSER_OUTPUT: Values: 27027.0 04:47:22 INFO - 2015-12-04 04:47:22,627 DEBUG : BROWSER_OUTPUT: 04:47:22 INFO - 2015-12-04 04:47:22,627 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:617.28 Median:617.28 stddev:0.00 (0.0%) 04:47:22 INFO - 2015-12-04 04:47:22,627 DEBUG : BROWSER_OUTPUT: Values: 617.3 04:47:22 INFO - 2015-12-04 04:47:22,627 DEBUG : BROWSER_OUTPUT: 04:47:22 INFO - 2015-12-04 04:47:22,627 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 04:47:22 INFO - 2015-12-04 04:47:22,627 DEBUG : BROWSER_OUTPUT: Values: 4830.9 04:47:22 INFO - 2015-12-04 04:47:22,627 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:47:22 INFO - 2015-12-04 04:47:22,628 DEBUG : BROWSER_OUTPUT: 04:47:23 INFO - 2015-12-04 04:47:23,530 INFO : Browser exited with error code: 0 04:47:23 INFO - 2015-12-04 04:47:23,544 INFO : Completed test v8_7 (00:00:40) 04:47:23 INFO - 2015-12-04 04:47:23,715 INFO : Completed test suite (00:20:18) 04:47:23 INFO - 2015-12-04 04:47:23,715 DEBUG : Working with test: dromaeo_css 04:47:23 INFO - 2015-12-04 04:47:23,716 DEBUG : Generating results file: dromaeo_css 04:47:23 INFO - 2015-12-04 04:47:23,717 DEBUG : Working with test: kraken 04:47:23 INFO - 2015-12-04 04:47:23,717 DEBUG : Generating results file: kraken 04:47:23 INFO - 2015-12-04 04:47:23,717 INFO : javascript benchmark 04:47:23 INFO - 2015-12-04 04:47:23,717 DEBUG : Working with test: v8_7 04:47:23 INFO - 2015-12-04 04:47:23,717 DEBUG : Generating results file: v8_7 04:47:23 INFO - 2015-12-04 04:47:23,718 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:47:23 INFO - 2015-12-04 04:47:23,769 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 04:47:23 INFO - 2015-12-04 04:47:23,769 DEBUG : process_Request line: dromaeo_css 6226.92 graph.html#tests=[[72,94,35]] 04:47:23 INFO - 2015-12-04 04:47:23,769 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:47:23 INFO - 2015-12-04 04:47:23,800 DEBUG : process_Request line: kraken 1529.00 graph.html#tests=[[232,94,35]] 04:47:23 INFO - 2015-12-04 04:47:23,800 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:47:23 INFO - 2015-12-04 04:47:23,831 DEBUG : process_Request line: v8_7 19777.48 graph.html#tests=[[230,94,35]] 04:47:23 INFO - 2015-12-04 04:47:23,832 INFO : javascript benchmark 04:47:23 INFO - 2015-12-04 04:47:23,836 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2611.947761044779, 2714.8506832124226, 2718.8096833221684, 2722.4963381774373, 2745.1490038088186, 4480.0, 4613.100445413137, 4661.324108004337, 4686.6953648012895, 4695.107929493398, 4525.660575456837, 4546.886012926838, 4616.67683262171, 4622.473172259197, 4622.491525932153, 4239.025024244425, 4248.511421186572, 4267.914641707164, 4425.203463376591, 4430.556944305576, 4117.485314335708, 4369.016971181474, 4379.146066517031, 4431.313146462304, 4441.5336389679105, 4193.559676233982, 4193.895152621194, 4220.53574106848, 4330.891727706801, 4341.761203133827, 4328.588784065509, 4342.869713908556, 4345.435093437833, 4345.73925564464, 4402.581754733327, 4322.135572885404, 4330.025744207528, 4336.262835318003, 4356.041670832412, 4356.629686476654, 4351.412559304516, 4456.384954956746, 4459.175052615276, 4475.753833539154, 4597.816087356502, 5005.624578156617, 5009.248612708123, 5011.373578302712, 5013.0725815723845, 5064.113780088506, 5038.294638750578, 5038.899222015576, 5038.924416133761, 5043.596512279046, 5081.517255860687, 4362.607365337135, 4475.261581838992, 4476.932846007313, 4531.932021019687, 4650.906981860411, 5098.5411312982005, 5152.871178220575, 5156.9742151289, 5161.122609156452, 5164.715940623302, 4939.950600493949, 4963.875903102379, 4966.304717339575, 4966.577840883565, 5000.799968001312, 4699.95300047002, 4800.3759511263315, 4803.375561177025, 4809.278608208797, 4919.655624106278, 4917.0, 4967.4784147664695, 4977.726225057657, 4991.650584459053, 4996.175631020914, 4952.331435256195, 4972.179590367549, 4975.054739599537, 4979.3277907482025, 5015.774290156952, 3914.8042597869994, 3995.5005624296964, 4032.858849940238, 4166.479190101238, 4191.7694526801315, 3584.444411116281, 3635.0, 3653.050206946213, 3676.0809797550614, 3693.7045036397026, 4247.936280955726, 4277.957220427818, 4280.89297767552, 4316.611504964569, 4322.135572885372, 4689.648276379286, 4805.927911081267, 4807.990322032342, 5000.349954505891, 5002.299678045077, 4181.749095054306, 4247.787610619456, 4254.553271906467, 4290.89272768177, 4291.377750226262, 4388.692791504628, 4432.534583868647, 4435.423394958635, 4441.978344980673, 4482.618977386958, 4516.751578663205, 4637.76811159434, 4644.651651126247, 4742.19382704941, 4798.7840547174765, 4864.92702609454, 4939.135651261086, 4957.876053098701, 4962.727050012139, 4999.275105109811, 4735.502772208868, 4748.667593268438, 4752.073345697556, 4754.096721622881, 4789.712617242837, 4599.0, 4710.552497512731, 4723.197056500472, 4932.4327702314695, 4966.553010229097, 4921.876953076202, 5009.77456014473, 5029.170186919264, 5031.144705400164, 5071.670341427795, 4825.203841366135, 4829.0, 4839.9836034431755, 4846.830360937351, 4882.438519570295, 4589.885252868571, 4709.740964246999, 4711.387519622427, 4848.903021939612, 4891.951080489292, 4601.815927362868, 4699.2481203007355, 4742.5731684148595, 4764.809407623657, 4773.64197685182, 4800.35195248637, 4827.348307978518, 4831.371921650163, 4835.927461088017, 4881.731504767272, 4546.681732278708, 4672.5327467253, 4732.313814496947, 4733.053389322081, 4783.832565860178], "unit": "ms", "name": "dojo.html", "value": 4547.279658546284}, {"lowerIsBetter": false, "replicates": [573.4867293772074, 576.7375843990984, 587.6562211106501, 588.2470437839567, 597.980443344098, 26191.73808261917, 37329.81335093328, 37688.24623507528, 37771.43342849852, 37794.8110259449, 39394.21211575767, 39967.0, 40046.39930401046, 40079.0, 40146.59853401472, 7022.227554968975, 7131.108611423572, 7887.723929662448, 8049.396295277848, 8058.073321568007, 10086.142677872389, 10360.067593916547, 10365.067143957041, 10365.326253793517, 10366.326188797742, 9999.900000999969, 10024.699259022242, 10094.394336339807, 10128.645497407591, 10139.0, 7194.892076618855, 7354.852902941965, 7356.411487081021, 9938.9503052485, 10129.594816207344, 9788.461634610094, 9917.801643967081, 9919.867228545825, 9921.404715717008, 9925.057119573628, 36376.81811590952, 36533.817330913174, 36576.268474630626, 36773.0, 36795.448068278994, 2843.076000299911, 2887.581300711385, 2938.030449951511, 3463.8268086595567, 3663.761855479412, 27993.30016749577, 27997.720022799716, 28161.85919070412, 28598.0, 28615.57076643852, 3433.570803649544, 3455.740819438527, 3462.722982161421, 3516.507688923553, 3552.946705799415, 223633.0, 224919.0, 225663.0, 225711.8714406434, 226348.0, 50592.74703626458, 51647.48352516502, 53951.730241348545, 54455.18317225245, 55423.722881386144, 56841.0, 57205.713971429876, 57235.0, 57486.0, 57492.0, 13332.200067995756, 13524.256165910772, 13526.661833454242, 13540.796888046687, 13603.115797473132, 9919.65281215154, 9950.35322704022, 9967.651132210483, 9970.302078854556, 9981.900180998242, 18900.05499725008, 19028.66799324062, 19065.42803715891, 19132.808671913102, 19185.52036199106, 7211.783646490614, 7437.51656142349, 7476.514026588255, 7497.700091996259, 7511.248875112445, 831.7005877883956, 868.8957325121025, 905.0270958719403, 908.2597682888425, 977.7066879935991, 25847.224583262534, 26979.32551686184, 27181.45637087247, 27262.5910611341, 27883.442331153263, 926.6525053105086, 979.8530220466845, 996.2179688944144, 1010.838265877456, 1059.3537941855461, 12233.755324893453, 12288.692782680326, 12396.876031239752, 12477.438515266835, 12547.0, 266249.0, 270986.0, 271119.0, 272490.0, 272516.0, 44684.19105516327, 44815.55184448179, 44890.0, 44905.10189796186, 45050.0, 1220.9633710988685, 1242.099477878531, 1250.9687257818446, 1254.0719867298133, 1255.0712472770085, 20715.0, 27127.457450851267, 28095.0, 28149.71850281471, 28321.15036548907, 40490.79754601208, 40977.0, 41023.58976410198, 41035.38446923239, 41083.0, 216698.0, 218071.0, 218449.0, 219064.0, 219105.0, 24093.277201683977, 28152.155435336972, 28910.566341504473, 30088.247793804454, 30954.380912382076, 36742.8162859184, 37136.62863371332, 37266.441003384425, 37607.0, 38968.6103138965, 29535.55696664595, 30455.390892182477, 31602.0, 32798.18004549905, 33023.66976330302, 29865.55201671933, 30479.390412192075, 30570.0, 30600.693993059784, 30657.693423065484, 30343.696563034086, 32827.34345313128, 33073.669263307056, 33301.0, 33316.00155985973, 26340.736592633828, 29361.70638293675, 29507.409851803273, 29790.255243618216, 29971.250718732204, 22098.779012210314, 22887.198948037403, 23361.0, 23401.0, 25555.36111597225], "unit": "ms", "name": "ext.html", "value": 16998.49523141703}, {"lowerIsBetter": false, "replicates": [323.2129764024599, 329.9620543637482, 330.7205411427343, 334.0396360463667, 334.19959197721465, 12461.563845265395, 12725.809112863291, 14572.56282311531, 15296.0, 15298.923505382458, 12104.455299511521, 13754.0, 13903.721925561482, 13907.374168162432, 14206.218657973808, 3972.781497017663, 4782.7608619569055, 4888.144574699431, 4916.729579873106, 4940.382452193476, 4836.637252206098, 4868.245421959602, 4869.415670119591, 4874.707517548941, 4885.364902562662, 4837.709737415748, 4849.660523763338, 4934.481879402665, 4939.703617782927, 4954.30639710439, 4857.854264372075, 4873.195922672755, 4884.0, 4891.559759621633, 4892.926606100911, 4342.34864770287, 4377.102693947765, 4381.978090109561, 4383.035732138925, 4384.298512238059, 18750.0624968751, 18839.0, 19122.139503722366, 19940.800591994186, 19966.0, 1731.6017316017387, 1901.3630433804692, 1914.15777058094, 1918.6258679557493, 1935.2162374238455, 8568.528730919797, 8735.519546424945, 8740.781480462976, 10450.68647940563, 12072.09459290548, 1759.0764848454535, 1775.6803775320566, 1790.4539115569746, 1817.8000419953794, 1818.6271814278173, 47323.76338118322, 48569.51430485685, 49208.0, 53656.0, 56686.43313566853, 8916.331275154389, 9074.500902450296, 9124.361294709439, 9125.36122471434, 9154.450732956044, 11135.888641113646, 11138.665840024812, 11350.09199264057, 11440.313581185155, 11471.541138354372, 6283.560150789401, 6392.0, 6421.3578642136345, 6431.614103153825, 6535.44448721864, 5915.704214789243, 6096.847578810565, 6144.8771024579255, 6182.876342473125, 6199.070139479114, 3868.323043467382, 3888.6889048876023, 3912.5891781362548, 3913.8434462621176, 3950.8617198398492, 1604.630934884983, 1687.7130887749113, 1694.737315716066, 1712.6917154911987, 1728.809830918598, 806.1535387842741, 812.6627449608346, 874.9762777550281, 892.3262936483044, 990.346371394876, 16014.359425622844, 16030.0, 16049.67900642004, 16237.756433653505, 16319.67360652804, 786.1980779604771, 824.0646865807232, 841.2176675691666, 854.7178043072984, 919.3748251189122, 8726.912730872737, 9044.0, 9099.181073703267, 9123.087691230823, 9161.77095572616, 471448.0, 478269.0, 480382.0, 480959.0, 501089.0, 69516.0, 69965.30034699588, 70796.64601676959, 70868.0, 71485.64257178681, 1060.4326685223368, 1068.385678235018, 1073.3184427888348, 1073.7476692977143, 1077.0145317034826, 13537.796933045815, 13918.164910105426, 14948.028378155384, 14980.0, 15089.396424142911, 23740.694261815766, 25505.234842954742, 26751.598726018736, 31542.0, 32202.38988050635, 33826.49260261049, 34575.82712086423, 35518.822405887804, 37645.62354376421, 41703.79148104361, 8647.654093836427, 8656.567171641518, 8683.348748843735, 8706.216440520384, 8716.128387161232, 11546.884531154918, 13288.335583220995, 15555.988860724017, 16111.838881611035, 16853.073080980663, 13016.414261358072, 13234.073614847253, 13492.460301587827, 13616.18302901829, 13661.38523766413, 12282.570110046105, 12425.31660758667, 12532.686682833002, 13031.283279419344, 13126.14680045794, 13583.660408489866, 13847.86152138506, 13993.720125597634, 14098.647533811327, 14232.644183895485, 8356.707515236938, 8424.157584241771, 8580.570971451278, 8759.956200218958, 8766.254868336007, 13096.607101786962, 13303.135296205715, 13529.526466573623, 13624.65938351549, 13839.930800346337], "unit": "ms", "name": "jquery.html", "value": 7954.990161606013}, {"lowerIsBetter": false, "replicates": [1247.9188852724578, 1659.941902033429, 1706.5733566608349, 1731.8527925126364, 1742.3030787684925, 5983.3717459666705, 7035.2612975637585, 7250.601216933067, 7252.129744430676, 7252.311030452099, 6645.867082658344, 6788.592684438925, 6791.864162716743, 6792.286809884965, 6799.150106236721, 1757.6660434517464, 1792.06812457522, 1792.5429015601069, 2034.2574960139555, 2053.8664986775884, 2072.3990042887544, 2129.37183530858, 2130.9786902131013, 2133.7332833395826, 2134.061013154215, 2060.7424071991, 2072.5958438104576, 2119.629064913634, 2136.711543941571, 2139.529303553216, 1744.7819022622173, 1781.6703909776604, 2043.6627956387326, 2081.864678795881, 2097.643400621898, 2046.8464865135024, 2051.0155125539677, 2054.8356131509445, 2057.7942205779304, 2057.855950083495, 7024.262452442522, 7139.571625702474, 7154.1415030196185, 7156.92843071573, 7158.105236845395, 4230.915381692349, 4246.2356775780345, 4247.108107297471, 4292.570742925714, 4316.050468896838, 2776.5557510798176, 2810.2271875234474, 2839.162447078096, 2839.5882597023315, 2847.572864070385, 924.2328867040341, 931.222429271559, 945.6028468043438, 950.8288508068545, 955.1212884146602, 9636.566354514063, 9654.420734755937, 9665.081817227352, 9665.565049572786, 9668.564914578861, 3994.500687414073, 4057.6145266199665, 4092.631663150331, 4096.610821971908, 4117.670586353084, 8279.296259817862, 8295.8340833183, 8299.502029878106, 8303.418760686814, 8305.0, 4224.070704445017, 4231.576842315744, 4244.10873716523, 4253.659707223414, 4257.318828987347, 3860.6332398422105, 3861.0, 3864.594217607167, 3866.1881004988704, 3871.96128038716, 3438.7420943429343, 3448.327576122632, 3481.4255647817827, 3486.8082255476193, 3500.4224302989724, 1105.3588918427292, 1120.4509790202742, 1127.177160672697, 1134.0643968725835, 1138.8348689439986, 1104.4808939798281, 1119.5465836336298, 1133.6315697398213, 1134.4384529657707, 1135.460656188304, 6437.678116094176, 6493.577917435352, 6494.220693516808, 6523.934760652428, 6546.312637173123, 391.93141200289836, 447.88355027693035, 450.6259804362371, 453.0485979443209, 455.5262526971912, 4412.691111622155, 5388.676679399248, 5473.835784926379, 5481.314835645544, 5484.067708489566, 8118.066422361386, 8120.187981201832, 8227.876581851277, 8264.173582641688, 8294.004719433706, 8088.676452941934, 8103.946486956658, 8112.959435202786, 8122.0, 8207.917920820715, 6117.418845209698, 6117.694115294217, 6156.07658851167, 6200.3799620037635, 6227.782027629011, 6643.0, 6706.463482921452, 6710.698018589273, 6711.127553418024, 6713.462922966249, 7436.516626419266, 7476.710167647001, 7531.623418829146, 7588.127365353055, 7599.240075992578, 7658.387329013777, 7695.076590809139, 7784.610769461618, 7817.101033381234, 7908.485948413335, 6057.57596968208, 6103.328633850184, 6111.663858487826, 6117.541184411098, 6117.908231376444, 6780.355866192704, 6825.146856642919, 6864.862702746017, 6868.690908909011, 6870.519063665695, 6225.097360882737, 6283.403076707706, 6316.715747791269, 6373.968130159319, 6384.808455746335, 6218.347073557392, 6267.96866015667, 6355.3326900674765, 6395.136656551306, 6424.196975378078, 6259.123722678738, 6269.247690277196, 6372.968135159294, 6434.8391290218115, 6438.935610643834, 5964.194833697396, 5971.970140149271, 5991.820245392645, 5998.070299103646, 6001.639901605918, 5326.147816349366, 5435.483629055233, 5865.208196893364, 5912.438318359749, 5919.970400147971], "unit": "ms", "name": "mootools.html", "value": 3988.915027372061}, {"lowerIsBetter": false, "replicates": [287.6936063092806, 297.3339719029374, 299.0251779199808, 300.1386022116526, 301.77065430272984, 5290.603204759639, 5312.0, 5341.359036915571, 5362.678239305645, 5380.031594313022, 5245.10833158363, 5252.474752524755, 5256.579473642109, 5261.947380526203, 5270.314859068316, 4113.794310284488, 4122.50529936408, 4127.4427952226515, 4135.359019351998, 4139.6895232857505, 3901.453796468497, 4038.1116154445976, 4101.220768054075, 4130.752154870717, 4132.2768515509815, 3881.7282790204695, 3994.4807175067344, 4004.3392840181336, 4006.1386801837743, 4006.8597599084037, 3820.5033345665024, 3861.092643228839, 3918.608139186087, 3942.093318536724, 3969.0672691917375, 3432.0733401981324, 3434.553508043963, 3509.3332266869215, 3577.6780089791782, 3599.3521166190076, 4935.087008903364, 5036.395632524084, 5116.923246151311, 5123.359580052494, 5140.0, 4680.017196388729, 4693.084848454553, 4696.647751418657, 4696.81212751493, 4703.6942598730975, 5307.52232299095, 5379.542738867201, 5418.512333889968, 5567.777288908439, 5575.996320662279, 3881.0879443331078, 3894.279558281727, 3898.376259798447, 3900.9219815603815, 3915.686745060388, 5801.332846722638, 5812.912806307909, 5816.243888294537, 5819.156222347779, 5825.300963884319, 4007.158496715664, 4007.6593489553134, 4009.8997525062105, 4011.0373510357304, 4017.1764788218347, 3966.4050392441363, 4079.082206503513, 4079.898427424638, 4082.9795851020554, 4093.201825643971, 4651.906961860744, 4653.232216684277, 4656.185167595725, 4657.115148121846, 4657.278121891112, 5528.474794894559, 5539.529140023063, 5540.833774986757, 5545.251391062155, 5547.694876781735, 1408.6548795544952, 1421.459845258795, 1421.4882642248783, 1421.7583010888175, 1421.8364888038009, 969.544314172352, 987.5852142100335, 988.3328753091778, 1001.244060734141, 1003.172382784206, 4845.466998630148, 4846.345743324606, 4851.660383773102, 4854.708717476963, 4859.343988561499, 5761.251037365116, 5768.2501274834, 5770.047942089592, 5770.336411312753, 5770.971145144247, 4846.07924494352, 4851.56335929768, 4854.247591623304, 4854.490278520704, 4855.465898751135, 3006.113196607006, 3065.7700672449655, 3098.9225269368444, 3101.17818778024, 3118.9844050780057, 5504.0643090674685, 5510.6969116698165, 5513.42109078549, 5519.806806761744, 5526.198701188305, 5945.197398351167, 5976.402359763989, 5985.396352586638, 5987.760489580368, 5994.850128746729, 5509.520715677961, 5510.862228444321, 5513.283273174622, 5514.6691198528215, 5518.558515318765, 5536.0865457200725, 5677.971610141923, 5715.914261286167, 5813.738381772746, 5821.76712931478, 5518.2826232589505, 5615.073512870494, 5633.126865335879, 5656.915146272727, 5672.064109421899, 5497.862553436036, 5500.0, 5500.4224556420995, 5500.477454641803, 5501.394846566955, 3891.8443262269193, 3930.744501607386, 3932.2528719543197, 3932.9606703932595, 3933.645971862546, 5671.574631902541, 5815.5929084963645, 5825.825225243249, 5834.883302334015, 5837.182794408701, 5606.6636001840025, 5609.943900560942, 5611.270534830446, 5611.298587676541, 5611.438856114356, 5542.944570554404, 5556.305461817273, 5578.525825304732, 5593.412691667317, 5596.244506991504, 5366.490183432567, 5465.508104270635, 5486.423925487767, 5487.75305111279, 5494.670319780826, 5592.133219351007, 5599.664020158803, 5627.43725627434, 5632.5212356950115, 5642.689652069175, 5432.9185062223305, 5452.972735136299, 5458.4541545845095, 5519.475649813261, 5520.475554822286], "unit": "ms", "name": "prototype.html", "value": 4170.714377465664}, {"lowerIsBetter": false, "replicates": [752.4920678541982, 793.6745934166993, 797.7726347990822, 800.9159038300982, 819.8114433680249, 14394.0, 14728.116313021214, 14736.557903262892, 14748.926255368708, 14774.926125369358, 14039.157650540974, 14042.508512202076, 14100.083494572846, 14161.645958851008, 14190.503332383369, 631.1132858334048, 646.1341801985338, 805.3074356053804, 821.1172989036779, 821.6549049399237, 636.1666217255387, 778.2256654628652, 801.0067516279801, 804.0512195609178, 804.5775967616989, 845.7716416567523, 858.3390789092396, 858.4505916213628, 859.2867919626694, 860.5396113079504, 652.9706163222619, 667.956582822115, 817.284875733733, 849.2314455417857, 855.3841234311286, 620.88203241384, 621.6829416997318, 622.4304761143549, 623.0094150300998, 623.7910300049489, 12832.973362131008, 12961.675958101028, 12978.415971281314, 12982.675433114153, 13005.414756335987, 10891.455427228608, 11163.218574699775, 11303.660890173307, 11399.202055856093, 11782.823257651142, 9439.292053096045, 9648.0, 9649.90350096497, 9748.95125524375, 9791.167750741124, 3234.530993006001, 3253.2842774589553, 3272.067460773692, 3276.6887145721357, 3316.1046517440154, 42157.57842421567, 42262.0, 42635.786821065696, 42679.57320426818, 42689.786551067045, 9372.718818435458, 9437.622495100257, 9460.195883349854, 9465.479398633004, 9530.332876698703, 16469.752953705465, 16490.17549122539, 16494.092824894746, 16495.91752041256, 16528.83471165273, 6158.445739883432, 6193.38066193377, 6275.3724627537795, 6312.179416675803, 6452.483801295885, 3484.0767196692896, 3554.91112722184, 3598.838052287653, 3618.7105031597407, 3625.3293140768515, 2697.8516181609807, 2701.8378897266225, 2706.2422521693957, 2724.209979106037, 2733.945321093567, 501.30819469132365, 508.9440161582223, 509.40654137928897, 510.8544064941474, 513.1148768374524, 514.7014731455821, 553.1122548309985, 600.8557946092906, 603.499095750526, 615.6213928434071, 7396.667149978264, 7426.480146389809, 7439.330460258495, 7620.314171724572, 7683.692652293846, 468.8687167593079, 492.9975350123298, 519.7655568025939, 581.5318668471837, 605.1376788076973, 3707.6663100321102, 3783.138666813187, 3886.3004659161056, 3952.545457272393, 3962.0, 46640.300395494094, 46945.765271173426, 47131.29303060388, 47480.0, 47677.0, 42313.57686423158, 42683.0, 42740.57259427428, 42760.3585946211, 43080.78459607682, 40446.79776601157, 40512.79743601263, 40921.79539102285, 40929.0, 41222.0, 7655.272749088827, 7690.307872291521, 7728.0, 7739.845203095794, 7827.686892524235, 30454.0, 30526.0, 30974.38051239008, 31181.53227701541, 31193.68806311908, 36158.276834463686, 36441.453378199876, 36858.0, 39709.60290397175, 39746.2050758989, 8508.149185081442, 8983.955080224558, 9086.091390860862, 9588.808223835345, 9602.519084348354, 10158.89841101609, 10163.771218079723, 10243.641472548425, 10368.326058806153, 10700.625478108228, 9545.809083818145, 9568.952155239458, 9690.75773105678, 9866.605335786488, 10133.08802207805, 9522.619095236112, 9528.52357382142, 9612.086851749073, 9779.755506112404, 9909.702708918743, 9830.623712680374, 9917.206623469961, 9941.502924853872, 9996.750081248027, 10028.448435336126, 8527.53098579584, 8570.271526920033, 8594.65621375163, 8727.476351418934, 8901.465912045298, 8166.754997350089, 8215.917840821516, 8438.367122465963, 8822.86765698528, 9302.395344302598], "unit": "ms", "name": "yui.html", "value": 5698.05823948683}], "name": "dromaeo_css", "value": 6226.921386207586}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 114.0, 106.0, 112.0, 112.0, 113.0, 102.0, 112.0, 114.0, 119.0], "unit": "ms", "name": "ai-astar", "value": 111.6}, {"lowerIsBetter": true, "replicates": [155.0, 129.0, 152.0, 170.0, 130.0, 152.0, 160.0, 129.0, 179.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.6}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 162.0, 162.0, 163.0, 161.0, 162.0, 162.0, 162.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 90.0, 91.0, 72.0, 78.0, 73.0, 105.0, 97.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 82.3}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 129.0, 94.0, 94.0, 94.0, 136.0, 94.0, 95.0, 129.0], "unit": "ms", "name": "audio-oscillator", "value": 105.3}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 148.0, 146.0, 147.0, 146.0, 147.0, 147.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 72.0, 72.0, 72.0, 71.0, 72.0, 81.0, 71.0, 71.0], "unit": "ms", "name": "json-parse-financial", "value": 72.6}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 67.0, 69.0, 69.0, 69.0, 68.0, 68.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 84.0, 85.0, 83.0, 84.0, 84.0, 86.0, 83.0, 87.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.3}, {"lowerIsBetter": true, "replicates": [131.0, 120.0, 127.0, 119.0, 131.0, 130.0, 129.0, 129.0, 138.0, 121.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 127.5}, {"lowerIsBetter": true, "replicates": [137.0, 154.0, 150.0, 147.0, 139.0, 136.0, 149.0, 149.0, 149.0, 137.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.7}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 70.0, 70.0, 71.0, 72.0, 70.0, 69.0, 71.0, 71.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.5}], "name": "kraken", "value": 1528.9999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.16816218012627], "unit": "score", "name": "Richards", "value": 212.4474360000001}, {"lowerIsBetter": false, "replicates": [186.3238308179616], "unit": "score", "name": "DeltaBlue", "value": 354.85530600000016}, {"lowerIsBetter": false, "replicates": [279.01785714285717], "unit": "score", "name": "Encrypt", "value": 953.9927040000001}, {"lowerIsBetter": false, "replicates": [5138.461538461538], "unit": "score", "name": "Decrypt", "value": 51.80169161676644}, {"lowerIsBetter": false, "replicates": [1978.2608695652175], "unit": "score", "name": "RayTrace", "value": 374.06037362637363}, {"lowerIsBetter": false, "replicates": [793.6507936507936], "unit": "score", "name": "Earley", "value": 839.7433799999998}, {"lowerIsBetter": false, "replicates": [12108.43373493976], "unit": "score", "name": "Boyer", "value": 55.0412228855721}, {"lowerIsBetter": false, "replicates": [27027.027027027027], "unit": "score", "name": "RegExp", "value": 33.70644499999999}, {"lowerIsBetter": false, "replicates": [617.283950617284], "unit": "score", "name": "Splay", "value": 132.01541999999998}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19777.475943756614}]} 04:47:23 INFO - RETURN: dromaeo_css: 6226.92 04:47:23 INFO - RETURN: kraken: 1529.00 04:47:23 INFO - RETURN: v8_7: 19777.48 04:47:23 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19777.48"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1529.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6226.92"}}} 04:47:23 INFO - Return code: 0 04:47:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:47:23 INFO - # TBPL SUCCESS # 04:47:23 INFO - Running post-action listener: _resource_record_post_action 04:47:23 INFO - Running post-run listener: _resource_record_post_run 04:47:25 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 8192; Write bytes: 508284928; Read time: 16; Write time: 474796 04:47:25 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 231612416; Read time: 0; Write time: 313980 04:47:25 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 8192; Write bytes: 276672512; Read time: 16; Write time: 160816 04:47:25 INFO - Running post-run listener: _upload_blobber_files 04:47:25 INFO - Blob upload gear active. 04:47:25 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:47:25 INFO - Copying logs to upload dir... 04:47:25 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1282.906888 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2015-12-04 04:47:24.553661) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-04 04:47:24.556922) ========= 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=ae8083fbfc14dfa356ee9053000001f7-1449230908.547643-1619566471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009952 build_url: 'https://queue.taskcluster.net/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-04 04:47:24.612882) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 04:47:24.613652) ========= 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=ae8083fbfc14dfa356ee9053000001f7-1449230908.547643-1619566471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004559 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 04:47:24.667814) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-04 04:47:24.668503) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-04 04:47:24.669110) ========= ========= Total master_lag: 0.29 =========