builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-011 starttime: 1450227814.82 results: success (0) buildid: 20151215154758 builduid: c42585d50db645b0b1872cae1eb6cfee revision: e6463ae7eda2775bc84593bb4a0742940bb87379 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-15 17:03:34.818696) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-15 17:03:34.819151) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-15 17:03:34.819447) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1450227761.824051-165911479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006386 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-15 17:03:34.849148) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-15 17:03:34.849486) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-15 17:03:34.958775) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 17:03:34.959110) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1450227761.824051-165911479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004576 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 17:03:35.007845) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-15 17:03:35.008434) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-15 17:03:35.008821) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 17:03:35.009103) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1450227761.824051-165911479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-15 17:03:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2015-12-15 17:03:35 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111514 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 17:03:35.135232) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 17:03:35.135552) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1450227761.824051-165911479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015936 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 17:03:35.184643) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 17:03:35.184962) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e6463ae7eda2775bc84593bb4a0742940bb87379 --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 e6463ae7eda2775bc84593bb4a0742940bb87379 --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=76a4ffbc7ba64825c1a171dc000001de-1450227761.824051-165911479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-15 17:03:35,958 truncating revision to first 12 chars 2015-12-15 17:03:35,958 Setting DEBUG logging. 2015-12-15 17:03:35,958 attempt 1/10 2015-12-15 17:03:35,958 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e6463ae7eda2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-15 17:03:36,304 unpacking tar archive at: mozilla-central-e6463ae7eda2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.615427 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 17:03:35.812967) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-15 17:03:35.813294) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-15 17:03:35.820750) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-15 17:03:35.821010) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-15 17:03:35.821383) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-12-15 17:03:35.821727) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=76a4ffbc7ba64825c1a171dc000001de-1450227761.824051-165911479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:03:36 INFO - MultiFileLogger online at 20151215 17:03:36 in /builds/slave/test 17:03:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 17:03:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:03:36 INFO - {'append_to_log': False, 17:03:36 INFO - 'base_work_dir': '/builds/slave/test', 17:03:36 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:03:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:03:36 INFO - 'branch': 'Firefox-Non-PGO', 17:03:36 INFO - 'buildbot_json_path': 'buildprops.json', 17:03:36 INFO - 'config_files': ('talos/linux_config.py',), 17:03:36 INFO - 'default_actions': ('clobber', 17:03:36 INFO - 'read-buildbot-config', 17:03:36 INFO - 'download-and-extract', 17:03:36 INFO - 'populate-webroot', 17:03:36 INFO - 'create-virtualenv', 17:03:36 INFO - 'install', 17:03:36 INFO - 'run-tests'), 17:03:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:03:36 INFO - 'download_minidump_stackwalk': True, 17:03:36 INFO - 'download_symbols': 'ondemand', 17:03:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:03:36 INFO - 'tooltool.py': '/tools/tooltool.py', 17:03:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:03:36 INFO - '/tools/misc-python/virtualenv.py')}, 17:03:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:03:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:03:36 INFO - 'installer_path': 'installer.exe', 17:03:36 INFO - 'log_level': 'info', 17:03:36 INFO - 'log_name': 'talos', 17:03:36 INFO - 'log_to_console': True, 17:03:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:03:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:03:36 INFO - 'opt_config_files': (), 17:03:36 INFO - 'pip_index': False, 17:03:36 INFO - 'sps_profile': False, 17:03:36 INFO - 'sps_profile_interval': 0, 17:03:36 INFO - 'suite': 'dromaeojs-e10s', 17:03:36 INFO - 'system_bits': '64', 17:03:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:03:36 INFO - 'title': 'talos-linux64-ix-011', 17:03:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:03:36 INFO - 'use_talos_json': True, 17:03:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:03:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:03:36 INFO - 'work_dir': 'build'} 17:03:36 INFO - ##### 17:03:36 INFO - ##### Running clobber step. 17:03:36 INFO - ##### 17:03:36 INFO - Running pre-action listener: _resource_record_pre_action 17:03:36 INFO - Running main action method: clobber 17:03:36 INFO - rmtree: /builds/slave/test/build 17:03:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:03:37 INFO - Running post-action listener: _resource_record_post_action 17:03:37 INFO - ##### 17:03:37 INFO - ##### Running read-buildbot-config step. 17:03:37 INFO - ##### 17:03:37 INFO - Running pre-action listener: _resource_record_pre_action 17:03:37 INFO - Running main action method: read_buildbot_config 17:03:37 INFO - Using buildbot properties: 17:03:37 INFO - { 17:03:37 INFO - "properties": { 17:03:37 INFO - "buildnumber": 176, 17:03:37 INFO - "product": "firefox", 17:03:37 INFO - "script_repo_revision": "production", 17:03:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 17:03:37 INFO - "repository": "", 17:03:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 17:03:37 INFO - "buildid": "20151215154758", 17:03:37 INFO - "slavename": "talos-linux64-ix-011", 17:03:37 INFO - "pgo_build": "False", 17:03:37 INFO - "basedir": "/builds/slave/test", 17:03:37 INFO - "project": "", 17:03:37 INFO - "platform": "ubuntu64_hw", 17:03:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:03:37 INFO - "slavebuilddir": "test", 17:03:37 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 17:03:37 INFO - "branch": "mozilla-central", 17:03:37 INFO - "repo_path": "mozilla-central", 17:03:37 INFO - "stage_platform": "linux64", 17:03:37 INFO - "builduid": "c42585d50db645b0b1872cae1eb6cfee", 17:03:37 INFO - "revision": "e6463ae7eda2775bc84593bb4a0742940bb87379" 17:03:37 INFO - }, 17:03:37 INFO - "sourcestamp": { 17:03:37 INFO - "repository": "", 17:03:37 INFO - "hasPatch": false, 17:03:37 INFO - "project": "", 17:03:37 INFO - "branch": "mozilla-central-linux64-talos", 17:03:37 INFO - "changes": [ 17:03:37 INFO - { 17:03:37 INFO - "category": null, 17:03:37 INFO - "files": [ 17:03:37 INFO - { 17:03:37 INFO - "url": null, 17:03:37 INFO - "name": "https://queue.taskcluster.net/v1/task/GtEwwiC0Tzaq4cwea7wUpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 17:03:37 INFO - } 17:03:37 INFO - ], 17:03:37 INFO - "repository": "", 17:03:37 INFO - "rev": "e6463ae7eda2775bc84593bb4a0742940bb87379", 17:03:37 INFO - "who": "kwierso@gmail.com", 17:03:37 INFO - "when": 1450227567, 17:03:37 INFO - "number": 7364150, 17:03:37 INFO - "comments": "Merge inbound to central, a=merge", 17:03:37 INFO - "project": "", 17:03:37 INFO - "at": "Tue 15 Dec 2015 16:59:27", 17:03:37 INFO - "branch": "mozilla-central-linux64-talos", 17:03:37 INFO - "revlink": "", 17:03:37 INFO - "properties": [ 17:03:37 INFO - [ 17:03:37 INFO - "buildid", 17:03:37 INFO - "20151215154758", 17:03:37 INFO - "Change" 17:03:37 INFO - ], 17:03:37 INFO - [ 17:03:37 INFO - "builduid", 17:03:37 INFO - "c42585d50db645b0b1872cae1eb6cfee", 17:03:37 INFO - "Change" 17:03:37 INFO - ], 17:03:37 INFO - [ 17:03:37 INFO - "pgo_build", 17:03:37 INFO - "False", 17:03:37 INFO - "Change" 17:03:37 INFO - ] 17:03:37 INFO - ], 17:03:37 INFO - "revision": "e6463ae7eda2775bc84593bb4a0742940bb87379" 17:03:37 INFO - } 17:03:37 INFO - ], 17:03:37 INFO - "revision": "e6463ae7eda2775bc84593bb4a0742940bb87379" 17:03:37 INFO - } 17:03:37 INFO - } 17:03:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/GtEwwiC0Tzaq4cwea7wUpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 17:03:37 INFO - Running post-action listener: _resource_record_post_action 17:03:37 INFO - ##### 17:03:37 INFO - ##### Running download-and-extract step. 17:03:37 INFO - ##### 17:03:37 INFO - Running pre-action listener: _resource_record_pre_action 17:03:37 INFO - Running main action method: download_and_extract 17:03:37 INFO - mkdir: /builds/slave/test/build/tests 17:03: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')]} 17:03:37 INFO - https://queue.taskcluster.net/v1/task/GtEwwiC0Tzaq4cwea7wUpg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:03:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GtEwwiC0Tzaq4cwea7wUpg/artifacts/public/build/test_packages.json 17:03:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GtEwwiC0Tzaq4cwea7wUpg/artifacts/public/build/test_packages.json 17:03:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GtEwwiC0Tzaq4cwea7wUpg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 17:03:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GtEwwiC0Tzaq4cwea7wUpg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 17:03:37 INFO - Downloaded 1302 bytes. 17:03:37 INFO - Reading from file /builds/slave/test/build/test_packages.json 17:03:37 INFO - Using the following test package requirements: 17:03:37 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:03:37 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:03:37 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:37 INFO - u'jsshell-linux-x86_64.zip'], 17:03:37 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:03:37 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:03:37 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:03:37 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:03:37 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:03:37 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:03:37 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:03:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:03: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')]} 17:03:37 INFO - https://queue.taskcluster.net/v1/task/GtEwwiC0Tzaq4cwea7wUpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:03:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GtEwwiC0Tzaq4cwea7wUpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:03:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GtEwwiC0Tzaq4cwea7wUpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:03:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GtEwwiC0Tzaq4cwea7wUpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:03:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GtEwwiC0Tzaq4cwea7wUpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:03:38 INFO - Downloaded 21863181 bytes. 17:03:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 17:03:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:03:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 17:03:39 INFO - Return code: 0 17:03:39 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:03:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:39 INFO - https://queue.taskcluster.net/v1/task/GtEwwiC0Tzaq4cwea7wUpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:03:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GtEwwiC0Tzaq4cwea7wUpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:03:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GtEwwiC0Tzaq4cwea7wUpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:03:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GtEwwiC0Tzaq4cwea7wUpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:03:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GtEwwiC0Tzaq4cwea7wUpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:03:40 INFO - Downloaded 21863181 bytes. 17:03:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 17:03:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:03:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 17:03:42 INFO - Return code: 0 17:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:42 INFO - https://queue.taskcluster.net/v1/task/GtEwwiC0Tzaq4cwea7wUpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:03:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GtEwwiC0Tzaq4cwea7wUpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:03:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GtEwwiC0Tzaq4cwea7wUpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:03:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GtEwwiC0Tzaq4cwea7wUpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:03:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GtEwwiC0Tzaq4cwea7wUpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:03:42 INFO - Downloaded 11132052 bytes. 17:03:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 17:03:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:03:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 17:03:43 INFO - Return code: 0 17:03: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')]} 17:03:43 INFO - https://queue.taskcluster.net/v1/task/GtEwwiC0Tzaq4cwea7wUpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:03:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GtEwwiC0Tzaq4cwea7wUpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:03:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GtEwwiC0Tzaq4cwea7wUpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:03:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GtEwwiC0Tzaq4cwea7wUpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:03:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GtEwwiC0Tzaq4cwea7wUpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:03:44 INFO - Downloaded 57748175 bytes. 17:03:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GtEwwiC0Tzaq4cwea7wUpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:03:44 INFO - mkdir: /builds/slave/test/properties 17:03:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:03:44 INFO - Writing to file /builds/slave/test/properties/build_url 17:03:44 INFO - Contents: 17:03:44 INFO - build_url:https://queue.taskcluster.net/v1/task/GtEwwiC0Tzaq4cwea7wUpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:03:44 INFO - Running post-action listener: _resource_record_post_action 17:03:44 INFO - Running post-action listener: set_extra_try_arguments 17:03:44 INFO - ##### 17:03:44 INFO - ##### Running populate-webroot step. 17:03:44 INFO - ##### 17:03:44 INFO - Running pre-action listener: _resource_record_pre_action 17:03:44 INFO - Running main action method: populate_webroot 17:03:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:03:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:03:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:03:44 INFO - '--tppagecycles', 17:03:44 INFO - '7'], 17:03:44 INFO - 'tests': ['tsvgm']}}, 17:03:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:03:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:03:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:03:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:03:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:03:44 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:03:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:03:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:03:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:03:44 INFO - 'talos_options': ['--e10s'], 17:03:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:03:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:03:44 INFO - 'tests': ['damp', 'tps']}, 17:03:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:03:44 INFO - 'talos_options': ['--e10s'], 17:03:44 INFO - 'tests': ['damp', 'tps']}, 17:03:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:03:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:03:44 INFO - 'other': {'tests': ['a11yr', 17:03:44 INFO - 'ts_paint', 17:03:44 INFO - 'tpaint', 17:03:44 INFO - 'sessionrestore', 17:03:44 INFO - 'sessionrestore_no_auto_restore']}, 17:03:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:03:44 INFO - 'tests': ['a11yr', 17:03:44 INFO - 'ts_paint', 17:03:44 INFO - 'tpaint', 17:03:44 INFO - 'sessionrestore', 17:03:44 INFO - 'sessionrestore_no_auto_restore']}, 17:03:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:03:44 INFO - 'tests': ['a11yr', 17:03:44 INFO - 'ts_paint', 17:03:44 INFO - 'tpaint', 17:03:44 INFO - 'sessionrestore', 17:03:44 INFO - 'sessionrestore_no_auto_restore']}, 17:03:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:03:44 INFO - 'tests': ['a11yr', 17:03:44 INFO - 'ts_paint', 17:03:44 INFO - 'tpaint', 17:03:44 INFO - 'sessionrestore', 17:03:44 INFO - 'sessionrestore_no_auto_restore']}, 17:03:44 INFO - 'other_l64': {'tests': ['a11yr', 17:03:44 INFO - 'ts_paint', 17:03:44 INFO - 'tpaint', 17:03:44 INFO - 'sessionrestore', 17:03:44 INFO - 'sessionrestore_no_auto_restore']}, 17:03:44 INFO - 'other_nol64': {'tests': ['a11yr', 17:03:44 INFO - 'ts_paint', 17:03:44 INFO - 'tpaint', 17:03:44 INFO - 'sessionrestore', 17:03:44 INFO - 'sessionrestore_no_auto_restore']}, 17:03:44 INFO - 'svgr': {'tests': ['tsvgx', 17:03:44 INFO - 'tsvgr_opacity', 17:03:44 INFO - 'tart', 17:03:44 INFO - 'tscrollx', 17:03:44 INFO - 'cart']}, 17:03:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:03:44 INFO - 'tests': ['tsvgx', 17:03:44 INFO - 'tsvgr_opacity', 17:03:44 INFO - 'tart', 17:03:44 INFO - 'tscrollx', 17:03:44 INFO - 'cart']}, 17:03:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:03:44 INFO - 'tests': ['tp5o']}, 17:03:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:03:44 INFO - 'talos_options': ['--e10s'], 17:03:44 INFO - 'tests': ['tp5o']}, 17:03:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:03:44 INFO - 'talos_options': ['--xperf_path', 17:03:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:03:44 INFO - 'tests': ['tp5n']}, 17:03:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:03:44 INFO - 'talos_options': ['--e10s', 17:03:44 INFO - '--xperf_path', 17:03:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:03:44 INFO - 'tests': ['tp5n']}}, 17:03:44 INFO - 'talos.zip': {'path': '', 17:03:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:03:44 INFO - Running post-action listener: _resource_record_post_action 17:03:44 INFO - ##### 17:03:44 INFO - ##### Running create-virtualenv step. 17:03:44 INFO - ##### 17:03:44 INFO - Running pre-action listener: _resource_record_pre_action 17:03:44 INFO - Running main action method: create_virtualenv 17:03:44 INFO - Creating virtualenv /builds/slave/test/build/venv 17:03:44 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 17:03:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:03:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:03:44 INFO - Using real prefix '/usr' 17:03:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:03:45 INFO - Installing distribute.............................................................................................................................................................................................done. 17:03:46 INFO - Installing pip.................done. 17:03:46 INFO - Return code: 0 17:03:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:03: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')]} 17:03:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03: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')]} 17:03:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:47 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 0x7f4b3b933f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1135240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c40b0>, '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 0x11c4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c5440>, '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': '76a4ffbc7ba64825c1a171dc000001de-1450227761.824051-165911479', '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 17:03:47 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 17:03:47 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 17:03:47 INFO - Using env: {'DISPLAY': ':0', 17:03:47 INFO - 'HOME': '/home/cltbld', 17:03:47 INFO - 'LANG': 'en_US.UTF-8', 17:03:47 INFO - 'LANGUAGE': 'en_US:en', 17:03:47 INFO - 'LOGNAME': 'cltbld', 17:03:47 INFO - 'MAIL': '/var/mail/cltbld', 17:03:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:47 INFO - 'MOZ_NO_REMOTE': '1', 17:03:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:47 INFO - 'NO_EM_RESTART': '1', 17:03:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:47 INFO - 'PWD': '/builds/slave/test', 17:03:47 INFO - 'SHELL': '/bin/bash', 17:03:47 INFO - 'SHLVL': '1', 17:03:47 INFO - 'TERM': 'linux', 17:03:47 INFO - 'TMOUT': '86400', 17:03:47 INFO - 'USER': 'cltbld', 17:03:47 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1450227761.824051-165911479', 17:03:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:47 INFO - '_': '/tools/buildbot/bin/python'} 17:03:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:47 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 17:03:47 INFO - Cleaning up... 17:03:47 INFO - Return code: 0 17:03:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:03:47 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')]} 17:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:47 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')]} 17:03:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:47 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 0x7f4b3b933f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1135240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c40b0>, '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 0x11c4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c5440>, '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': '76a4ffbc7ba64825c1a171dc000001de-1450227761.824051-165911479', '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 17:03:47 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 17:03:47 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 17:03:47 INFO - Using env: {'DISPLAY': ':0', 17:03:47 INFO - 'HOME': '/home/cltbld', 17:03:47 INFO - 'LANG': 'en_US.UTF-8', 17:03:47 INFO - 'LANGUAGE': 'en_US:en', 17:03:47 INFO - 'LOGNAME': 'cltbld', 17:03:47 INFO - 'MAIL': '/var/mail/cltbld', 17:03:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:47 INFO - 'MOZ_NO_REMOTE': '1', 17:03:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:47 INFO - 'NO_EM_RESTART': '1', 17:03:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:47 INFO - 'PWD': '/builds/slave/test', 17:03:47 INFO - 'SHELL': '/bin/bash', 17:03:47 INFO - 'SHLVL': '1', 17:03:47 INFO - 'TERM': 'linux', 17:03:47 INFO - 'TMOUT': '86400', 17:03:47 INFO - 'USER': 'cltbld', 17:03:47 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1450227761.824051-165911479', 17:03:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:47 INFO - '_': '/tools/buildbot/bin/python'} 17:03:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:47 INFO - Downloading/unpacking psutil>=0.7.1 17:03:47 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 17:03:47 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 17:03:47 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 17:03:47 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 17:03:47 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 17:03:47 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 17:03:49 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 17:03:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:03:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:03:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:03:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:03:49 INFO - Installing collected packages: psutil 17:03:49 INFO - Running setup.py install for psutil 17:03:49 INFO - building 'psutil._psutil_linux' extension 17:03:49 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 17:03:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:03:49 INFO - building 'psutil._psutil_posix' extension 17:03:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:03:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:03:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:03:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:03:49 INFO - Successfully installed psutil 17:03:49 INFO - Cleaning up... 17:03:49 INFO - Return code: 0 17:03:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:03:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:49 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 0x7f4b3b933f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1135240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c40b0>, '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 0x11c4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c5440>, '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': '76a4ffbc7ba64825c1a171dc000001de-1450227761.824051-165911479', '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 17:03:49 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 17:03:49 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 17:03:49 INFO - Using env: {'DISPLAY': ':0', 17:03:49 INFO - 'HOME': '/home/cltbld', 17:03:49 INFO - 'LANG': 'en_US.UTF-8', 17:03:49 INFO - 'LANGUAGE': 'en_US:en', 17:03:49 INFO - 'LOGNAME': 'cltbld', 17:03:49 INFO - 'MAIL': '/var/mail/cltbld', 17:03:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:49 INFO - 'MOZ_NO_REMOTE': '1', 17:03:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:49 INFO - 'NO_EM_RESTART': '1', 17:03:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:49 INFO - 'PWD': '/builds/slave/test', 17:03:49 INFO - 'SHELL': '/bin/bash', 17:03:49 INFO - 'SHLVL': '1', 17:03:49 INFO - 'TERM': 'linux', 17:03:49 INFO - 'TMOUT': '86400', 17:03:49 INFO - 'USER': 'cltbld', 17:03:49 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1450227761.824051-165911479', 17:03:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:49 INFO - '_': '/tools/buildbot/bin/python'} 17:03:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:03:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:03:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:03:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:03:51 INFO - Installing collected packages: mozsystemmonitor 17:03:51 INFO - Running setup.py install for mozsystemmonitor 17:03:51 INFO - Successfully installed mozsystemmonitor 17:03:51 INFO - Cleaning up... 17:03:51 INFO - Return code: 0 17:03:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:03:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:51 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 0x7f4b3b933f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1135240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c40b0>, '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 0x11c4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c5440>, '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': '76a4ffbc7ba64825c1a171dc000001de-1450227761.824051-165911479', '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 17:03:51 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 17:03:51 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 17:03:51 INFO - Using env: {'DISPLAY': ':0', 17:03:51 INFO - 'HOME': '/home/cltbld', 17:03:51 INFO - 'LANG': 'en_US.UTF-8', 17:03:51 INFO - 'LANGUAGE': 'en_US:en', 17:03:51 INFO - 'LOGNAME': 'cltbld', 17:03:51 INFO - 'MAIL': '/var/mail/cltbld', 17:03:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:51 INFO - 'MOZ_NO_REMOTE': '1', 17:03:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:51 INFO - 'NO_EM_RESTART': '1', 17:03:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:51 INFO - 'PWD': '/builds/slave/test', 17:03:51 INFO - 'SHELL': '/bin/bash', 17:03:51 INFO - 'SHLVL': '1', 17:03:51 INFO - 'TERM': 'linux', 17:03:51 INFO - 'TMOUT': '86400', 17:03:51 INFO - 'USER': 'cltbld', 17:03:51 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1450227761.824051-165911479', 17:03:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:51 INFO - '_': '/tools/buildbot/bin/python'} 17:03:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:52 INFO - Downloading/unpacking blobuploader==1.2.4 17:03:52 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 17:03:52 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 17:03:52 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 17:03:52 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 17:03:52 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 17:03:52 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 17:03:53 INFO - Downloading blobuploader-1.2.4.tar.gz 17:03:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:03:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:03:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:03:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:03:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:54 INFO - Downloading docopt-0.6.1.tar.gz 17:03:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:03:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:03:54 INFO - Installing collected packages: blobuploader, requests, docopt 17:03:54 INFO - Running setup.py install for blobuploader 17:03:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:03:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:03:54 INFO - Running setup.py install for requests 17:03:54 INFO - Running setup.py install for docopt 17:03:55 INFO - Successfully installed blobuploader requests docopt 17:03:55 INFO - Cleaning up... 17:03:55 INFO - Return code: 0 17:03:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:03:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:55 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 0x7f4b3b933f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1135240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c40b0>, '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 0x11c4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c5440>, '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': '76a4ffbc7ba64825c1a171dc000001de-1450227761.824051-165911479', '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 17:03:55 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 17:03:55 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 17:03:55 INFO - Using env: {'DISPLAY': ':0', 17:03:55 INFO - 'HOME': '/home/cltbld', 17:03:55 INFO - 'LANG': 'en_US.UTF-8', 17:03:55 INFO - 'LANGUAGE': 'en_US:en', 17:03:55 INFO - 'LOGNAME': 'cltbld', 17:03:55 INFO - 'MAIL': '/var/mail/cltbld', 17:03:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:55 INFO - 'MOZ_NO_REMOTE': '1', 17:03:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:55 INFO - 'NO_EM_RESTART': '1', 17:03:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:55 INFO - 'PWD': '/builds/slave/test', 17:03:55 INFO - 'SHELL': '/bin/bash', 17:03:55 INFO - 'SHLVL': '1', 17:03:55 INFO - 'TERM': 'linux', 17:03:55 INFO - 'TMOUT': '86400', 17:03:55 INFO - 'USER': 'cltbld', 17:03:55 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1450227761.824051-165911479', 17:03:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:55 INFO - '_': '/tools/buildbot/bin/python'} 17:03:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:03:55 INFO - Running setup.py (path:/tmp/pip-fRYCLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:03:55 INFO - Running setup.py (path:/tmp/pip-NnKXZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:03:55 INFO - Running setup.py (path:/tmp/pip-3OyK5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:03:55 INFO - Running setup.py (path:/tmp/pip-UPC1WC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:03:55 INFO - Running setup.py (path:/tmp/pip-9wIqrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:03:55 INFO - Running setup.py (path:/tmp/pip-qUzHik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:03:55 INFO - Running setup.py (path:/tmp/pip-hEduFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:03:55 INFO - Running setup.py (path:/tmp/pip-5Z0hv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:03:55 INFO - Running setup.py (path:/tmp/pip-G6ezOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:03:55 INFO - Running setup.py (path:/tmp/pip-VsQnnX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:03:55 INFO - Running setup.py (path:/tmp/pip-hfCzMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:03:56 INFO - Running setup.py (path:/tmp/pip-lxBIBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:03:56 INFO - Running setup.py (path:/tmp/pip-G4Mk1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:03:56 INFO - Running setup.py (path:/tmp/pip-z0zeBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:03:56 INFO - Running setup.py (path:/tmp/pip-fmw_iE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:03:56 INFO - Running setup.py (path:/tmp/pip-nvadFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:03:56 INFO - Running setup.py (path:/tmp/pip-a2ZYmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:03:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:03:56 INFO - Running setup.py install for manifestparser 17:03:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:03:56 INFO - Running setup.py install for mozcrash 17:03:56 INFO - Running setup.py install for mozdebug 17:03:56 INFO - Running setup.py install for mozdevice 17:03:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:03:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:03:56 INFO - Running setup.py install for mozfile 17:03:56 INFO - Running setup.py install for mozhttpd 17:03:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:03:57 INFO - Running setup.py install for mozinfo 17:03:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:03:57 INFO - Running setup.py install for mozInstall 17:03:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:03:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:03:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:03:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:03:57 INFO - Running setup.py install for mozleak 17:03:57 INFO - Running setup.py install for mozlog 17:03:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:03:57 INFO - Running setup.py install for moznetwork 17:03:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:03:57 INFO - Running setup.py install for mozprocess 17:03:57 INFO - Running setup.py install for mozprofile 17:03:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:03:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:03:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:03:57 INFO - Running setup.py install for mozrunner 17:03:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:03:57 INFO - Running setup.py install for mozscreenshot 17:03:58 INFO - Running setup.py install for moztest 17:03:58 INFO - Running setup.py install for mozversion 17:03:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:03:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:03:58 INFO - Cleaning up... 17:03:58 INFO - Return code: 0 17:03:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:03:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f4b3b933f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1135240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c40b0>, '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 0x11c4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c5440>, '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': '76a4ffbc7ba64825c1a171dc000001de-1450227761.824051-165911479', '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 17:03:58 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 17:03:58 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 17:03:58 INFO - Using env: {'DISPLAY': ':0', 17:03:58 INFO - 'HOME': '/home/cltbld', 17:03:58 INFO - 'LANG': 'en_US.UTF-8', 17:03:58 INFO - 'LANGUAGE': 'en_US:en', 17:03:58 INFO - 'LOGNAME': 'cltbld', 17:03:58 INFO - 'MAIL': '/var/mail/cltbld', 17:03:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:58 INFO - 'MOZ_NO_REMOTE': '1', 17:03:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:58 INFO - 'NO_EM_RESTART': '1', 17:03:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:58 INFO - 'PWD': '/builds/slave/test', 17:03:58 INFO - 'SHELL': '/bin/bash', 17:03:58 INFO - 'SHLVL': '1', 17:03:58 INFO - 'TERM': 'linux', 17:03:58 INFO - 'TMOUT': '86400', 17:03:58 INFO - 'USER': 'cltbld', 17:03:58 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1450227761.824051-165911479', 17:03:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:58 INFO - '_': '/tools/buildbot/bin/python'} 17:03:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:03:58 INFO - Running setup.py (path:/tmp/pip-lQ5zmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:03:58 INFO - Running setup.py (path:/tmp/pip-thvym6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:03:58 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)) 17:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:03:58 INFO - Running setup.py (path:/tmp/pip-EYrhHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:03:58 INFO - Running setup.py (path:/tmp/pip-hAJMs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:03:58 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)) 17:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:03:58 INFO - Running setup.py (path:/tmp/pip-Z99qVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:03:58 INFO - Running setup.py (path:/tmp/pip-5vlHff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:03:58 INFO - Running setup.py (path:/tmp/pip-ZEjyL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:03:58 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)) 17:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:03:58 INFO - Running setup.py (path:/tmp/pip-12yj0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:03:59 INFO - Running setup.py (path:/tmp/pip-0zqaMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:03:59 INFO - Running setup.py (path:/tmp/pip-ijBWz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:03:59 INFO - Running setup.py (path:/tmp/pip-JN2WdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:03:59 INFO - Running setup.py (path:/tmp/pip-MoMcL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:03:59 INFO - Running setup.py (path:/tmp/pip-MLVTJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:03:59 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)) 17:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:03:59 INFO - Running setup.py (path:/tmp/pip-vM0ff9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:03:59 INFO - Running setup.py (path:/tmp/pip-cNmst_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:03:59 INFO - Running setup.py (path:/tmp/pip-U6J7Wg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:03:59 INFO - Running setup.py (path:/tmp/pip-X7uKuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:03:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:03:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:01 INFO - Downloading blessings-1.5.1.tar.gz 17:04:01 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 17:04:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:04:01 INFO - Installing collected packages: blessings 17:04:01 INFO - Running setup.py install for blessings 17:04:01 INFO - Successfully installed blessings 17:04:01 INFO - Cleaning up... 17:04:01 INFO - Return code: 0 17:04:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:04:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:04:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:04:02 INFO - Reading from file tmpfile_stdout 17:04:02 INFO - Current package versions: 17:04:02 INFO - argparse == 1.2.1 17:04:02 INFO - blessings == 1.5.1 17:04:02 INFO - blobuploader == 1.2.4 17:04:02 INFO - docopt == 0.6.1 17:04:02 INFO - manifestparser == 1.1 17:04:02 INFO - mozInstall == 1.12 17:04:02 INFO - mozcrash == 0.16 17:04:02 INFO - mozdebug == 0.1 17:04:02 INFO - mozdevice == 0.47 17:04:02 INFO - mozfile == 1.2 17:04:02 INFO - mozhttpd == 0.7 17:04:02 INFO - mozinfo == 0.9 17:04:02 INFO - mozleak == 0.1 17:04:02 INFO - mozlog == 3.1 17:04:02 INFO - moznetwork == 0.27 17:04:02 INFO - mozprocess == 0.22 17:04:02 INFO - mozprofile == 0.27 17:04:02 INFO - mozrunner == 6.11 17:04:02 INFO - mozscreenshot == 0.1 17:04:02 INFO - mozsystemmonitor == 0.0 17:04:02 INFO - moztest == 0.7 17:04:02 INFO - mozversion == 1.4 17:04:02 INFO - psutil == 3.1.1 17:04:02 INFO - requests == 1.2.3 17:04:02 INFO - wsgiref == 0.1.2 17:04:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:04: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')]} 17:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04: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')]} 17:04:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:02 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 0x7f4b3b933f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1135240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c40b0>, '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 0x11c4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c5440>, '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': '76a4ffbc7ba64825c1a171dc000001de-1450227761.824051-165911479', '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 17:04:02 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 17:04:02 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 17:04:02 INFO - Using env: {'DISPLAY': ':0', 17:04:02 INFO - 'HOME': '/home/cltbld', 17:04:02 INFO - 'LANG': 'en_US.UTF-8', 17:04:02 INFO - 'LANGUAGE': 'en_US:en', 17:04:02 INFO - 'LOGNAME': 'cltbld', 17:04:02 INFO - 'MAIL': '/var/mail/cltbld', 17:04:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:02 INFO - 'MOZ_NO_REMOTE': '1', 17:04:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:02 INFO - 'NO_EM_RESTART': '1', 17:04:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:02 INFO - 'PWD': '/builds/slave/test', 17:04:02 INFO - 'SHELL': '/bin/bash', 17:04:02 INFO - 'SHLVL': '1', 17:04:02 INFO - 'TERM': 'linux', 17:04:02 INFO - 'TMOUT': '86400', 17:04:02 INFO - 'USER': 'cltbld', 17:04:02 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1450227761.824051-165911479', 17:04:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:02 INFO - '_': '/tools/buildbot/bin/python'} 17:04:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:04:02 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)) 17:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:04:02 INFO - Cleaning up... 17:04:02 INFO - Return code: 0 17:04:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:04: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')]} 17:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04: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')]} 17:04:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:02 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 0x7f4b3b933f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1135240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c40b0>, '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 0x11c4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c5440>, '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': '76a4ffbc7ba64825c1a171dc000001de-1450227761.824051-165911479', '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 17:04:02 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 17:04:02 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 17:04:02 INFO - Using env: {'DISPLAY': ':0', 17:04:02 INFO - 'HOME': '/home/cltbld', 17:04:02 INFO - 'LANG': 'en_US.UTF-8', 17:04:02 INFO - 'LANGUAGE': 'en_US:en', 17:04:02 INFO - 'LOGNAME': 'cltbld', 17:04:02 INFO - 'MAIL': '/var/mail/cltbld', 17:04:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:02 INFO - 'MOZ_NO_REMOTE': '1', 17:04:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:02 INFO - 'NO_EM_RESTART': '1', 17:04:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:02 INFO - 'PWD': '/builds/slave/test', 17:04:02 INFO - 'SHELL': '/bin/bash', 17:04:02 INFO - 'SHLVL': '1', 17:04:02 INFO - 'TERM': 'linux', 17:04:02 INFO - 'TMOUT': '86400', 17:04:02 INFO - 'USER': 'cltbld', 17:04:02 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1450227761.824051-165911479', 17:04:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:02 INFO - '_': '/tools/buildbot/bin/python'} 17:04:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:02 INFO - Downloading/unpacking jsonschema 17:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:04:04 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 17:04:04 INFO - Downloading/unpacking functools32 (from jsonschema) 17:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:04 INFO - Downloading functools32-3.2.3-2.tar.gz 17:04:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 17:04:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:04:04 INFO - warning: no files found matching '*.txt' 17:04:04 INFO - no previously-included directories found matching 'build' 17:04:04 INFO - no previously-included directories found matching 'dist' 17:04:04 INFO - no previously-included directories found matching '.git*' 17:04:04 INFO - Installing collected packages: jsonschema, functools32 17:04:04 INFO - Running setup.py install for functools32 17:04:04 INFO - warning: no files found matching '*.txt' 17:04:04 INFO - no previously-included directories found matching 'build' 17:04:04 INFO - no previously-included directories found matching 'dist' 17:04:04 INFO - no previously-included directories found matching '.git*' 17:04:04 INFO - Successfully installed jsonschema functools32 17:04:04 INFO - Cleaning up... 17:04:04 INFO - Return code: 0 17:04:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:04: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')]} 17:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04: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')]} 17:04:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4b3b933f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1135240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c40b0>, '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 0x11c4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c5440>, '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': '76a4ffbc7ba64825c1a171dc000001de-1450227761.824051-165911479', '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 17:04:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:04:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:04:04 INFO - Using env: {'DISPLAY': ':0', 17:04:04 INFO - 'HOME': '/home/cltbld', 17:04:04 INFO - 'LANG': 'en_US.UTF-8', 17:04:04 INFO - 'LANGUAGE': 'en_US:en', 17:04:04 INFO - 'LOGNAME': 'cltbld', 17:04:04 INFO - 'MAIL': '/var/mail/cltbld', 17:04:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:04 INFO - 'MOZ_NO_REMOTE': '1', 17:04:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:04 INFO - 'NO_EM_RESTART': '1', 17:04:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:04 INFO - 'PWD': '/builds/slave/test', 17:04:04 INFO - 'SHELL': '/bin/bash', 17:04:04 INFO - 'SHLVL': '1', 17:04:04 INFO - 'TERM': 'linux', 17:04:04 INFO - 'TMOUT': '86400', 17:04:04 INFO - 'USER': 'cltbld', 17:04:04 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1450227761.824051-165911479', 17:04:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:04 INFO - '_': '/tools/buildbot/bin/python'} 17:04:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:04 INFO - Downloading/unpacking flake8 17:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:04:06 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 17:04:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:04:06 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 17:04:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:06 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 17:04:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 17:04:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:04:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:04:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:04:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:04:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:04:07 INFO - no previously-included directories found matching 'docs/_build' 17:04:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:04:07 INFO - Running setup.py install for pep8 17:04:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:04:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:04:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:04:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:04:07 INFO - no previously-included directories found matching 'docs/_build' 17:04:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:04:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:04:07 INFO - Cleaning up... 17:04:07 INFO - Return code: 0 17:04:07 INFO - Running post-action listener: _resource_record_post_action 17:04:07 INFO - Running post-action listener: _start_resource_monitoring 17:04:07 INFO - Starting resource monitoring. 17:04:07 INFO - ##### 17:04:07 INFO - ##### Running install step. 17:04:07 INFO - ##### 17:04:07 INFO - Running pre-action listener: _resource_record_pre_action 17:04:07 INFO - Running main action method: install 17:04:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:04:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:04:07 INFO - Reading from file tmpfile_stdout 17:04:07 INFO - Detecting whether we're running mozinstall >=1.0... 17:04:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:04:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:04:07 INFO - Reading from file tmpfile_stdout 17:04:07 INFO - Output received: 17:04:07 INFO - Usage: mozinstall [options] installer 17:04:07 INFO - Options: 17:04:07 INFO - -h, --help show this help message and exit 17:04:07 INFO - -d DEST, --destination=DEST 17:04:07 INFO - Directory to install application into. [default: 17:04:07 INFO - "/builds/slave/test"] 17:04:07 INFO - --app=APP Application being installed. [default: firefox] 17:04:07 INFO - mkdir: /builds/slave/test/build/application 17:04:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:04:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:04:22 INFO - Reading from file tmpfile_stdout 17:04:22 INFO - Output received: 17:04:22 INFO - /builds/slave/test/build/application/firefox/firefox 17:04:22 INFO - Running post-action listener: _resource_record_post_action 17:04:22 INFO - ##### 17:04:22 INFO - ##### Running run-tests step. 17:04:22 INFO - ##### 17:04:22 INFO - Running pre-action listener: _resource_record_pre_action 17:04:22 INFO - Running main action method: run_tests 17:04:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:04:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:04:22 INFO - Python 2.7.3 17:04:22 INFO - Return code: 0 17:04:22 INFO - grabbing minidump binary from tooltool 17:04:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:22 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 0x11c40b0>, '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 0x11c4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c5440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:04:22 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 17:04:22 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 17:04:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:04:22 INFO - Return code: 0 17:04:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:04:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:04:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:04:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:04:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:04:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:04:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:04:23 INFO - Return code: 0 17:04:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GtEwwiC0Tzaq4cwea7wUpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost'] in /builds/slave/test/build 17:04:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GtEwwiC0Tzaq4cwea7wUpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost 17:04:23 INFO - Using env: {'DISPLAY': ':0', 17:04:23 INFO - 'HOME': '/home/cltbld', 17:04:23 INFO - 'LANG': 'en_US.UTF-8', 17:04:23 INFO - 'LANGUAGE': 'en_US:en', 17:04:23 INFO - 'LOGNAME': 'cltbld', 17:04:23 INFO - 'MAIL': '/var/mail/cltbld', 17:04:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:04:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:04:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:23 INFO - 'MOZ_NO_REMOTE': '1', 17:04:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:04:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:23 INFO - 'NO_EM_RESTART': '1', 17:04:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:23 INFO - 'PWD': '/builds/slave/test', 17:04:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:04:23 INFO - 'SHELL': '/bin/bash', 17:04:23 INFO - 'SHLVL': '1', 17:04:23 INFO - 'TERM': 'linux', 17:04:23 INFO - 'TMOUT': '86400', 17:04:23 INFO - 'USER': 'cltbld', 17:04:23 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1450227761.824051-165911479', 17:04:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:23 INFO - '_': '/tools/buildbot/bin/python'} 17:04:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GtEwwiC0Tzaq4cwea7wUpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost'] with output_timeout 3600 17:04:23 INFO - mozversion INFO | application_buildid: 20151215154758 17:04:23 INFO - mozversion INFO | application_changeset: e6463ae7eda2775bc84593bb4a0742940bb87379 17:04:23 INFO - mozversion INFO | application_display_name: Nightly 17:04:23 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:04:23 INFO - mozversion INFO | application_name: Firefox 17:04:23 INFO - mozversion INFO | application_remotingname: firefox 17:04:23 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 17:04:23 INFO - mozversion INFO | application_vendor: Mozilla 17:04:23 INFO - mozversion INFO | application_version: 46.0a1 17:04:23 INFO - mozversion INFO | platform_buildid: 20151215154758 17:04:23 INFO - mozversion INFO | platform_changeset: e6463ae7eda2775bc84593bb4a0742940bb87379 17:04:23 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 17:04:23 INFO - mozversion INFO | platform_version: 46.0a1 17:04:23 INFO - 2015-12-15 17:04:23,477 DEBUG : using testdate: 1450227863 17:04:23 INFO - 2015-12-15 17:04:23,477 DEBUG : actual date: 1450227863 17:04:23 INFO - 2015-12-15 17:04:23,485 INFO : starting webserver on 'localhost:39460' 17:04:23 INFO - 2015-12-15 17:04:23,486 INFO : Starting test suite talos-linux64-ix-011.e 17:04:23 INFO - 2015-12-15 17:04:23,486 INFO : Starting test dromaeo_css 17:04:23 INFO - 2015-12-15 17:04:23,486 DEBUG : operating with platform_type : linux_ 17:04:23 INFO - 2015-12-15 17:04:23,487 INFO : Initialising browser for dromaeo_css test... 17:04:23 INFO - 2015-12-15 17:04:23,503 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9Rw85I/profile http://localhost:39460/getInfo.html 17:04:28 INFO - 2015-12-15 17:04:28,535 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:04:28 INFO - 2015-12-15 17:04:28,536 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:04:28 INFO - 2015-12-15 17:04:28,536 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:04:28 INFO - 2015-12-15 17:04:28,536 DEBUG : BROWSER_OUTPUT: __metrics 17:04:28 INFO - 2015-12-15 17:04:28,692 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] 17:04:29 INFO - 2015-12-15 17:04:29,604 INFO : Browser initialized. 17:04:29 INFO - 2015-12-15 17:04:29,605 INFO : Running cycle 1/1 for dromaeo_css test... 17:04:29 INFO - 2015-12-15 17:04:29,605 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9Rw85I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:04:41 INFO - 2015-12-15 17:04:41,677 DEBUG : BROWSER_OUTPUT: RSS: Main: 142839808 17:04:41 INFO - 2015-12-15 17:04:41,677 DEBUG : BROWSER_OUTPUT: 17:05:31 INFO - 2015-12-15 17:05:31,305 DEBUG : BROWSER_OUTPUT: 1450227931304 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] 17:07:42 INFO - 2015-12-15 17:07:42,558 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39460/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39460/tests/dromaeo/cssquery-ext.html) 17:07:43 INFO - 2015-12-15 17:07:43,744 DEBUG : BROWSER_OUTPUT: RSS: Main: 146837504 17:07:43 INFO - 2015-12-15 17:07:43,744 DEBUG : BROWSER_OUTPUT: 17:10:45 INFO - 2015-12-15 17:10:45,879 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39460/tests/dromaeo/cssquery-ext.html (next: http://localhost:39460/tests/dromaeo/cssquery-jquery.html) 17:10:46 INFO - 2015-12-15 17:10:46,473 DEBUG : BROWSER_OUTPUT: RSS: Main: 146710528 17:10:46 INFO - 2015-12-15 17:10:46,473 DEBUG : BROWSER_OUTPUT: 17:13:48 INFO - 2015-12-15 17:13:48,244 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39460/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39460/tests/dromaeo/cssquery-mootools.html) 17:13:48 INFO - 2015-12-15 17:13:48,837 DEBUG : BROWSER_OUTPUT: RSS: Main: 144580608 17:13:48 INFO - 2015-12-15 17:13:48,837 DEBUG : BROWSER_OUTPUT: 17:16:50 INFO - 2015-12-15 17:16:50,563 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39460/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39460/tests/dromaeo/cssquery-prototype.html) 17:16:51 INFO - 2015-12-15 17:16:51,196 DEBUG : BROWSER_OUTPUT: RSS: Main: 143847424 17:16:51 INFO - 2015-12-15 17:16:51,197 DEBUG : BROWSER_OUTPUT: 17:19:53 INFO - 2015-12-15 17:19:53,787 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39460/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39460/tests/dromaeo/cssquery-yui.html) 17:19:54 INFO - 2015-12-15 17:19:54,414 DEBUG : BROWSER_OUTPUT: RSS: Main: 144793600 17:19:54 INFO - 2015-12-15 17:19:54,414 DEBUG : BROWSER_OUTPUT: 17:22:56 INFO - 2015-12-15 17:22:56,581 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39460/tests/dromaeo/cssquery-yui.html (next: http://localhost:39460/tests/dromaeo/cssquery-dojo.html) 17:22:56 INFO - 2015-12-15 17:22:56,831 DEBUG : BROWSER_OUTPUT: RSS: Main: 146792448 17:22:56 INFO - 2015-12-15 17:22:56,831 DEBUG : BROWSER_OUTPUT: 17:22:56 INFO - 2015-12-15 17:22:56,831 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:22:56 INFO - 2015-12-15 17:22:56,831 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:22:56 INFO - 2015-12-15 17:22:56,832 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:22:56 INFO - 2015-12-15 17:22:56,832 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:22:56 INFO - 2015-12-15 17:22:56,835 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2692.2865440658225;2738.137486691691;2771.265614612128;2785.345443820702;2791.204506715586;4645.233536466488;4752.405949256343;4754.738489383082;4796.592289655379;4797;4708.529147085298;4717.198076327024;4721.12659158056;4724.126036683216;4737.076270127326;4408.823647054114;4411.360352748849;4422.800973956164;4567.680262381618;4569.223232050543;4494;4530.343100250462;4570.794314255866;4578.381918441001;4608.976955115219;88.10805421798135;4463;4465.68740188187;4568.428946381702;4601.286800545904;4577.473590537097;4583.220852455091;4588.220002599566;4592.357070010168;4621.630269578425;4553.704009239389;4564.178447879381;4569.543045695404;4581.839635612738;4606.884827879297;4591.931121033187;4616.422947131608;4633.953660463386;4709.835155769531;4901.607871370317;5177.844664660066;5210.348706411699;5219.243209734605;5227;5243.79024839006;5229.816956406546;5266.420693723688;5275.261463395128;5277.7361131943635;5336.493033161843;4617.30740388941;4756.5243475652505;4762.523747625279;4762.880927976828;4862.586680132193;5265.131253343156;5268.209768534751;5367.516923476827;5435.592330575223;5484.2047903053835;5216.765245563959;5225.372955245395;5226.5818734501145;5230.555402790806;5235.9266350398075;4970.776315065831;5303.496167864047;5309.442508536626;5361.061814182581;5395.865103372447;5041.117804384218;5046.44489106198;5086.440491545927;5091.821786237464;5169.121249387613;5154.149565321755;5207.505286997729;5211.400688920747;5216.400113986864;5272.209168624737;4123.525794533667;4228.534861165269;4317.201317756162;4365.781710914505;4377.212101821639;3673.504076949631;3758.774473531597;3768.9246215075545;3773.1699026214187;3789.696824254053;4485.147821913891;4508.504064552896;4511.8646440606835;4520.796564154621;4565.178267911808;4983.775730092155;5095.337606111182;5172.5344718975475;5287.365516138088;5322.627416080914;4463.642908567307;4496.527864574238;4511.571400716993;4535.909281814345;4537.523560026149;4600.5169457207185;4620.676552641283;4622.583967442946;4623.029163875623;4658.743769092733;4748.382710247714;4788.760561971957;4863.537963893425;4918.040982008617;4970.403551573834;5192.091384007859;5197.480251974772;5199.532042116228;5203.063448579292;5214.791408343775;4893.486183950634;4911.754412279443;4918.729469879047;4919.409670839522;4961.578265847299;4921.384826896638;5017.247412888096;5043.218301163325;5158.6131040171385;5200.63595548308;5214.2960700304975;5222.921656175236;5228.790848366023;5229.529342359206;5230.2677625131755;4801.639877009308;5038.420581633159;5043.36957880265;5046.545810877039;5054.494550544916;4936.3829521309835;4952.925706114339;4970.577500912463;4974.9751251243515;4979.327790748347;4898.044881248265;4914.70511769295;4937.086638971802;4976.253561965734;5008.449070602303;5082.313887625123;5100.132977393926;5120.846374608767;5127.564157046693;5164.302819119371;4757.904841903073;4854.927176092432;4926.236433352836;5015.749212539431;5018.297438358706 17:22:56 INFO - 2015-12-15 17:22:56,835 DEBUG : BROWSER_OUTPUT: |1;ext.html;559.4964531921272;559.6026820957122;570.067938919866;572.4361503918642;576.4581293584031;35002.474962875574;35820.28359432813;35896.64103358966;36032.279354412894;36187;40572;41385.172296554054;41407.58592414075;41431.58568414315;41477.37783933243;7964.999999999985;8164.510129392226;8171.019477662689;8175.79560510986;8190.262876341158;7967.561784101872;7990.041195056601;8033.598320083973;8059.234372734581;8080.232377924117;7988.081370642392;8079.151689072651;8087.110417854032;8124.715634952778;8131.430799844014;7941.96029019857;7990.720324788634;8051.315638170762;8061.838763224761;8074.0311162660855;7966.601669916481;8074.555899425529;8105.351571874236;8107.391945604103;8123.390745694038;37811.05472363185;38161;38273;38316;38405.423918641245;2595.2344058502786;3037.8329191894436;3126.796758210709;3136.5452009458727;3213.7107660310685;26449.867750661124;26517.867410663017;26571.73428265712;26716.198514044416;26724.599131013052;3475.2180759329203;3557.8932632021083;3586.336527742376;3610.0433385152955;3633.2006958469096;214718;217059.99999999843;217124;217210;217429;47721;49087.26369104466;56391.43608563862;56763.71618141883;56837.43162568404;68220;69174.3082569178;69211.65394172996;69546.304536955;69689.65155174192;15292.235388230767;15425.460108896359;15534.223288835514;15564.066156030674;15567.377304907903;10822.24244302907;10825.56697732082;10836.945815270874;10848;10871;19840.90079549593;19973.300934467225;20030.799692003184;20141.39575812728;20149.697754533692;7410.777676669709;7659.655315510815;7749.922500775033;7756.573388463576;7772.611369431505;787.4920676163842;812.0308252487694;899.5322432335149;900.5905757489508;997.6458357283205;25887.870560647076;26422.339441514116;26908;26908.461830763667;26954.32614184661;938.648006997376;949.5015117063597;973.8587904753913;992.9851052234222;1000.5797565022708;13998.370073346723;14201.431942722382;14256.85743142576;15298.388064477296;16348.182590870409;306405.7437702467;309644;310114;311363;314680;49930.50069499259;50198.749006255464;50372.244416333786;50667.493325067015;50672.74663626658;1183.7573297473998;1204.6085022367765;1214.441356975801;1216.1183142221996;1220.4568966809684;27843.303917402227;27919.72080279171;28242.576361355008;28394.432111357244;28519.28701782472;41670.37494437525;41834.79082604689;41976.1604767909;42152.36771448369;42155.3676694856;248107;250234;250907;251689;254328;30018.549721753756;42310;43605.34591981059;44161.33757993697;44200.55799442093;38858.80570597129;39024.609753903234;39195.41206881956;39759.60240397559;40111.79944100261;33081;34010.82994585011;34255;34541.91187771805;34698.13254668654;33789.262153254036;33927.66072339344;34225.14437139092;34438.655613443545;34569.65430345664;33344.833275833465;33426.83286583552;33491.4976275361;33821.83089084539;33891;30457.238569035064;30520.389592208474;30955.845220774652;31095;31177.37645247037;24057.353691094315;24068.27795166148;24121.879390602935;24213.665266407148;24362 17:22:56 INFO - 2015-12-15 17:22:56,839 DEBUG : BROWSER_OUTPUT: |2;jquery.html;328.9029736227814;333.95491608632835;334.8309103902529;335.2289733612692;335.2774770369854;14886.330115144818;15318.540443786676;16072.357105715757;16072.357105715786;16751.748723769124;9924.45415502147;10101.090901818834;10158.49207539622;10172.847407288897;10317.742056448593;4552.658550608709;4618.237990731525;4669.6731228814;4685.461171965234;4689.437267527885;4496.7751612419415;4665.580097791198;4669.743164125972;4672.766361681919;4687.578117969382;3225.532297816815;3377.0881861897274;4651.62786977041;4660.464046634646;5158.871028224287;5268.341457317835;5290.444503327172;5298.523132918037;5307.1243244864745;5308.309919710432;5017.197248440269;5112.054269960069;5112.696262453088;5115.974420127913;5163.66436181647;11413.714657133554;11432.485538150802;11843.88156118445;11983.760324793542;12113.33376664283;1829.0763164601924;1895.3745264062964;1896.753422055138;2019.7273368095266;2061.917523299066;9032;9137.81724365509;9268.351215414923;10687.465626718633;13071.54249601269;1752.8860624059396;1779.9288028478975;1831.2400353853136;1835.6053448508635;1839.190756067326;53432.46567534314;55417.44582554163;56963.43036569623;57227.14159287573;57776.71111644457;9595.808083838285;9903.950480247697;9904.55429505674;9921.206303495703;9994.450305233137;12290.508379664714;12395.75208495825;12467;12476.563320283927;12490.81263781044;7222.277772222841;7323.194448610649;7329.303716146957;7364.447666424932;7408.222136675679;7004.544704594185;7012.5792452453015;7052.612106334201;7082.645867706594;7100.183478899889;4092.6316631502714;4123.340265557496;4152.5432202457705;4166.229247589205;4237.343211802176;1671.7659527666137;1679.3114822922544;1703.233544904773;1710.4783041172313;1723.284836792717;378.5835580861086;380.5368358660944;392.04536952520704;803.61426515273;824.8474032304043;9749.610015599439;10203.336783109222;10204.997755499056;10479.738006549745;10597.364158150536;404.45398711739506;824.1223097401248;837.7361131243639;873.1966590736538;880.903100658927;8769.254613357809;8885.42244754089;9043.412178208395;9061.275097992146;9183.219426348702;312566;312674;314267.42866285524;315936;469307;69761.65119174372;73302;75601;76100.23899761042;76137.61931190308;1059.6979860739498;1066.195022757813;1069.4652673663168;1095.118429664128;1104.1442881766695;14739.705205896036;14882.776758348416;14955.401783928955;15056.924715376354;15191.924040379727;33031.17422064468;33674.66325336813;33791.324173516885;34068.318633627685;34568;45553;45567.77216113898;45843.3123503141;46437;47904;8745.693900713444;8789.956050219707;9003.54982250898;9016.684416045407;9043.18611324984;10273.126784223425;10330.121939634915;10399.064084232456;10501.369917804956;15770;13217.339133043502;13859;14028.08817426864;14300.427982880985;14311.284435777961;13084.28036458004;13846.169229846242;13929.860701392856;14122.717545648824;14527.201003944885;14654.633634158805;14660.266986650839;14782.408703651734;14912.627184320045;15227.238638068275;8876.245519130687;8918.420302680304;9011.279097672039;9087.227585655293;9130.269578433843;12386.194897331645;13918.09532380392;14007.929960350133;14348.06737562055;14393.496227631982 17:22:56 INFO - 2015-12-15 17:22:56,839 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1480.9481668141618;1600.7278762610358;1652.3142895698286;1677.5973766296092;1679.3954176496468;6257.874842503147;6415.06981487684;7359.227281135477;7596.582187979659;7613.390928725703;6913.481488888341;7215.855682886352;7218;7259.927400725991;7276.672549735262;2094.32981445937;2138.112683236455;2139.7967193116706;2141.9464513387134;2143.217725530178;2115.7672656007826;2151.967720484186;2187.0814258011674;2203.272919936417;2207.4481379655085;2082.739657542807;2104.8105670489654;2119.470132466883;2122.5330427306044;2126.2133010786033;2094.235604004535;2119.4383488375593;2120.226117467121;2120.416885356524;2125.1393185759794;2074.66805311151;2098.6956891250834;2101.4746313421647;2116.809487146149;2123.193186589086;7115.252898445692;7185.856282874365;7192.172900116449;7200.063991681101;7250.4562157837845;4189.832406703728;4228.513720922103;4229.111886503838;4233;4252.596003379674;2683.3559945613106;2729.331313828105;2768.44631073784;2788.121741651373;2792.539231026878;817.464560712734;824.9546274954876;826.5784449930519;828.2628460670009;858.1032820702319;9426.057394260588;9427.434353938717;9495.24038076959;9497.715068547956;9510.38182518134;3891.2412079644764;3907.7264591478324;3953.9802300988313;3967.8809635710977;3970.285348637215;8131.430799844073;8187.5087494750505;8194.467359621605;8197.508149511048;8215.260626543639;4290.120525292307;4297.247981603207;4311.676624253194;4316.69783115179;4325.740455572675;3345.347657206821;3418.9658103418647;3855.2289542091694;3918.8432462701744;3930.941035884464;3371.3088816792497;3424.8972530823617;3444.2422667013216;3447.9310413792086;3470.514128022079;1061.4056128568027;1071.8017166824163;1072.780080083581;1077.876044254905;1095.1676725688376;963.0658261486348;973.3138137612966;979.1090108001827;1033.8397548380012;1195.3365881935608;6981;7000.229974702778;7007;7036.683349249296;7077.646117694095;376.10674647711687;377.136357740776;383.35596198386423;383.8157684311546;384.0092561192118;5363.517283444431;5386.326709161355;5395.81114660985;5415.404305526389;5485.424030476823;8591.226789588967;8948.194662480408;8977.730668079968;9031.36780425364;9045;8808.03111657717;8809.03100658927;8825.646974120964;8868;8929.10708929102;6852.417544508772;6988.986596943415;7020.262872398324;7061.258567850302;7077.3984211341585;6634.303398143125;6637.568558043712;6660.966695166493;6677.432418244503;6718.193816742022;7733.342665873463;7950.801229969297;7991.760247192594;8090.150534193825;8125.837483250184;8055.436119471581;8181.059178194346;8181.959090204511;8231.506109633441;8298.502089874626;6419.871602568016;6459.289478157493;6470.320616335405;6473.741050357933;6506.284308726131;7102.218755936946;7153.678084486107;7170.1754298256365;7172.892406614009;7186.1376634804155;6521.967390163209;6526.804195874131;6636.303188165366;6648.5346025777735;6780.982852572153;6618.834529136618;6695.665216739046;6708.127943367331;6749;6756.986452032234;6842.315768423118;6868.107146071178;6878.037074809631;6895.862082758417;6913.5506192097355;5963.254593175853;6037.215162028908;6117.755289788359;6141.973148860776;6153.569250152446;6402.071699603438;6429.067785171031;6430.871382572229;6431.517636177399;6455.806325810233 17:22:56 INFO - 2015-12-15 17:22:56,839 DEBUG : BROWSER_OUTPUT: |4;prototype.html;286.5114978960871;295.970402959704;302.4601087059599;309.75065072616536;311.3135536142804;5600.18797274395;5625;5633.408492108326;5645.237892884465;5789.218455508505;5577.498025177733;5615.354234263061;5631.380548139701;5656.802011929573;5662;4159.313713237312;4320.848770293041;4337.501187363462;4342.565743425664;4343.174796788616;4249.405083288342;4295.055087880662;4301.333293339538;4312.784360781964;4326.870193894189;4254.851080212193;4260.595243451882;4276.935845962313;4284.571542845706;4286.442762440878;4257.8296868125235;4260.573942605745;4269.957300427002;4281.743095414286;4285.035866929916;3720.683741881943;3721.0325315417917;3727.4408838674144;3729.440583912408;3730.0488375464356;5200.141976573861;5259.921101183485;5269.209618557209;5322.9620224056325;5452.154915988028;4910;4911.993041426535;4915.410150781893;4919.7540122993705;4935.876603084952;5924.555658325643;5924.881502369928;5935.139404786281;5940.584159108864;5953.553483488756;3853.094522787143;4018.457508236409;4020.075382662004;4027.617376349242;4046.150308435232;6135.601185922901;6195.2255968004;6214.223222097238;6216.844578885519;6218.440340369389;4096.91806163875;4108.137291168829;4108.815103320358;4117.608827161415;4120.443740095108;4151.169766046803;4171.5828417158045;4172;4176.4570605821655;4180.707350485498;4511.413516242867;4823.782929768169;4831.202851529529;4833;4841.661083724176;5698.430156984268;5730.426957304237;5878.617889837147;5881.647101173943;5888.381719919433;1449.0725935401351;1487.1746180869504;1487.605784467117;1489.7616381379144;1491.142593009024;968.3366893677853;978.188103873783;992.5831150916632;997.1972562087444;999.5701848205196;5127.87180320495;5160.329157209539;5160.612954028463;5178.689278643294;5187.19598462239;6181.320054793969;6185.195924529782;6186.412290832453;6188.2883468400805;6193.876122477615;5147.948520514747;5148.021875843578;5156.020356132323;5158.174692049329;5158.535731784157;3258.918527036843;3289.111939776247;3292.456744637108;3324.6675332467044;3337.816420096918;5776.220210271644;5777.075667893117;5779.393163717749;5793.768249270066;5796.913046304308;6289.0880822280515;6291.842703932438;6313.084602732578;6338.271098823694;6340.904886426707;5622.381538030813;5762.193292938992;5769.1923130761725;5779.450952159622;5784.50831679312;6138.416850399205;6142.355052719578;6147.262328520606;6148.292946311231;6171.506279497539;5939.020061689773;5969.820905372846;5975.223220981245;5987.161797348288;5993.340732519507;5740.827775166752;5770.682612456355;5771.018926782541;5775.595708300547;5777.422257774189;4071.2671719089662;4178.080822219107;4179.4357761701785;4194.853180138681;4198.412222288943;6007.279126504673;6104.786332478342;6142.262928448615;6149.540183926465;6207.348228435949;5903.173555702119;5933.762649493972;5948.940510595012;5956.821295361146;5961;5878.500327472213;5902.5277977762535;5924.081767326072;5929.229200203946;5938.970305148447;5703.458171473703;5802.970985145047;5810.273715785527;5832.50423713989;5839.328477225174;5958.970205148947;5980.850478738066;5981.700914954322;5986.730597123053;6031.969840150771;5832.825015249549;5834.38738932423;5835.649861008353;5836.095405212199;5837.591368604157 17:22:56 INFO - 2015-12-15 17:22:56,840 DEBUG : BROWSER_OUTPUT: |5;yui.html;682.2631557917447;731.6378392695616;768.1051574915224;786.7089177004507;809.518336589729;12045.09661775366;12331.691707707312;12334.44494997725;12347.382630868455;12370.752584948295;10841.6747497575;11464.31214127153;11917.28496290221;12026.278423294609;12084.274943503397;791.2048391366683;804.1556365815899;807.6607824713634;807.8424707182102;808.3937047214589;789.6249281591256;790.5217343507181;797.4457751862458;797.7247849491916;797.7327595255597;825.9669613215464;826.6197549127379;829.4567058576612;833.0586437325844;833.9958300208491;826.7189155687065;827.4828232354778;828.8549503836834;832.5088197963231;833.0669649991987;613.9263288405375;615.5691016288616;617.0281806155278;617.2808677890297;617.9443850053472;11064.557417703281;11275.323480591109;11280.548778048867;11308.491117899632;11312.547498100066;9344.205742511895;9721.902780972241;10034.89965100347;10065.849012264822;10125.696229113139;8745;8754.255888249443;8878.156575125353;9031.819363612756;9132.178103970675;3155.2269693924904;3181.220600952758;3189.6650851660474;3268.983655081733;3291.341731653679;34430.48354274688;34537.654623453695;37142;42448.787756061334;42605.360919585924;9523.857142142873;9868.561314089357;9968.601255949827;10108.494575271206;10118;16771.91614041922;16832.074235916898;16836.24236909342;16895.746563801553;16966.23651935666;6417.294097649255;6459.257185423642;6535.117759102555;6554.967225163844;6682.532222744361;3664.926701465956;3692.9815350923072;3694.8891533254045;3714.3871261241593;3728.086618778417;2661.4544018476167;2682.0746842339363;2701.338172147797;2702.513547561458;2710.9593356099676;466.24468361254986;471.5355374955666;473.76548608438355;476.82595852513583;478.34705626819834;478.3996084913481;488.4139033160151;503.3230305239447;555.3197333266716;617.9556549431446;7586.317231449196;8020.157883422274;8143.470674406145;8147.633356498854;8224.845597668875;526.2264471227289;618.9319174890759;621.142822904389;638.8434833465831;642.958207716497;3535.840887160084;3644.5079914211774;3742.6900584795103;3744;3777;49609;50168.49831501711;50198.498015020115;50278.24582631263;50395.24407133896;44314.556854431044;44316.55683443189;44827;44858.63560232995;45679;38083.61916380856;39506.20987580232;39779;39932.600673992885;40562.79718601447;8103.756887293391;8315.95842020786;8536.487810731376;8643.092475290005;8705.34709896773;30832.845835770677;30990.22524436907;31482.842585786926;31573.684263157073;31608.525872111477;36136.27727445489;36428;36677.63322366742;39100.41349379819;39648.80175599104;9639.228861690908;9673.70978870635;10069.69790906274;10180;10373.688789336333;11272.590926134233;11306.387225548902;11404.771904562029;11450.713732156762;11712.063034957353;10767.192460565646;10784.406857622906;10784.622538211124;10805.51375188134;10873.401962891801;10772;10853.45732713377;10866.130709543375;10872.347659140476;10886.401247931122;10576.576936922436;10708.625198118028;10713.303635263683;10744;10832.945835270773;9515.751754342364;9631.518424078628;9690.176335011603;9721;9845.803083938137;9247.12152345526;9281.48951807657;9341.486218257789;9403.106704863027;9617.038296170327 17:22:56 INFO - 2015-12-15 17:22:56,840 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:22:56 INFO - 2015-12-15 17:22:56,840 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:22:56 INFO - 2015-12-15 17:22:56,840 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,330 17:22:56 INFO - 2015-12-15 17:22:56,840 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:22:56 INFO - 2015-12-15 17:22:56,840 DEBUG : BROWSER_OUTPUT: __startTimestamp1450228976831__endTimestamp 17:22:56 INFO - 2015-12-15 17:22:56,841 DEBUG : BROWSER_OUTPUT: 17:22:56 INFO - 2015-12-15 17:22:56,841 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:22:56 INFO - 2015-12-15 17:22:56,841 DEBUG : BROWSER_OUTPUT: Number of tests: 6 17:22:56 INFO - 2015-12-15 17:22:56,841 DEBUG : BROWSER_OUTPUT: 17:22:56 INFO - 2015-12-15 17:22:56,841 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4764.62 Median:4911.75 stddev:623.75 (12.7%) stddev-sans-first:604.11 17:22:56 INFO - 2015-12-15 17:22:56,841 DEBUG : BROWSER_OUTPUT: Values: 2692.3 2738.1 2771.3 2785.3 2791.2 4645.2 4752.4 4754.7 4796.6 4797.0 4708.5 4717.2 4721.1 4724.1 4737.1 4408.8 4411.4 4422.8 4567.7 4569.2 4494.0 4530.3 4570.8 4578.4 4609.0 88.1 4463.0 4465.7 4568.4 4601.3 4577.5 4583.2 4588.2 4592.4 4621.6 4553.7 4564.2 4569.5 4581.8 4606.9 4591.9 4616.4 4634.0 4709.8 4901.6 5177.8 5210.3 5219.2 5227.0 5243.8 5229.8 5266.4 5275.3 5277.7 5336.5 4617.3 4756.5 4762.5 4762.9 4862.6 5265.1 5268.2 5367.5 5435.6 5484.2 5216.8 5225.4 5226.6 5230.6 5235.9 4970.8 5303.5 5309.4 5361.1 5395.9 5041.1 5046.4 5086.4 5091.8 5169.1 5154.1 5207.5 5211.4 5216.4 5272.2 4123.5 4228.5 4317.2 4365.8 4377.2 3673.5 3758.8 3768.9 3773.2 3789.7 4485.1 4508.5 4511.9 4520.8 4565.2 4983.8 5095.3 5172.5 5287.4 5322.6 4463.6 4496.5 4511.6 4535.9 4537.5 4600.5 4620.7 4622.6 4623.0 4658.7 4748.4 4788.8 4863.5 4918.0 4970.4 5192.1 5197.5 5199.5 5203.1 5214.8 4893.5 4911.8 4918.7 4919.4 4961.6 4921.4 5017.2 5043.2 5158.6 5200.6 5214.3 5222.9 5228.8 5229.5 5230.3 4801.6 5038.4 5043.4 5046.5 5054.5 4936.4 4952.9 4970.6 4975.0 4979.3 4898.0 4914.7 4937.1 4976.3 5008.4 5082.3 5100.1 5120.8 5127.6 5164.3 4757.9 4854.9 4926.2 5015.7 5018.3 17:22:56 INFO - 2015-12-15 17:22:56,841 DEBUG : BROWSER_OUTPUT: 17:22:56 INFO - 2015-12-15 17:22:56,841 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42951.21 Median:19703.31 stddev:68543.91 (347.9%) stddev-sans-first:68662.29 17:22:56 INFO - 2015-12-15 17:22:56,841 DEBUG : BROWSER_OUTPUT: Values: 559.5 559.6 570.1 572.4 576.5 35002.5 35820.3 35896.6 36032.3 36187.0 40572.0 41385.2 41407.6 41431.6 41477.4 7965.0 8164.5 8171.0 8175.8 8190.3 7967.6 7990.0 8033.6 8059.2 8080.2 7988.1 8079.2 8087.1 8124.7 8131.4 7942.0 7990.7 8051.3 8061.8 8074.0 7966.6 8074.6 8105.4 8107.4 8123.4 37811.1 38161.0 38273.0 38316.0 38405.4 2595.2 3037.8 3126.8 3136.5 3213.7 26449.9 26517.9 26571.7 26716.2 26724.6 3475.2 3557.9 3586.3 3610.0 3633.2 214718.0 217060.0 217124.0 217210.0 217429.0 47721.0 49087.3 56391.4 56763.7 56837.4 68220.0 69174.3 69211.7 69546.3 69689.7 15292.2 15425.5 15534.2 15564.1 15567.4 10822.2 10825.6 10836.9 10848.0 10871.0 19840.9 19973.3 20030.8 20141.4 20149.7 7410.8 7659.7 7749.9 7756.6 7772.6 787.5 812.0 899.5 900.6 997.6 25887.9 26422.3 26908.0 26908.5 26954.3 938.6 949.5 973.9 993.0 1000.6 13998.4 14201.4 14256.9 15298.4 16348.2 306405.7 309644.0 310114.0 311363.0 314680.0 49930.5 50198.7 50372.2 50667.5 50672.7 1183.8 1204.6 1214.4 1216.1 1220.5 27843.3 27919.7 28242.6 28394.4 28519.3 41670.4 41834.8 41976.2 42152.4 42155.4 248107.0 250234.0 250907.0 251689.0 254328.0 30018.5 42310.0 43605.3 44161.3 44200.6 38858.8 39024.6 39195.4 39759.6 40111.8 33081.0 34010.8 34255.0 34541.9 34698.1 33789.3 33927.7 34225.1 34438.7 34569.7 33344.8 33426.8 33491.5 33821.8 33891.0 30457.2 30520.4 30955.8 31095.0 31177.4 24057.4 24068.3 24121.9 24213.7 24362.0 17:22:56 INFO - 2015-12-15 17:22:56,841 DEBUG : BROWSER_OUTPUT: 17:22:56 INFO - 2015-12-15 17:22:56,841 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22119.82 Median:17473.29 stddev:57847.83 (331.1%) stddev-sans-first:57986.97 17:22:56 INFO - 2015-12-15 17:22:56,842 DEBUG : BROWSER_OUTPUT: Values: 328.9 334.0 334.8 335.2 335.3 14886.3 15318.5 16072.4 16072.4 16751.7 9924.5 10101.1 10158.5 10172.8 10317.7 4552.7 4618.2 4669.7 4685.5 4689.4 4496.8 4665.6 4669.7 4672.8 4687.6 3225.5 3377.1 4651.6 4660.5 5158.9 5268.3 5290.4 5298.5 5307.1 5308.3 5017.2 5112.1 5112.7 5116.0 5163.7 11413.7 11432.5 11843.9 11983.8 12113.3 1829.1 1895.4 1896.8 2019.7 2061.9 9032.0 9137.8 9268.4 10687.5 13071.5 1752.9 1779.9 1831.2 1835.6 1839.2 53432.5 55417.4 56963.4 57227.1 57776.7 9595.8 9904.0 9904.6 9921.2 9994.5 12290.5 12395.8 12467.0 12476.6 12490.8 7222.3 7323.2 7329.3 7364.4 7408.2 7004.5 7012.6 7052.6 7082.6 7100.2 4092.6 4123.3 4152.5 4166.2 4237.3 1671.8 1679.3 1703.2 1710.5 1723.3 378.6 380.5 392.0 803.6 824.8 9749.6 10203.3 10205.0 10479.7 10597.4 404.5 824.1 837.7 873.2 880.9 8769.3 8885.4 9043.4 9061.3 9183.2 312566.0 312674.0 314267.4 315936.0 469307.0 69761.7 73302.0 75601.0 76100.2 76137.6 1059.7 1066.2 1069.5 1095.1 1104.1 14739.7 14882.8 14955.4 15056.9 15191.9 33031.2 33674.7 33791.3 34068.3 34568.0 45553.0 45567.8 45843.3 46437.0 47904.0 8745.7 8790.0 9003.5 9016.7 9043.2 10273.1 10330.1 10399.1 10501.4 15770.0 13217.3 13859.0 14028.1 14300.4 14311.3 13084.3 13846.2 13929.9 14122.7 14527.2 14654.6 14660.3 14782.4 14912.6 15227.2 8876.2 8918.4 9011.3 9087.2 9130.3 12386.2 13918.1 14007.9 14348.1 14393.5 17:22:56 INFO - 2015-12-15 17:22:56,843 DEBUG : BROWSER_OUTPUT: 17:22:56 INFO - 2015-12-15 17:22:56,843 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5093.48 Median:6464.81 stddev:2681.60 (41.5%) stddev-sans-first:2675.38 17:22:56 INFO - 2015-12-15 17:22:56,843 DEBUG : BROWSER_OUTPUT: Values: 1480.9 1600.7 1652.3 1677.6 1679.4 6257.9 6415.1 7359.2 7596.6 7613.4 6913.5 7215.9 7218.0 7259.9 7276.7 2094.3 2138.1 2139.8 2141.9 2143.2 2115.8 2152.0 2187.1 2203.3 2207.4 2082.7 2104.8 2119.5 2122.5 2126.2 2094.2 2119.4 2120.2 2120.4 2125.1 2074.7 2098.7 2101.5 2116.8 2123.2 7115.3 7185.9 7192.2 7200.1 7250.5 4189.8 4228.5 4229.1 4233.0 4252.6 2683.4 2729.3 2768.4 2788.1 2792.5 817.5 825.0 826.6 828.3 858.1 9426.1 9427.4 9495.2 9497.7 9510.4 3891.2 3907.7 3954.0 3967.9 3970.3 8131.4 8187.5 8194.5 8197.5 8215.3 4290.1 4297.2 4311.7 4316.7 4325.7 3345.3 3419.0 3855.2 3918.8 3930.9 3371.3 3424.9 3444.2 3447.9 3470.5 1061.4 1071.8 1072.8 1077.9 1095.2 963.1 973.3 979.1 1033.8 1195.3 6981.0 7000.2 7007.0 7036.7 7077.6 376.1 377.1 383.4 383.8 384.0 5363.5 5386.3 5395.8 5415.4 5485.4 8591.2 8948.2 8977.7 9031.4 9045.0 8808.0 8809.0 8825.6 8868.0 8929.1 6852.4 6989.0 7020.3 7061.3 7077.4 6634.3 6637.6 6661.0 6677.4 6718.2 7733.3 7950.8 7991.8 8090.2 8125.8 8055.4 8181.1 8182.0 8231.5 8298.5 6419.9 6459.3 6470.3 6473.7 6506.3 7102.2 7153.7 7170.2 7172.9 7186.1 6522.0 6526.8 6636.3 6648.5 6781.0 6618.8 6695.7 6708.1 6749.0 6757.0 6842.3 6868.1 6878.0 6895.9 6913.6 5963.3 6037.2 6117.8 6142.0 6153.6 6402.1 6429.1 6430.9 6431.5 6455.8 17:22:56 INFO - 2015-12-15 17:22:56,843 DEBUG : BROWSER_OUTPUT: 17:22:56 INFO - 2015-12-15 17:22:56,843 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4873.12 Median:5632.39 stddev:1459.45 (25.9%) stddev-sans-first:1422.36 17:22:56 INFO - 2015-12-15 17:22:56,843 DEBUG : BROWSER_OUTPUT: Values: 286.5 296.0 302.5 309.8 311.3 5600.2 5625.0 5633.4 5645.2 5789.2 5577.5 5615.4 5631.4 5656.8 5662.0 4159.3 4320.8 4337.5 4342.6 4343.2 4249.4 4295.1 4301.3 4312.8 4326.9 4254.9 4260.6 4276.9 4284.6 4286.4 4257.8 4260.6 4270.0 4281.7 4285.0 3720.7 3721.0 3727.4 3729.4 3730.0 5200.1 5259.9 5269.2 5323.0 5452.2 4910.0 4912.0 4915.4 4919.8 4935.9 5924.6 5924.9 5935.1 5940.6 5953.6 3853.1 4018.5 4020.1 4027.6 4046.2 6135.6 6195.2 6214.2 6216.8 6218.4 4096.9 4108.1 4108.8 4117.6 4120.4 4151.2 4171.6 4172.0 4176.5 4180.7 4511.4 4823.8 4831.2 4833.0 4841.7 5698.4 5730.4 5878.6 5881.6 5888.4 1449.1 1487.2 1487.6 1489.8 1491.1 968.3 978.2 992.6 997.2 999.6 5127.9 5160.3 5160.6 5178.7 5187.2 6181.3 6185.2 6186.4 6188.3 6193.9 5147.9 5148.0 5156.0 5158.2 5158.5 3258.9 3289.1 3292.5 3324.7 3337.8 5776.2 5777.1 5779.4 5793.8 5796.9 6289.1 6291.8 6313.1 6338.3 6340.9 5622.4 5762.2 5769.2 5779.5 5784.5 6138.4 6142.4 6147.3 6148.3 6171.5 5939.0 5969.8 5975.2 5987.2 5993.3 5740.8 5770.7 5771.0 5775.6 5777.4 4071.3 4178.1 4179.4 4194.9 4198.4 6007.3 6104.8 6142.3 6149.5 6207.3 5903.2 5933.8 5948.9 5956.8 5961.0 5878.5 5902.5 5924.1 5929.2 5939.0 5703.5 5803.0 5810.3 5832.5 5839.3 5959.0 5980.9 5981.7 5986.7 6032.0 5832.8 5834.4 5835.6 5836.1 5837.6 17:22:56 INFO - 2015-12-15 17:22:56,843 DEBUG : BROWSER_OUTPUT: 17:22:56 INFO - 2015-12-15 17:22:56,843 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12160.38 Median:44842.82 stddev:13574.35 (30.3%) stddev-sans-first:13585.06 17:22:56 INFO - 2015-12-15 17:22:56,844 DEBUG : BROWSER_OUTPUT: Values: 682.3 731.6 768.1 786.7 809.5 12045.1 12331.7 12334.4 12347.4 12370.8 10841.7 11464.3 11917.3 12026.3 12084.3 791.2 804.2 807.7 807.8 808.4 789.6 790.5 797.4 797.7 797.7 826.0 826.6 829.5 833.1 834.0 826.7 827.5 828.9 832.5 833.1 613.9 615.6 617.0 617.3 617.9 11064.6 11275.3 11280.5 11308.5 11312.5 9344.2 9721.9 10034.9 10065.8 10125.7 8745.0 8754.3 8878.2 9031.8 9132.2 3155.2 3181.2 3189.7 3269.0 3291.3 34430.5 34537.7 37142.0 42448.8 42605.4 9523.9 9868.6 9968.6 10108.5 10118.0 16771.9 16832.1 16836.2 16895.7 16966.2 6417.3 6459.3 6535.1 6555.0 6682.5 3664.9 3693.0 3694.9 3714.4 3728.1 2661.5 2682.1 2701.3 2702.5 2711.0 466.2 471.5 473.8 476.8 478.3 478.4 488.4 503.3 555.3 618.0 7586.3 8020.2 8143.5 8147.6 8224.8 526.2 618.9 621.1 638.8 643.0 3535.8 3644.5 3742.7 3744.0 3777.0 49609.0 50168.5 50198.5 50278.2 50395.2 44314.6 44316.6 44827.0 44858.6 45679.0 38083.6 39506.2 39779.0 39932.6 40562.8 8103.8 8316.0 8536.5 8643.1 8705.3 30832.8 30990.2 31482.8 31573.7 31608.5 36136.3 36428.0 36677.6 39100.4 39648.8 9639.2 9673.7 10069.7 10180.0 10373.7 11272.6 11306.4 11404.8 11450.7 11712.1 10767.2 10784.4 10784.6 10805.5 10873.4 10772.0 10853.5 10866.1 10872.3 10886.4 10576.6 10708.6 10713.3 10744.0 10832.9 9515.8 9631.5 9690.2 9721.0 9845.8 9247.1 9281.5 9341.5 9403.1 9617.0 17:22:56 INFO - 2015-12-15 17:22:56,844 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:22:56 INFO - 2015-12-15 17:22:56,844 DEBUG : BROWSER_OUTPUT: 17:22:57 INFO - 2015-12-15 17:22:57,584 INFO : Browser exited with error code: 0 17:22:57 INFO - 2015-12-15 17:22:57,601 INFO : Completed test dromaeo_css (00:18:34) 17:22:57 INFO - 2015-12-15 17:22:57,601 INFO : Starting test kraken 17:22:57 INFO - 2015-12-15 17:22:57,601 DEBUG : operating with platform_type : linux_ 17:22:57 INFO - 2015-12-15 17:22:57,601 INFO : Initialising browser for kraken test... 17:22:57 INFO - 2015-12-15 17:22:57,607 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcClwDT/profile http://localhost:39460/getInfo.html 17:23:02 INFO - 2015-12-15 17:23:02,244 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:23:02 INFO - 2015-12-15 17:23:02,244 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:23:02 INFO - 2015-12-15 17:23:02,245 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:23:02 INFO - 2015-12-15 17:23:02,245 DEBUG : BROWSER_OUTPUT: __metrics 17:23:02 INFO - 2015-12-15 17:23:02,447 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] 17:23:03 INFO - 2015-12-15 17:23:03,280 INFO : Browser initialized. 17:23:03 INFO - 2015-12-15 17:23:03,281 INFO : Running cycle 1/1 for kraken test... 17:23:03 INFO - 2015-12-15 17:23:03,281 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcClwDT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:23:15 INFO - 2015-12-15 17:23:15,289 DEBUG : BROWSER_OUTPUT: RSS: Main: 142921728 17:23:15 INFO - 2015-12-15 17:23:15,289 DEBUG : BROWSER_OUTPUT: 17:23:17 INFO - 2015-12-15 17:23:17,864 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39460/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39460/tests/kraken/driver.html?testName=audio-beat-detection) 17:23:18 INFO - 2015-12-15 17:23:18,486 DEBUG : BROWSER_OUTPUT: RSS: Main: 141774848 17:23:18 INFO - 2015-12-15 17:23:18,486 DEBUG : BROWSER_OUTPUT: 17:23:21 INFO - 2015-12-15 17:23:21,211 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39460/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39460/tests/kraken/driver.html?testName=audio-dft) 17:23:21 INFO - 2015-12-15 17:23:21,813 DEBUG : BROWSER_OUTPUT: RSS: Main: 141795328 17:23:21 INFO - 2015-12-15 17:23:21,813 DEBUG : BROWSER_OUTPUT: 17:23:24 INFO - 2015-12-15 17:23:24,704 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39460/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39460/tests/kraken/driver.html?testName=audio-fft) 17:23:25 INFO - 2015-12-15 17:23:25,291 DEBUG : BROWSER_OUTPUT: RSS: Main: 137961472 17:23:25 INFO - 2015-12-15 17:23:25,291 DEBUG : BROWSER_OUTPUT: 17:23:27 INFO - 2015-12-15 17:23:27,425 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39460/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39460/tests/kraken/driver.html?testName=audio-oscillator) 17:23:28 INFO - 2015-12-15 17:23:28,012 DEBUG : BROWSER_OUTPUT: RSS: Main: 137711616 17:23:28 INFO - 2015-12-15 17:23:28,012 DEBUG : BROWSER_OUTPUT: 17:23:30 INFO - 2015-12-15 17:23:30,285 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39460/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39460/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:23:30 INFO - 2015-12-15 17:23:30,867 DEBUG : BROWSER_OUTPUT: RSS: Main: 139784192 17:23:30 INFO - 2015-12-15 17:23:30,867 DEBUG : BROWSER_OUTPUT: 17:23:33 INFO - 2015-12-15 17:23:33,909 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39460/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39460/tests/kraken/driver.html?testName=imaging-darkroom) 17:23:34 INFO - 2015-12-15 17:23:34,511 DEBUG : BROWSER_OUTPUT: RSS: Main: 140759040 17:23:34 INFO - 2015-12-15 17:23:34,511 DEBUG : BROWSER_OUTPUT: 17:23:37 INFO - 2015-12-15 17:23:37,973 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39460/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39460/tests/kraken/driver.html?testName=imaging-desaturate) 17:23:38 INFO - 2015-12-15 17:23:38,566 DEBUG : BROWSER_OUTPUT: RSS: Main: 138395648 17:23:38 INFO - 2015-12-15 17:23:38,566 DEBUG : BROWSER_OUTPUT: 17:23:41 INFO - 2015-12-15 17:23:41,445 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39460/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39460/tests/kraken/driver.html?testName=json-parse-financial) 17:23:42 INFO - 2015-12-15 17:23:42,039 DEBUG : BROWSER_OUTPUT: RSS: Main: 140001280 17:23:42 INFO - 2015-12-15 17:23:42,039 DEBUG : BROWSER_OUTPUT: 17:23:43 INFO - 2015-12-15 17:23:43,788 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39460/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39460/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:23:44 INFO - 2015-12-15 17:23:44,375 DEBUG : BROWSER_OUTPUT: RSS: Main: 140701696 17:23:44 INFO - 2015-12-15 17:23:44,376 DEBUG : BROWSER_OUTPUT: 17:23:46 INFO - 2015-12-15 17:23:46,267 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39460/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39460/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:23:46 INFO - 2015-12-15 17:23:46,880 DEBUG : BROWSER_OUTPUT: RSS: Main: 139862016 17:23:46 INFO - 2015-12-15 17:23:46,880 DEBUG : BROWSER_OUTPUT: 17:23:49 INFO - 2015-12-15 17:23:49,085 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39460/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39460/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:23:49 INFO - 2015-12-15 17:23:49,672 DEBUG : BROWSER_OUTPUT: RSS: Main: 140525568 17:23:49 INFO - 2015-12-15 17:23:49,672 DEBUG : BROWSER_OUTPUT: 17:23:52 INFO - 2015-12-15 17:23:52,269 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39460/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39460/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:23:52 INFO - 2015-12-15 17:23:52,870 DEBUG : BROWSER_OUTPUT: RSS: Main: 140877824 17:23:52 INFO - 2015-12-15 17:23:52,871 DEBUG : BROWSER_OUTPUT: 17:23:55 INFO - 2015-12-15 17:23:55,518 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39460/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39460/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:23:56 INFO - 2015-12-15 17:23:56,119 DEBUG : BROWSER_OUTPUT: RSS: Main: 141705216 17:23:56 INFO - 2015-12-15 17:23:56,120 DEBUG : BROWSER_OUTPUT: 17:23:57 INFO - 2015-12-15 17:23:57,909 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39460/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39460/tests/kraken/driver.html?testName=ai-astar) 17:23:58 INFO - 2015-12-15 17:23:58,155 DEBUG : BROWSER_OUTPUT: RSS: Main: 140722176 17:23:58 INFO - 2015-12-15 17:23:58,155 DEBUG : BROWSER_OUTPUT: 17:23:58 INFO - 2015-12-15 17:23:58,156 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:23:58 INFO - 2015-12-15 17:23:58,156 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:23:58 INFO - 2015-12-15 17:23:58,157 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:23:58 INFO - 2015-12-15 17:23:58,157 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:23:58 INFO - 2015-12-15 17:23:58,157 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;108;112;113;114;124;114;114;114;114 17:23:58 INFO - 2015-12-15 17:23:58,157 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;131;169;165;130;154;156;137;169;136 17:23:58 INFO - 2015-12-15 17:23:58,158 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;163;162;162;161;164;168;166;164;163 17:23:58 INFO - 2015-12-15 17:23:58,158 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;73;72;75;142;77;79;74;72 17:23:58 INFO - 2015-12-15 17:23:58,158 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;137;94;95;95;133;94;95;131 17:23:58 INFO - 2015-12-15 17:23:58,159 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;111;110;110;110;109;110;110;110 17:23:58 INFO - 2015-12-15 17:23:58,159 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;148;147;148;148;148;149;146;147;147 17:23:58 INFO - 2015-12-15 17:23:58,159 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;97;98;96;96;96;96;96;96;101 17:23:58 INFO - 2015-12-15 17:23:58,159 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;72;71;73;72;72;73;72;72;71 17:23:58 INFO - 2015-12-15 17:23:58,160 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;68;68;70;69;69;69;69;70 17:23:58 INFO - 2015-12-15 17:23:58,160 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;85;95;83;84;86;83;84;84;95 17:23:58 INFO - 2015-12-15 17:23:58,160 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;130;123;130;126;129;123;120;124;132 17:23:58 INFO - 2015-12-15 17:23:58,160 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;152;151;154;148;154;145;149;162;149;142 17:23:58 INFO - 2015-12-15 17:23:58,161 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;73;69;71;71;69;77;71;69;69 17:23:58 INFO - 2015-12-15 17:23:58,161 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:23:58 INFO - 2015-12-15 17:23:58,161 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:23:58 INFO - 2015-12-15 17:23:58,161 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,792 17:23:58 INFO - 2015-12-15 17:23:58,162 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:23:58 INFO - 2015-12-15 17:23:58,162 DEBUG : BROWSER_OUTPUT: __startTimestamp1450229038155__endTimestamp 17:23:58 INFO - 2015-12-15 17:23:58,162 DEBUG : BROWSER_OUTPUT: 17:23:58 INFO - 2015-12-15 17:23:58,166 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:23:58 INFO - 2015-12-15 17:23:58,166 DEBUG : BROWSER_OUTPUT: Number of tests: 14 17:23:58 INFO - 2015-12-15 17:23:58,166 DEBUG : BROWSER_OUTPUT: 17:23:58 INFO - 2015-12-15 17:23:58,166 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.20 Median:114.00 stddev:3.97 (3.5%) stddev-sans-first:4.20 17:23:58 INFO - 2015-12-15 17:23:58,166 DEBUG : BROWSER_OUTPUT: Values: 115.0 108.0 112.0 113.0 114.0 124.0 114.0 114.0 114.0 114.0 17:23:58 INFO - 2015-12-15 17:23:58,166 DEBUG : BROWSER_OUTPUT: 17:23:58 INFO - 2015-12-15 17:23:58,167 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.40 Median:156.50 stddev:15.54 (9.9%) stddev-sans-first:16.29 17:23:58 INFO - 2015-12-15 17:23:58,167 DEBUG : BROWSER_OUTPUT: Values: 157.0 131.0 169.0 165.0 130.0 154.0 156.0 137.0 169.0 136.0 17:23:58 INFO - 2015-12-15 17:23:58,167 DEBUG : BROWSER_OUTPUT: 17:23:58 INFO - 2015-12-15 17:23:58,167 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.70 Median:164.00 stddev:2.06 (1.3%) stddev-sans-first:2.18 17:23:58 INFO - 2015-12-15 17:23:58,167 DEBUG : BROWSER_OUTPUT: Values: 164.0 163.0 162.0 162.0 161.0 164.0 168.0 166.0 164.0 163.0 17:23:58 INFO - 2015-12-15 17:23:58,167 DEBUG : BROWSER_OUTPUT: 17:23:58 INFO - 2015-12-15 17:23:58,168 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.80 Median:73.50 stddev:21.64 (29.4%) stddev-sans-first:22.71 17:23:58 INFO - 2015-12-15 17:23:58,168 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 73.0 72.0 75.0 142.0 77.0 79.0 74.0 72.0 17:23:58 INFO - 2015-12-15 17:23:58,168 DEBUG : BROWSER_OUTPUT: 17:23:58 INFO - 2015-12-15 17:23:58,168 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.40 Median:95.00 stddev:18.88 (19.9%) stddev-sans-first:19.56 17:23:58 INFO - 2015-12-15 17:23:58,168 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 137.0 94.0 95.0 95.0 133.0 94.0 95.0 131.0 17:23:58 INFO - 2015-12-15 17:23:58,168 DEBUG : BROWSER_OUTPUT: 17:23:58 INFO - 2015-12-15 17:23:58,168 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 17:23:58 INFO - 2015-12-15 17:23:58,168 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 111.0 110.0 110.0 110.0 109.0 110.0 110.0 110.0 17:23:58 INFO - 2015-12-15 17:23:58,168 DEBUG : BROWSER_OUTPUT: 17:23:58 INFO - 2015-12-15 17:23:58,169 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 17:23:58 INFO - 2015-12-15 17:23:58,169 DEBUG : BROWSER_OUTPUT: Values: 147.0 148.0 147.0 148.0 148.0 148.0 149.0 146.0 147.0 147.0 17:23:58 INFO - 2015-12-15 17:23:58,169 DEBUG : BROWSER_OUTPUT: 17:23:58 INFO - 2015-12-15 17:23:58,169 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.70 Median:96.00 stddev:1.70 (1.8%) stddev-sans-first:1.69 17:23:58 INFO - 2015-12-15 17:23:58,169 DEBUG : BROWSER_OUTPUT: Values: 95.0 97.0 98.0 96.0 96.0 96.0 96.0 96.0 96.0 101.0 17:23:58 INFO - 2015-12-15 17:23:58,169 DEBUG : BROWSER_OUTPUT: 17:23:58 INFO - 2015-12-15 17:23:58,169 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.00 Median:72.00 stddev:0.67 (0.9%) stddev-sans-first:0.71 17:23:58 INFO - 2015-12-15 17:23:58,169 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 71.0 73.0 72.0 72.0 73.0 72.0 72.0 71.0 17:23:58 INFO - 2015-12-15 17:23:58,169 DEBUG : BROWSER_OUTPUT: 17:23:58 INFO - 2015-12-15 17:23:58,169 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 17:23:58 INFO - 2015-12-15 17:23:58,169 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 68.0 68.0 70.0 69.0 69.0 69.0 69.0 70.0 17:23:58 INFO - 2015-12-15 17:23:58,169 DEBUG : BROWSER_OUTPUT: 17:23:58 INFO - 2015-12-15 17:23:58,170 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:84.50 stddev:4.67 (5.5%) stddev-sans-first:4.88 17:23:58 INFO - 2015-12-15 17:23:58,170 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 95.0 83.0 84.0 86.0 83.0 84.0 84.0 95.0 17:23:58 INFO - 2015-12-15 17:23:58,170 DEBUG : BROWSER_OUTPUT: 17:23:58 INFO - 2015-12-15 17:23:58,170 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.40 Median:128.00 stddev:3.86 (3.0%) stddev-sans-first:4.09 17:23:58 INFO - 2015-12-15 17:23:58,170 DEBUG : BROWSER_OUTPUT: Values: 127.0 130.0 123.0 130.0 126.0 129.0 123.0 120.0 124.0 132.0 17:23:58 INFO - 2015-12-15 17:23:58,170 DEBUG : BROWSER_OUTPUT: 17:23:58 INFO - 2015-12-15 17:23:58,170 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.60 Median:151.50 stddev:5.50 (3.6%) stddev-sans-first:5.81 17:23:58 INFO - 2015-12-15 17:23:58,170 DEBUG : BROWSER_OUTPUT: Values: 152.0 151.0 154.0 148.0 154.0 145.0 149.0 162.0 149.0 142.0 17:23:58 INFO - 2015-12-15 17:23:58,170 DEBUG : BROWSER_OUTPUT: 17:23:58 INFO - 2015-12-15 17:23:58,170 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:71.00 stddev:2.51 (3.5%) stddev-sans-first:2.65 17:23:58 INFO - 2015-12-15 17:23:58,170 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 69.0 71.0 71.0 69.0 77.0 71.0 69.0 69.0 17:23:58 INFO - 2015-12-15 17:23:58,170 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:23:58 INFO - 2015-12-15 17:23:58,170 DEBUG : BROWSER_OUTPUT: 17:23:59 INFO - 2015-12-15 17:23:59,064 INFO : Browser exited with error code: 0 17:23:59 INFO - 2015-12-15 17:23:59,117 INFO : Completed test kraken (00:01:01) 17:23:59 INFO - 2015-12-15 17:23:59,118 INFO : Starting test v8_7 17:23:59 INFO - 2015-12-15 17:23:59,118 DEBUG : operating with platform_type : linux_ 17:23:59 INFO - 2015-12-15 17:23:59,118 INFO : Initialising browser for v8_7 test... 17:23:59 INFO - 2015-12-15 17:23:59,124 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQd8QJg/profile http://localhost:39460/getInfo.html 17:24:04 INFO - 2015-12-15 17:24:04,211 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:24:04 INFO - 2015-12-15 17:24:04,211 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:24:04 INFO - 2015-12-15 17:24:04,212 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:24:04 INFO - 2015-12-15 17:24:04,212 DEBUG : BROWSER_OUTPUT: __metrics 17:24:04 INFO - 2015-12-15 17:24:04,348 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] 17:24:05 INFO - 2015-12-15 17:24:05,276 INFO : Browser initialized. 17:24:05 INFO - 2015-12-15 17:24:05,277 INFO : Running cycle 1/1 for v8_7 test... 17:24:05 INFO - 2015-12-15 17:24:05,277 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQd8QJg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:24:17 INFO - 2015-12-15 17:24:17,277 DEBUG : BROWSER_OUTPUT: RSS: Main: 142651392 17:24:17 INFO - 2015-12-15 17:24:17,278 DEBUG : BROWSER_OUTPUT: 17:24:38 INFO - 2015-12-15 17:24:38,741 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39460/tests/v8_7/run.html (next: http://localhost:39460/tests/v8_7/run.html) 17:24:38 INFO - 2015-12-15 17:24:38,991 DEBUG : BROWSER_OUTPUT: RSS: Main: 137842688 17:24:38 INFO - 2015-12-15 17:24:38,991 DEBUG : BROWSER_OUTPUT: 17:24:38 INFO - 2015-12-15 17:24:38,991 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:24:38 INFO - 2015-12-15 17:24:38,991 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:24:38 INFO - 2015-12-15 17:24:38,991 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:24:38 INFO - 2015-12-15 17:24:38,992 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:24:38 INFO - 2015-12-15 17:24:38,992 DEBUG : BROWSER_OUTPUT: |0;Richards;165.8649859014762 17:24:38 INFO - 2015-12-15 17:24:38,992 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.79133103183736 17:24:38 INFO - 2015-12-15 17:24:38,992 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.09572983533354 17:24:38 INFO - 2015-12-15 17:24:38,992 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5191.709844559586 17:24:38 INFO - 2015-12-15 17:24:38,992 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1077.5862068965516 17:24:38 INFO - 2015-12-15 17:24:38,992 DEBUG : BROWSER_OUTPUT: |5;Earley;710.7320540156361 17:24:38 INFO - 2015-12-15 17:24:38,992 DEBUG : BROWSER_OUTPUT: |6;Boyer;12156.626506024097 17:24:38 INFO - 2015-12-15 17:24:38,992 DEBUG : BROWSER_OUTPUT: |7;RegExp;25974.358974358973 17:24:38 INFO - 2015-12-15 17:24:38,992 DEBUG : BROWSER_OUTPUT: |8;Splay;598.4440454817475 17:24:38 INFO - 2015-12-15 17:24:38,992 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4850.241545893719 17:24:38 INFO - 2015-12-15 17:24:38,992 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:24:38 INFO - 2015-12-15 17:24:38,993 DEBUG : BROWSER_OUTPUT: __startTimestamp1450229078990__endTimestamp 17:24:38 INFO - 2015-12-15 17:24:38,993 DEBUG : BROWSER_OUTPUT: 17:24:38 INFO - 2015-12-15 17:24:38,993 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:24:38 INFO - 2015-12-15 17:24:38,993 DEBUG : BROWSER_OUTPUT: Number of tests: 10 17:24:38 INFO - 2015-12-15 17:24:38,993 DEBUG : BROWSER_OUTPUT: 17:24:38 INFO - 2015-12-15 17:24:38,993 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.86 Median:165.86 stddev:0.00 (0.0%) 17:24:38 INFO - 2015-12-15 17:24:38,993 DEBUG : BROWSER_OUTPUT: Values: 165.9 17:24:38 INFO - 2015-12-15 17:24:38,993 DEBUG : BROWSER_OUTPUT: 17:24:38 INFO - 2015-12-15 17:24:38,993 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.79 Median:191.79 stddev:0.00 (0.0%) 17:24:38 INFO - 2015-12-15 17:24:38,993 DEBUG : BROWSER_OUTPUT: Values: 191.8 17:24:38 INFO - 2015-12-15 17:24:38,993 DEBUG : BROWSER_OUTPUT: 17:24:38 INFO - 2015-12-15 17:24:38,994 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.10 Median:279.10 stddev:0.00 (0.0%) 17:24:38 INFO - 2015-12-15 17:24:38,994 DEBUG : BROWSER_OUTPUT: Values: 279.1 17:24:38 INFO - 2015-12-15 17:24:38,994 DEBUG : BROWSER_OUTPUT: 17:24:38 INFO - 2015-12-15 17:24:38,994 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 17:24:38 INFO - 2015-12-15 17:24:38,994 DEBUG : BROWSER_OUTPUT: Values: 5191.7 17:24:38 INFO - 2015-12-15 17:24:38,994 DEBUG : BROWSER_OUTPUT: 17:24:38 INFO - 2015-12-15 17:24:38,994 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1077.59 Median:1077.59 stddev:0.00 (0.0%) 17:24:38 INFO - 2015-12-15 17:24:38,994 DEBUG : BROWSER_OUTPUT: Values: 1077.6 17:24:38 INFO - 2015-12-15 17:24:38,994 DEBUG : BROWSER_OUTPUT: 17:24:38 INFO - 2015-12-15 17:24:38,994 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:710.73 Median:710.73 stddev:0.00 (0.0%) 17:24:38 INFO - 2015-12-15 17:24:38,994 DEBUG : BROWSER_OUTPUT: Values: 710.7 17:24:38 INFO - 2015-12-15 17:24:38,994 DEBUG : BROWSER_OUTPUT: 17:24:38 INFO - 2015-12-15 17:24:38,995 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12156.63 Median:12156.63 stddev:0.00 (0.0%) 17:24:38 INFO - 2015-12-15 17:24:38,995 DEBUG : BROWSER_OUTPUT: Values: 12156.6 17:24:38 INFO - 2015-12-15 17:24:38,995 DEBUG : BROWSER_OUTPUT: 17:24:38 INFO - 2015-12-15 17:24:38,995 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25974.36 Median:25974.36 stddev:0.00 (0.0%) 17:24:38 INFO - 2015-12-15 17:24:38,995 DEBUG : BROWSER_OUTPUT: Values: 25974.4 17:24:39 INFO - 2015-12-15 17:24:38,995 DEBUG : BROWSER_OUTPUT: 17:24:39 INFO - 2015-12-15 17:24:38,995 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:598.44 Median:598.44 stddev:0.00 (0.0%) 17:24:39 INFO - 2015-12-15 17:24:38,995 DEBUG : BROWSER_OUTPUT: Values: 598.4 17:24:39 INFO - 2015-12-15 17:24:38,995 DEBUG : BROWSER_OUTPUT: 17:24:39 INFO - 2015-12-15 17:24:38,995 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 17:24:39 INFO - 2015-12-15 17:24:38,995 DEBUG : BROWSER_OUTPUT: Values: 4850.2 17:24:39 INFO - 2015-12-15 17:24:38,995 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:24:39 INFO - 2015-12-15 17:24:38,995 DEBUG : BROWSER_OUTPUT: 17:24:39 INFO - 2015-12-15 17:24:39,956 INFO : Browser exited with error code: 0 17:24:39 INFO - 2015-12-15 17:24:39,971 INFO : Completed test v8_7 (00:00:40) 17:24:40 INFO - 2015-12-15 17:24:40,452 INFO : Completed test suite (00:20:16) 17:24:40 INFO - 2015-12-15 17:24:40,452 DEBUG : Working with test: dromaeo_css 17:24:40 INFO - 2015-12-15 17:24:40,452 DEBUG : Generating results file: dromaeo_css 17:24:40 INFO - 2015-12-15 17:24:40,453 DEBUG : Working with test: kraken 17:24:40 INFO - 2015-12-15 17:24:40,453 DEBUG : Generating results file: kraken 17:24:40 INFO - 2015-12-15 17:24:40,454 INFO : javascript benchmark 17:24:40 INFO - 2015-12-15 17:24:40,454 DEBUG : Working with test: v8_7 17:24:40 INFO - 2015-12-15 17:24:40,454 DEBUG : Generating results file: v8_7 17:24:40 INFO - 2015-12-15 17:24:40,454 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:24:40 INFO - 2015-12-15 17:24:40,504 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 17:24:40 INFO - 2015-12-15 17:24:40,505 DEBUG : process_Request line: dromaeo_css 6361.56 graph.html#tests=[[72,94,43]] 17:24:40 INFO - 2015-12-15 17:24:40,505 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:24:40 INFO - 2015-12-15 17:24:40,534 DEBUG : process_Request line: kraken 1545.10 graph.html#tests=[[232,94,43]] 17:24:40 INFO - 2015-12-15 17:24:40,534 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:24:40 INFO - 2015-12-15 17:24:40,566 DEBUG : process_Request line: v8_7 21305.45 graph.html#tests=[[230,94,43]] 17:24:40 INFO - 2015-12-15 17:24:40,567 INFO : javascript benchmark 17:24:40 INFO - 2015-12-15 17:24:40,571 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2692.2865440658225, 2738.137486691691, 2771.265614612128, 2785.345443820702, 2791.204506715586, 4645.233536466488, 4752.405949256343, 4754.738489383082, 4796.592289655379, 4797.0, 4708.529147085298, 4717.198076327024, 4721.12659158056, 4724.126036683216, 4737.076270127326, 4408.823647054114, 4411.360352748849, 4422.800973956164, 4567.680262381618, 4569.223232050543, 4494.0, 4530.343100250462, 4570.794314255866, 4578.381918441001, 4608.976955115219, 88.10805421798135, 4463.0, 4465.68740188187, 4568.428946381702, 4601.286800545904, 4577.473590537097, 4583.220852455091, 4588.220002599566, 4592.357070010168, 4621.630269578425, 4553.704009239389, 4564.178447879381, 4569.543045695404, 4581.839635612738, 4606.884827879297, 4591.931121033187, 4616.422947131608, 4633.953660463386, 4709.835155769531, 4901.607871370317, 5177.844664660066, 5210.348706411699, 5219.243209734605, 5227.0, 5243.79024839006, 5229.816956406546, 5266.420693723688, 5275.261463395128, 5277.7361131943635, 5336.493033161843, 4617.30740388941, 4756.5243475652505, 4762.523747625279, 4762.880927976828, 4862.586680132193, 5265.131253343156, 5268.209768534751, 5367.516923476827, 5435.592330575223, 5484.2047903053835, 5216.765245563959, 5225.372955245395, 5226.5818734501145, 5230.555402790806, 5235.9266350398075, 4970.776315065831, 5303.496167864047, 5309.442508536626, 5361.061814182581, 5395.865103372447, 5041.117804384218, 5046.44489106198, 5086.440491545927, 5091.821786237464, 5169.121249387613, 5154.149565321755, 5207.505286997729, 5211.400688920747, 5216.400113986864, 5272.209168624737, 4123.525794533667, 4228.534861165269, 4317.201317756162, 4365.781710914505, 4377.212101821639, 3673.504076949631, 3758.774473531597, 3768.9246215075545, 3773.1699026214187, 3789.696824254053, 4485.147821913891, 4508.504064552896, 4511.8646440606835, 4520.796564154621, 4565.178267911808, 4983.775730092155, 5095.337606111182, 5172.5344718975475, 5287.365516138088, 5322.627416080914, 4463.642908567307, 4496.527864574238, 4511.571400716993, 4535.909281814345, 4537.523560026149, 4600.5169457207185, 4620.676552641283, 4622.583967442946, 4623.029163875623, 4658.743769092733, 4748.382710247714, 4788.760561971957, 4863.537963893425, 4918.040982008617, 4970.403551573834, 5192.091384007859, 5197.480251974772, 5199.532042116228, 5203.063448579292, 5214.791408343775, 4893.486183950634, 4911.754412279443, 4918.729469879047, 4919.409670839522, 4961.578265847299, 4921.384826896638, 5017.247412888096, 5043.218301163325, 5158.6131040171385, 5200.63595548308, 5214.2960700304975, 5222.921656175236, 5228.790848366023, 5229.529342359206, 5230.2677625131755, 4801.639877009308, 5038.420581633159, 5043.36957880265, 5046.545810877039, 5054.494550544916, 4936.3829521309835, 4952.925706114339, 4970.577500912463, 4974.9751251243515, 4979.327790748347, 4898.044881248265, 4914.70511769295, 4937.086638971802, 4976.253561965734, 5008.449070602303, 5082.313887625123, 5100.132977393926, 5120.846374608767, 5127.564157046693, 5164.302819119371, 4757.904841903073, 4854.927176092432, 4926.236433352836, 5015.749212539431, 5018.297438358706], "unit": "score", "name": "dojo.html", "value": 4728.351566445155}, {"lowerIsBetter": false, "replicates": [559.4964531921272, 559.6026820957122, 570.067938919866, 572.4361503918642, 576.4581293584031, 35002.474962875574, 35820.28359432813, 35896.64103358966, 36032.279354412894, 36187.0, 40572.0, 41385.172296554054, 41407.58592414075, 41431.58568414315, 41477.37783933243, 7964.999999999985, 8164.510129392226, 8171.019477662689, 8175.79560510986, 8190.262876341158, 7967.561784101872, 7990.041195056601, 8033.598320083973, 8059.234372734581, 8080.232377924117, 7988.081370642392, 8079.151689072651, 8087.110417854032, 8124.715634952778, 8131.430799844014, 7941.96029019857, 7990.720324788634, 8051.315638170762, 8061.838763224761, 8074.0311162660855, 7966.601669916481, 8074.555899425529, 8105.351571874236, 8107.391945604103, 8123.390745694038, 37811.05472363185, 38161.0, 38273.0, 38316.0, 38405.423918641245, 2595.2344058502786, 3037.8329191894436, 3126.796758210709, 3136.5452009458727, 3213.7107660310685, 26449.867750661124, 26517.867410663017, 26571.73428265712, 26716.198514044416, 26724.599131013052, 3475.2180759329203, 3557.8932632021083, 3586.336527742376, 3610.0433385152955, 3633.2006958469096, 214718.0, 217059.99999999843, 217124.0, 217210.0, 217429.0, 47721.0, 49087.26369104466, 56391.43608563862, 56763.71618141883, 56837.43162568404, 68220.0, 69174.3082569178, 69211.65394172996, 69546.304536955, 69689.65155174192, 15292.235388230767, 15425.460108896359, 15534.223288835514, 15564.066156030674, 15567.377304907903, 10822.24244302907, 10825.56697732082, 10836.945815270874, 10848.0, 10871.0, 19840.90079549593, 19973.300934467225, 20030.799692003184, 20141.39575812728, 20149.697754533692, 7410.777676669709, 7659.655315510815, 7749.922500775033, 7756.573388463576, 7772.611369431505, 787.4920676163842, 812.0308252487694, 899.5322432335149, 900.5905757489508, 997.6458357283205, 25887.870560647076, 26422.339441514116, 26908.0, 26908.461830763667, 26954.32614184661, 938.648006997376, 949.5015117063597, 973.8587904753913, 992.9851052234222, 1000.5797565022708, 13998.370073346723, 14201.431942722382, 14256.85743142576, 15298.388064477296, 16348.182590870409, 306405.7437702467, 309644.0, 310114.0, 311363.0, 314680.0, 49930.50069499259, 50198.749006255464, 50372.244416333786, 50667.493325067015, 50672.74663626658, 1183.7573297473998, 1204.6085022367765, 1214.441356975801, 1216.1183142221996, 1220.4568966809684, 27843.303917402227, 27919.72080279171, 28242.576361355008, 28394.432111357244, 28519.28701782472, 41670.37494437525, 41834.79082604689, 41976.1604767909, 42152.36771448369, 42155.3676694856, 248107.0, 250234.0, 250907.0, 251689.0, 254328.0, 30018.549721753756, 42310.0, 43605.34591981059, 44161.33757993697, 44200.55799442093, 38858.80570597129, 39024.609753903234, 39195.41206881956, 39759.60240397559, 40111.79944100261, 33081.0, 34010.82994585011, 34255.0, 34541.91187771805, 34698.13254668654, 33789.262153254036, 33927.66072339344, 34225.14437139092, 34438.655613443545, 34569.65430345664, 33344.833275833465, 33426.83286583552, 33491.4976275361, 33821.83089084539, 33891.0, 30457.238569035064, 30520.389592208474, 30955.845220774652, 31095.0, 31177.37645247037, 24057.353691094315, 24068.27795166148, 24121.879390602935, 24213.665266407148, 24362.0], "unit": "score", "name": "ext.html", "value": 17513.934227831003}, {"lowerIsBetter": false, "replicates": [328.9029736227814, 333.95491608632835, 334.8309103902529, 335.2289733612692, 335.2774770369854, 14886.330115144818, 15318.540443786676, 16072.357105715757, 16072.357105715786, 16751.748723769124, 9924.45415502147, 10101.090901818834, 10158.49207539622, 10172.847407288897, 10317.742056448593, 4552.658550608709, 4618.237990731525, 4669.6731228814, 4685.461171965234, 4689.437267527885, 4496.7751612419415, 4665.580097791198, 4669.743164125972, 4672.766361681919, 4687.578117969382, 3225.532297816815, 3377.0881861897274, 4651.62786977041, 4660.464046634646, 5158.871028224287, 5268.341457317835, 5290.444503327172, 5298.523132918037, 5307.1243244864745, 5308.309919710432, 5017.197248440269, 5112.054269960069, 5112.696262453088, 5115.974420127913, 5163.66436181647, 11413.714657133554, 11432.485538150802, 11843.88156118445, 11983.760324793542, 12113.33376664283, 1829.0763164601924, 1895.3745264062964, 1896.753422055138, 2019.7273368095266, 2061.917523299066, 9032.0, 9137.81724365509, 9268.351215414923, 10687.465626718633, 13071.54249601269, 1752.8860624059396, 1779.9288028478975, 1831.2400353853136, 1835.6053448508635, 1839.190756067326, 53432.46567534314, 55417.44582554163, 56963.43036569623, 57227.14159287573, 57776.71111644457, 9595.808083838285, 9903.950480247697, 9904.55429505674, 9921.206303495703, 9994.450305233137, 12290.508379664714, 12395.75208495825, 12467.0, 12476.563320283927, 12490.81263781044, 7222.277772222841, 7323.194448610649, 7329.303716146957, 7364.447666424932, 7408.222136675679, 7004.544704594185, 7012.5792452453015, 7052.612106334201, 7082.645867706594, 7100.183478899889, 4092.6316631502714, 4123.340265557496, 4152.5432202457705, 4166.229247589205, 4237.343211802176, 1671.7659527666137, 1679.3114822922544, 1703.233544904773, 1710.4783041172313, 1723.284836792717, 378.5835580861086, 380.5368358660944, 392.04536952520704, 803.61426515273, 824.8474032304043, 9749.610015599439, 10203.336783109222, 10204.997755499056, 10479.738006549745, 10597.364158150536, 404.45398711739506, 824.1223097401248, 837.7361131243639, 873.1966590736538, 880.903100658927, 8769.254613357809, 8885.42244754089, 9043.412178208395, 9061.275097992146, 9183.219426348702, 312566.0, 312674.0, 314267.42866285524, 315936.0, 469307.0, 69761.65119174372, 73302.0, 75601.0, 76100.23899761042, 76137.61931190308, 1059.6979860739498, 1066.195022757813, 1069.4652673663168, 1095.118429664128, 1104.1442881766695, 14739.705205896036, 14882.776758348416, 14955.401783928955, 15056.924715376354, 15191.924040379727, 33031.17422064468, 33674.66325336813, 33791.324173516885, 34068.318633627685, 34568.0, 45553.0, 45567.77216113898, 45843.3123503141, 46437.0, 47904.0, 8745.693900713444, 8789.956050219707, 9003.54982250898, 9016.684416045407, 9043.18611324984, 10273.126784223425, 10330.121939634915, 10399.064084232456, 10501.369917804956, 15770.0, 13217.339133043502, 13859.0, 14028.08817426864, 14300.427982880985, 14311.284435777961, 13084.28036458004, 13846.169229846242, 13929.860701392856, 14122.717545648824, 14527.201003944885, 14654.633634158805, 14660.266986650839, 14782.408703651734, 14912.627184320045, 15227.238638068275, 8876.245519130687, 8918.420302680304, 9011.279097672039, 9087.227585655293, 9130.269578433843, 12386.194897331645, 13918.09532380392, 14007.929960350133, 14348.06737562055, 14393.496227631982], "unit": "score", "name": "jquery.html", "value": 7798.480615029757}, {"lowerIsBetter": false, "replicates": [1480.9481668141618, 1600.7278762610358, 1652.3142895698286, 1677.5973766296092, 1679.3954176496468, 6257.874842503147, 6415.06981487684, 7359.227281135477, 7596.582187979659, 7613.390928725703, 6913.481488888341, 7215.855682886352, 7218.0, 7259.927400725991, 7276.672549735262, 2094.32981445937, 2138.112683236455, 2139.7967193116706, 2141.9464513387134, 2143.217725530178, 2115.7672656007826, 2151.967720484186, 2187.0814258011674, 2203.272919936417, 2207.4481379655085, 2082.739657542807, 2104.8105670489654, 2119.470132466883, 2122.5330427306044, 2126.2133010786033, 2094.235604004535, 2119.4383488375593, 2120.226117467121, 2120.416885356524, 2125.1393185759794, 2074.66805311151, 2098.6956891250834, 2101.4746313421647, 2116.809487146149, 2123.193186589086, 7115.252898445692, 7185.856282874365, 7192.172900116449, 7200.063991681101, 7250.4562157837845, 4189.832406703728, 4228.513720922103, 4229.111886503838, 4233.0, 4252.596003379674, 2683.3559945613106, 2729.331313828105, 2768.44631073784, 2788.121741651373, 2792.539231026878, 817.464560712734, 824.9546274954876, 826.5784449930519, 828.2628460670009, 858.1032820702319, 9426.057394260588, 9427.434353938717, 9495.24038076959, 9497.715068547956, 9510.38182518134, 3891.2412079644764, 3907.7264591478324, 3953.9802300988313, 3967.8809635710977, 3970.285348637215, 8131.430799844073, 8187.5087494750505, 8194.467359621605, 8197.508149511048, 8215.260626543639, 4290.120525292307, 4297.247981603207, 4311.676624253194, 4316.69783115179, 4325.740455572675, 3345.347657206821, 3418.9658103418647, 3855.2289542091694, 3918.8432462701744, 3930.941035884464, 3371.3088816792497, 3424.8972530823617, 3444.2422667013216, 3447.9310413792086, 3470.514128022079, 1061.4056128568027, 1071.8017166824163, 1072.780080083581, 1077.876044254905, 1095.1676725688376, 963.0658261486348, 973.3138137612966, 979.1090108001827, 1033.8397548380012, 1195.3365881935608, 6981.0, 7000.229974702778, 7007.0, 7036.683349249296, 7077.646117694095, 376.10674647711687, 377.136357740776, 383.35596198386423, 383.8157684311546, 384.0092561192118, 5363.517283444431, 5386.326709161355, 5395.81114660985, 5415.404305526389, 5485.424030476823, 8591.226789588967, 8948.194662480408, 8977.730668079968, 9031.36780425364, 9045.0, 8808.03111657717, 8809.03100658927, 8825.646974120964, 8868.0, 8929.10708929102, 6852.417544508772, 6988.986596943415, 7020.262872398324, 7061.258567850302, 7077.3984211341585, 6634.303398143125, 6637.568558043712, 6660.966695166493, 6677.432418244503, 6718.193816742022, 7733.342665873463, 7950.801229969297, 7991.760247192594, 8090.150534193825, 8125.837483250184, 8055.436119471581, 8181.059178194346, 8181.959090204511, 8231.506109633441, 8298.502089874626, 6419.871602568016, 6459.289478157493, 6470.320616335405, 6473.741050357933, 6506.284308726131, 7102.218755936946, 7153.678084486107, 7170.1754298256365, 7172.892406614009, 7186.1376634804155, 6521.967390163209, 6526.804195874131, 6636.303188165366, 6648.5346025777735, 6780.982852572153, 6618.834529136618, 6695.665216739046, 6708.127943367331, 6749.0, 6756.986452032234, 6842.315768423118, 6868.107146071178, 6878.037074809631, 6895.862082758417, 6913.5506192097355, 5963.254593175853, 6037.215162028908, 6117.755289788359, 6141.973148860776, 6153.569250152446, 6402.071699603438, 6429.067785171031, 6430.871382572229, 6431.517636177399, 6455.806325810233], "unit": "score", "name": "mootools.html", "value": 4070.1534672090793}, {"lowerIsBetter": false, "replicates": [286.5114978960871, 295.970402959704, 302.4601087059599, 309.75065072616536, 311.3135536142804, 5600.18797274395, 5625.0, 5633.408492108326, 5645.237892884465, 5789.218455508505, 5577.498025177733, 5615.354234263061, 5631.380548139701, 5656.802011929573, 5662.0, 4159.313713237312, 4320.848770293041, 4337.501187363462, 4342.565743425664, 4343.174796788616, 4249.405083288342, 4295.055087880662, 4301.333293339538, 4312.784360781964, 4326.870193894189, 4254.851080212193, 4260.595243451882, 4276.935845962313, 4284.571542845706, 4286.442762440878, 4257.8296868125235, 4260.573942605745, 4269.957300427002, 4281.743095414286, 4285.035866929916, 3720.683741881943, 3721.0325315417917, 3727.4408838674144, 3729.440583912408, 3730.0488375464356, 5200.141976573861, 5259.921101183485, 5269.209618557209, 5322.9620224056325, 5452.154915988028, 4910.0, 4911.993041426535, 4915.410150781893, 4919.7540122993705, 4935.876603084952, 5924.555658325643, 5924.881502369928, 5935.139404786281, 5940.584159108864, 5953.553483488756, 3853.094522787143, 4018.457508236409, 4020.075382662004, 4027.617376349242, 4046.150308435232, 6135.601185922901, 6195.2255968004, 6214.223222097238, 6216.844578885519, 6218.440340369389, 4096.91806163875, 4108.137291168829, 4108.815103320358, 4117.608827161415, 4120.443740095108, 4151.169766046803, 4171.5828417158045, 4172.0, 4176.4570605821655, 4180.707350485498, 4511.413516242867, 4823.782929768169, 4831.202851529529, 4833.0, 4841.661083724176, 5698.430156984268, 5730.426957304237, 5878.617889837147, 5881.647101173943, 5888.381719919433, 1449.0725935401351, 1487.1746180869504, 1487.605784467117, 1489.7616381379144, 1491.142593009024, 968.3366893677853, 978.188103873783, 992.5831150916632, 997.1972562087444, 999.5701848205196, 5127.87180320495, 5160.329157209539, 5160.612954028463, 5178.689278643294, 5187.19598462239, 6181.320054793969, 6185.195924529782, 6186.412290832453, 6188.2883468400805, 6193.876122477615, 5147.948520514747, 5148.021875843578, 5156.020356132323, 5158.174692049329, 5158.535731784157, 3258.918527036843, 3289.111939776247, 3292.456744637108, 3324.6675332467044, 3337.816420096918, 5776.220210271644, 5777.075667893117, 5779.393163717749, 5793.768249270066, 5796.913046304308, 6289.0880822280515, 6291.842703932438, 6313.084602732578, 6338.271098823694, 6340.904886426707, 5622.381538030813, 5762.193292938992, 5769.1923130761725, 5779.450952159622, 5784.50831679312, 6138.416850399205, 6142.355052719578, 6147.262328520606, 6148.292946311231, 6171.506279497539, 5939.020061689773, 5969.820905372846, 5975.223220981245, 5987.161797348288, 5993.340732519507, 5740.827775166752, 5770.682612456355, 5771.018926782541, 5775.595708300547, 5777.422257774189, 4071.2671719089662, 4178.080822219107, 4179.4357761701785, 4194.853180138681, 4198.412222288943, 6007.279126504673, 6104.786332478342, 6142.262928448615, 6149.540183926465, 6207.348228435949, 5903.173555702119, 5933.762649493972, 5948.940510595012, 5956.821295361146, 5961.0, 5878.500327472213, 5902.5277977762535, 5924.081767326072, 5929.229200203946, 5938.970305148447, 5703.458171473703, 5802.970985145047, 5810.273715785527, 5832.50423713989, 5839.328477225174, 5958.970205148947, 5980.850478738066, 5981.700914954322, 5986.730597123053, 6031.969840150771, 5832.825015249549, 5834.38738932423, 5835.649861008353, 5836.095405212199, 5837.591368604157], "unit": "score", "name": "prototype.html", "value": 4395.786902523445}, {"lowerIsBetter": false, "replicates": [682.2631557917447, 731.6378392695616, 768.1051574915224, 786.7089177004507, 809.518336589729, 12045.09661775366, 12331.691707707312, 12334.44494997725, 12347.382630868455, 12370.752584948295, 10841.6747497575, 11464.31214127153, 11917.28496290221, 12026.278423294609, 12084.274943503397, 791.2048391366683, 804.1556365815899, 807.6607824713634, 807.8424707182102, 808.3937047214589, 789.6249281591256, 790.5217343507181, 797.4457751862458, 797.7247849491916, 797.7327595255597, 825.9669613215464, 826.6197549127379, 829.4567058576612, 833.0586437325844, 833.9958300208491, 826.7189155687065, 827.4828232354778, 828.8549503836834, 832.5088197963231, 833.0669649991987, 613.9263288405375, 615.5691016288616, 617.0281806155278, 617.2808677890297, 617.9443850053472, 11064.557417703281, 11275.323480591109, 11280.548778048867, 11308.491117899632, 11312.547498100066, 9344.205742511895, 9721.902780972241, 10034.89965100347, 10065.849012264822, 10125.696229113139, 8745.0, 8754.255888249443, 8878.156575125353, 9031.819363612756, 9132.178103970675, 3155.2269693924904, 3181.220600952758, 3189.6650851660474, 3268.983655081733, 3291.341731653679, 34430.48354274688, 34537.654623453695, 37142.0, 42448.787756061334, 42605.360919585924, 9523.857142142873, 9868.561314089357, 9968.601255949827, 10108.494575271206, 10118.0, 16771.91614041922, 16832.074235916898, 16836.24236909342, 16895.746563801553, 16966.23651935666, 6417.294097649255, 6459.257185423642, 6535.117759102555, 6554.967225163844, 6682.532222744361, 3664.926701465956, 3692.9815350923072, 3694.8891533254045, 3714.3871261241593, 3728.086618778417, 2661.4544018476167, 2682.0746842339363, 2701.338172147797, 2702.513547561458, 2710.9593356099676, 466.24468361254986, 471.5355374955666, 473.76548608438355, 476.82595852513583, 478.34705626819834, 478.3996084913481, 488.4139033160151, 503.3230305239447, 555.3197333266716, 617.9556549431446, 7586.317231449196, 8020.157883422274, 8143.470674406145, 8147.633356498854, 8224.845597668875, 526.2264471227289, 618.9319174890759, 621.142822904389, 638.8434833465831, 642.958207716497, 3535.840887160084, 3644.5079914211774, 3742.6900584795103, 3744.0, 3777.0, 49609.0, 50168.49831501711, 50198.498015020115, 50278.24582631263, 50395.24407133896, 44314.556854431044, 44316.55683443189, 44827.0, 44858.63560232995, 45679.0, 38083.61916380856, 39506.20987580232, 39779.0, 39932.600673992885, 40562.79718601447, 8103.756887293391, 8315.95842020786, 8536.487810731376, 8643.092475290005, 8705.34709896773, 30832.845835770677, 30990.22524436907, 31482.842585786926, 31573.684263157073, 31608.525872111477, 36136.27727445489, 36428.0, 36677.63322366742, 39100.41349379819, 39648.80175599104, 9639.228861690908, 9673.70978870635, 10069.69790906274, 10180.0, 10373.688789336333, 11272.590926134233, 11306.387225548902, 11404.771904562029, 11450.713732156762, 11712.063034957353, 10767.192460565646, 10784.406857622906, 10784.622538211124, 10805.51375188134, 10873.401962891801, 10772.0, 10853.45732713377, 10866.130709543375, 10872.347659140476, 10886.401247931122, 10576.576936922436, 10708.625198118028, 10713.303635263683, 10744.0, 10832.945835270773, 9515.751754342364, 9631.518424078628, 9690.176335011603, 9721.0, 9845.803083938137, 9247.12152345526, 9281.48951807657, 9341.486218257789, 9403.106704863027, 9617.038296170327], "unit": "score", "name": "yui.html", "value": 5735.727641145679}], "name": "dromaeo_css", "value": 6361.5638363756425}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 108.0, 112.0, 113.0, 114.0, 124.0, 114.0, 114.0, 114.0, 114.0], "unit": "score", "name": "ai-astar", "value": 114.2}, {"lowerIsBetter": true, "replicates": [157.0, 131.0, 169.0, 165.0, 130.0, 154.0, 156.0, 137.0, 169.0, 136.0], "unit": "score", "name": "audio-beat-detection", "value": 150.4}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 162.0, 162.0, 161.0, 164.0, 168.0, 166.0, 164.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.7}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 73.0, 72.0, 75.0, 142.0, 77.0, 79.0, 74.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 137.0, 94.0, 95.0, 95.0, 133.0, 94.0, 95.0, 131.0], "unit": "score", "name": "audio-oscillator", "value": 106.4}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 111.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 147.0, 148.0, 148.0, 148.0, 149.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.5}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 98.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 101.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 71.0, 73.0, 72.0, 72.0, 73.0, 72.0, 72.0, 71.0], "unit": "score", "name": "json-parse-financial", "value": 72.0}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 68.0, 68.0, 70.0, 69.0, 69.0, 69.0, 69.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 95.0, 83.0, 84.0, 86.0, 83.0, 84.0, 84.0, 95.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.3}, {"lowerIsBetter": true, "replicates": [127.0, 130.0, 123.0, 130.0, 126.0, 129.0, 123.0, 120.0, 124.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.4}, {"lowerIsBetter": true, "replicates": [152.0, 151.0, 154.0, 148.0, 154.0, 145.0, 149.0, 162.0, 149.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.6}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 69.0, 71.0, 71.0, 69.0, 77.0, 71.0, 69.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.1}], "name": "kraken", "value": 1545.0999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.8649859014762], "unit": "score", "name": "Richards", "value": 212.835758}, {"lowerIsBetter": false, "replicates": [191.79133103183736], "unit": "score", "name": "DeltaBlue", "value": 344.73925199999996}, {"lowerIsBetter": false, "replicates": [279.09572983533354], "unit": "score", "name": "Encrypt", "value": 953.7265229999995}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [1077.5862068965516], "unit": "score", "name": "RayTrace", "value": 686.7097920000001}, {"lowerIsBetter": false, "replicates": [710.7320540156361], "unit": "score", "name": "Earley", "value": 937.7134409999999}, {"lowerIsBetter": false, "replicates": [12156.626506024097], "unit": "score", "name": "Boyer", "value": 54.82302180376615}, {"lowerIsBetter": false, "replicates": [25974.358974358973], "unit": "score", "name": "RegExp", "value": 35.072472852912156}, {"lowerIsBetter": false, "replicates": [598.4440454817475], "unit": "score", "name": "Splay", "value": 136.17146100000005}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 21305.4453496145}]} 17:24:40 INFO - RETURN: dromaeo_css: 6361.56 17:24:40 INFO - RETURN: kraken: 1545.10 17:24:40 INFO - RETURN: v8_7: 21305.45 17:24:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "21305.45"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1545.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6361.56"}}} 17:24:40 INFO - Return code: 0 17:24:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:24:40 INFO - # TBPL SUCCESS # 17:24:40 INFO - Running post-action listener: _resource_record_post_action 17:24:40 INFO - Running post-run listener: _resource_record_post_run 17:24:41 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 4096; Write bytes: 510246912; Read time: 12; Write time: 838096 17:24:41 INFO - install - Wall time: 15s; CPU: 18.0%; Read bytes: 0; Write bytes: 235585536; Read time: 0; Write time: 649432 17:24:41 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 4096; Write bytes: 274661376; Read time: 12; Write time: 188664 17:24:41 INFO - Running post-run listener: _upload_blobber_files 17:24:41 INFO - Blob upload gear active. 17:24:41 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 17:24:41 INFO - Copying logs to upload dir... 17:24:41 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1265.289214 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-12-15 17:24:41.130647) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-15 17:24:41.134532) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1450227761.824051-165911479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/GtEwwiC0Tzaq4cwea7wUpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010045 build_url: 'https://queue.taskcluster.net/v1/task/GtEwwiC0Tzaq4cwea7wUpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-15 17:24:41.189336) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 17:24:41.189762) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1450227761.824051-165911479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 17:24:41.241379) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-15 17:24:41.241703) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-15 17:24:41.242015) ========= ========= Total master_lag: 0.24 =========