builder: ash_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-060 starttime: 1449204333.74 results: success (0) buildid: 20151203193821 builduid: 4586ce087fff452ab660d38ab5d7cd35 revision: e442bf66404c23b17ce4577f9e4a102c1b63057e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 20:45:33.742573) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 20:45:33.743086) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 20:45:33.743448) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1449203129.498243-731067672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006298 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 20:45:33.767601) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 20:45:33.767942) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 20:45:33.783983) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 20:45:33.784380) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1449203129.498243-731067672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004692 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 20:45:33.834204) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 20:45:33.834569) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 20:45:33.834994) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 20:45:33.835339) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1449203129.498243-731067672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-03 20:45:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.0M=0s 2015-12-03 20:45:34 (47.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.171936 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 20:45:34.026611) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 20:45:34.026945) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1449203129.498243-731067672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017745 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 20:45:34.080259) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 20:45:34.080674) ========= bash -c 'python archiver_client.py mozharness --repo projects/ash --rev e442bf66404c23b17ce4577f9e4a102c1b63057e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/ash --rev e442bf66404c23b17ce4577f9e4a102c1b63057e --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=49ca1b5d70b54a29b055e1ff000001bd-1449203129.498243-731067672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-03 20:45:34,525 truncating revision to first 12 chars 2015-12-03 20:45:34,525 Setting DEBUG logging. 2015-12-03 20:45:34,525 attempt 1/10 2015-12-03 20:45:34,525 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/ash/e442bf66404c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-03 20:45:34,789 unpacking tar archive at: ash-e442bf66404c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.545501 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 20:45:34.639844) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 20:45:34.640175) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 20:45:34.651098) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 20:45:34.651520) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 20:45:34.652017) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2015-12-03 20:45:34.652342) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Ash-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Ash-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Ash-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Ash-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=49ca1b5d70b54a29b055e1ff000001bd-1449203129.498243-731067672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:45:35 INFO - MultiFileLogger online at 20151203 20:45:35 in /builds/slave/test 20:45:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Ash-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Ash-Non-PGO 20:45:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:45:35 INFO - {'append_to_log': False, 20:45:35 INFO - 'base_work_dir': '/builds/slave/test', 20:45:35 INFO - 'blob_upload_branch': 'Ash-Non-PGO', 20:45:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:45:35 INFO - 'branch': 'Ash-Non-PGO', 20:45:35 INFO - 'buildbot_json_path': 'buildprops.json', 20:45:35 INFO - 'config_files': ('talos/linux_config.py',), 20:45:35 INFO - 'default_actions': ('clobber', 20:45:35 INFO - 'read-buildbot-config', 20:45:35 INFO - 'download-and-extract', 20:45:35 INFO - 'populate-webroot', 20:45:35 INFO - 'create-virtualenv', 20:45:35 INFO - 'install', 20:45:35 INFO - 'run-tests'), 20:45:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:45:35 INFO - 'download_minidump_stackwalk': True, 20:45:35 INFO - 'download_symbols': 'ondemand', 20:45:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:45:35 INFO - 'tooltool.py': '/tools/tooltool.py', 20:45:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:45:35 INFO - '/tools/misc-python/virtualenv.py')}, 20:45:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:45:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:45:35 INFO - 'installer_path': 'installer.exe', 20:45:35 INFO - 'log_level': 'info', 20:45:35 INFO - 'log_name': 'talos', 20:45:35 INFO - 'log_to_console': True, 20:45:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:45:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:45:35 INFO - 'opt_config_files': (), 20:45:35 INFO - 'pip_index': False, 20:45:35 INFO - 'sps_profile': False, 20:45:35 INFO - 'sps_profile_interval': 0, 20:45:35 INFO - 'suite': 'dromaeojs', 20:45:35 INFO - 'system_bits': '64', 20:45:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:45:35 INFO - 'title': 'talos-linux64-ix-060', 20:45:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:45:35 INFO - 'use_talos_json': True, 20:45:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:45:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:45:35 INFO - 'work_dir': 'build'} 20:45:35 INFO - ##### 20:45:35 INFO - ##### Running clobber step. 20:45:35 INFO - ##### 20:45:35 INFO - Running pre-action listener: _resource_record_pre_action 20:45:35 INFO - Running main action method: clobber 20:45:35 INFO - rmtree: /builds/slave/test/build 20:45:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:45:35 INFO - Running post-action listener: _resource_record_post_action 20:45:35 INFO - ##### 20:45:35 INFO - ##### Running read-buildbot-config step. 20:45:35 INFO - ##### 20:45:35 INFO - Running pre-action listener: _resource_record_pre_action 20:45:35 INFO - Running main action method: read_buildbot_config 20:45:35 INFO - Using buildbot properties: 20:45:35 INFO - { 20:45:35 INFO - "properties": { 20:45:35 INFO - "buildnumber": 2, 20:45:35 INFO - "product": "firefox", 20:45:35 INFO - "script_repo_revision": "production", 20:45:35 INFO - "builddir": "ash_ubuntu64_hw_test-dromaeojs", 20:45:35 INFO - "repository": "", 20:45:35 INFO - "buildername": "Ubuntu HW 12.04 x64 ash talos dromaeojs", 20:45:35 INFO - "buildid": "20151203193821", 20:45:35 INFO - "slavename": "talos-linux64-ix-060", 20:45:35 INFO - "pgo_build": "False", 20:45:35 INFO - "basedir": "/builds/slave/test", 20:45:35 INFO - "project": "", 20:45:35 INFO - "platform": "ubuntu64_hw", 20:45:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:45:35 INFO - "slavebuilddir": "test", 20:45:35 INFO - "scheduler": "tests-ash-linux64-talos", 20:45:35 INFO - "branch": "ash", 20:45:35 INFO - "repo_path": "projects/ash", 20:45:35 INFO - "stage_platform": "linux64", 20:45:35 INFO - "builduid": "4586ce087fff452ab660d38ab5d7cd35", 20:45:35 INFO - "revision": "e442bf66404c23b17ce4577f9e4a102c1b63057e" 20:45:35 INFO - }, 20:45:35 INFO - "sourcestamp": { 20:45:35 INFO - "repository": "", 20:45:35 INFO - "hasPatch": false, 20:45:35 INFO - "project": "", 20:45:35 INFO - "branch": "ash-linux64-talos", 20:45:35 INFO - "changes": [ 20:45:35 INFO - { 20:45:35 INFO - "category": null, 20:45:35 INFO - "files": [ 20:45:35 INFO - { 20:45:35 INFO - "url": null, 20:45:35 INFO - "name": "https://queue.taskcluster.net/v1/task/bNvlkaFfQgma7Y0-f3h5og/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 20:45:35 INFO - } 20:45:35 INFO - ], 20:45:35 INFO - "repository": "", 20:45:35 INFO - "rev": "e442bf66404c23b17ce4577f9e4a102c1b63057e", 20:45:35 INFO - "who": "nthomas@mozilla.com", 20:45:35 INFO - "when": 1449204311, 20:45:35 INFO - "number": 6742892, 20:45:35 INFO - "comments": "Merge from central", 20:45:35 INFO - "project": "", 20:45:35 INFO - "at": "Thu 03 Dec 2015 20:45:11", 20:45:35 INFO - "branch": "ash-linux64-talos", 20:45:35 INFO - "revlink": "", 20:45:35 INFO - "properties": [ 20:45:35 INFO - [ 20:45:35 INFO - "buildid", 20:45:35 INFO - "20151203193821", 20:45:35 INFO - "Change" 20:45:35 INFO - ], 20:45:35 INFO - [ 20:45:35 INFO - "builduid", 20:45:35 INFO - "4586ce087fff452ab660d38ab5d7cd35", 20:45:35 INFO - "Change" 20:45:35 INFO - ], 20:45:35 INFO - [ 20:45:35 INFO - "pgo_build", 20:45:35 INFO - "False", 20:45:35 INFO - "Change" 20:45:35 INFO - ] 20:45:35 INFO - ], 20:45:35 INFO - "revision": "e442bf66404c23b17ce4577f9e4a102c1b63057e" 20:45:35 INFO - } 20:45:35 INFO - ], 20:45:35 INFO - "revision": "e442bf66404c23b17ce4577f9e4a102c1b63057e" 20:45:35 INFO - } 20:45:35 INFO - } 20:45:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/bNvlkaFfQgma7Y0-f3h5og/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 20:45:35 INFO - Running post-action listener: _resource_record_post_action 20:45:35 INFO - ##### 20:45:35 INFO - ##### Running download-and-extract step. 20:45:35 INFO - ##### 20:45:35 INFO - Running pre-action listener: _resource_record_pre_action 20:45:35 INFO - Running main action method: download_and_extract 20:45:35 INFO - mkdir: /builds/slave/test/build/tests 20:45:35 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')]} 20:45:35 INFO - https://queue.taskcluster.net/v1/task/bNvlkaFfQgma7Y0-f3h5og/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 20:45:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bNvlkaFfQgma7Y0-f3h5og/artifacts/public/build/test_packages.json 20:45:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bNvlkaFfQgma7Y0-f3h5og/artifacts/public/build/test_packages.json 20:45:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bNvlkaFfQgma7Y0-f3h5og/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 20:45:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bNvlkaFfQgma7Y0-f3h5og/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 20:45:36 INFO - Downloaded 1302 bytes. 20:45:36 INFO - Reading from file /builds/slave/test/build/test_packages.json 20:45:36 INFO - Using the following test package requirements: 20:45:36 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 20:45:36 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:45:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:45:36 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:45:36 INFO - u'jsshell-linux-x86_64.zip'], 20:45:36 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:45:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:45:36 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 20:45:36 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:45:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:45:36 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:45:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:45:36 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:45:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:45:36 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 20:45:36 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:45:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:45:36 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:45:36 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')]} 20:45:36 INFO - https://queue.taskcluster.net/v1/task/bNvlkaFfQgma7Y0-f3h5og/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:45:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bNvlkaFfQgma7Y0-f3h5og/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:45:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bNvlkaFfQgma7Y0-f3h5og/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:45:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bNvlkaFfQgma7Y0-f3h5og/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:45:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bNvlkaFfQgma7Y0-f3h5og/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:45:38 INFO - Downloaded 21791043 bytes. 20:45:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 20:45:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:45:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 20:45:39 INFO - Return code: 0 20:45:39 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:45: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')]} 20:45:39 INFO - https://queue.taskcluster.net/v1/task/bNvlkaFfQgma7Y0-f3h5og/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:45:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bNvlkaFfQgma7Y0-f3h5og/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:45:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bNvlkaFfQgma7Y0-f3h5og/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:45:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bNvlkaFfQgma7Y0-f3h5og/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:45:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bNvlkaFfQgma7Y0-f3h5og/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:45:48 INFO - Downloaded 21791043 bytes. 20:45:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 20:45:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:45:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 20:45:49 INFO - Return code: 0 20:45: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')]} 20:45:49 INFO - https://queue.taskcluster.net/v1/task/bNvlkaFfQgma7Y0-f3h5og/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:45:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bNvlkaFfQgma7Y0-f3h5og/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 20:45:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bNvlkaFfQgma7Y0-f3h5og/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 20:45:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bNvlkaFfQgma7Y0-f3h5og/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 20:45:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bNvlkaFfQgma7Y0-f3h5og/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:45:52 INFO - Downloaded 11132001 bytes. 20:45:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 20:45:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 20:45:52 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 20:45:52 INFO - Return code: 0 20:45:52 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')]} 20:45:52 INFO - https://queue.taskcluster.net/v1/task/bNvlkaFfQgma7Y0-f3h5og/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:45:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bNvlkaFfQgma7Y0-f3h5og/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:45:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bNvlkaFfQgma7Y0-f3h5og/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:45:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bNvlkaFfQgma7Y0-f3h5og/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:45:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bNvlkaFfQgma7Y0-f3h5og/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:46:06 INFO - Downloaded 53021523 bytes. 20:46:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bNvlkaFfQgma7Y0-f3h5og/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:46:06 INFO - mkdir: /builds/slave/test/properties 20:46:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:46:06 INFO - Writing to file /builds/slave/test/properties/build_url 20:46:06 INFO - Contents: 20:46:06 INFO - build_url:https://queue.taskcluster.net/v1/task/bNvlkaFfQgma7Y0-f3h5og/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:46:06 INFO - Running post-action listener: _resource_record_post_action 20:46:06 INFO - Running post-action listener: set_extra_try_arguments 20:46:06 INFO - ##### 20:46:06 INFO - ##### Running populate-webroot step. 20:46:06 INFO - ##### 20:46:06 INFO - Running pre-action listener: _resource_record_pre_action 20:46:06 INFO - Running main action method: populate_webroot 20:46:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:46:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:46:06 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 20:46:06 INFO - '../fennec_ids.txt'], 20:46:06 INFO - 'tests': ['tcheck2']}, 20:46:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:46:06 INFO - '--tppagecycles', 20:46:06 INFO - '7'], 20:46:06 INFO - 'tests': ['tsvgm']}}, 20:46:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:46:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:46:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:46:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:46:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:46:06 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:46:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:46:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:46:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:46:06 INFO - 'talos_options': ['--e10s'], 20:46:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:46:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:46:06 INFO - 'tests': ['damp', 'tps']}, 20:46:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:46:06 INFO - 'talos_options': ['--e10s'], 20:46:06 INFO - 'tests': ['damp', 'tps']}, 20:46:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:46:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:46:06 INFO - 'other': {'tests': ['a11yr', 20:46:06 INFO - 'ts_paint', 20:46:06 INFO - 'tpaint', 20:46:06 INFO - 'sessionrestore', 20:46:06 INFO - 'sessionrestore_no_auto_restore']}, 20:46:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:46:06 INFO - 'tests': ['a11yr', 20:46:06 INFO - 'ts_paint', 20:46:06 INFO - 'tpaint', 20:46:06 INFO - 'sessionrestore', 20:46:06 INFO - 'sessionrestore_no_auto_restore']}, 20:46:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:46:06 INFO - 'tests': ['a11yr', 20:46:06 INFO - 'ts_paint', 20:46:06 INFO - 'tpaint', 20:46:06 INFO - 'sessionrestore', 20:46:06 INFO - 'sessionrestore_no_auto_restore']}, 20:46:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:46:06 INFO - 'tests': ['a11yr', 20:46:06 INFO - 'ts_paint', 20:46:06 INFO - 'tpaint', 20:46:06 INFO - 'sessionrestore', 20:46:06 INFO - 'sessionrestore_no_auto_restore']}, 20:46:06 INFO - 'other_l64': {'tests': ['a11yr', 20:46:06 INFO - 'ts_paint', 20:46:06 INFO - 'tpaint', 20:46:06 INFO - 'sessionrestore', 20:46:06 INFO - 'sessionrestore_no_auto_restore']}, 20:46:06 INFO - 'other_nol64': {'tests': ['a11yr', 20:46:06 INFO - 'ts_paint', 20:46:06 INFO - 'tpaint', 20:46:06 INFO - 'sessionrestore', 20:46:06 INFO - 'sessionrestore_no_auto_restore']}, 20:46:06 INFO - 'svgr': {'tests': ['tsvgx', 20:46:06 INFO - 'tsvgr_opacity', 20:46:06 INFO - 'tart', 20:46:06 INFO - 'tscrollx', 20:46:06 INFO - 'cart']}, 20:46:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:46:06 INFO - 'tests': ['tsvgx', 20:46:06 INFO - 'tsvgr_opacity', 20:46:06 INFO - 'tart', 20:46:06 INFO - 'tscrollx', 20:46:06 INFO - 'cart']}, 20:46:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:46:06 INFO - 'tests': ['tp5o']}, 20:46:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:46:06 INFO - 'talos_options': ['--e10s'], 20:46:06 INFO - 'tests': ['tp5o']}, 20:46:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:46:06 INFO - 'talos_options': ['--xperf_path', 20:46:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:46:06 INFO - 'tests': ['tp5n']}, 20:46:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:46:06 INFO - 'talos_options': ['--e10s', 20:46:06 INFO - '--xperf_path', 20:46:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:46:06 INFO - 'tests': ['tp5n']}}, 20:46:06 INFO - 'talos.zip': {'path': '', 20:46:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:46:06 INFO - Running post-action listener: _resource_record_post_action 20:46:06 INFO - ##### 20:46:06 INFO - ##### Running create-virtualenv step. 20:46:06 INFO - ##### 20:46:06 INFO - Running pre-action listener: _resource_record_pre_action 20:46:06 INFO - Running main action method: create_virtualenv 20:46:06 INFO - Creating virtualenv /builds/slave/test/build/venv 20:46:06 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 20:46:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:46:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:46:06 INFO - Using real prefix '/usr' 20:46:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:46:06 INFO - Installing distribute.............................................................................................................................................................................................done. 20:46:08 INFO - Installing pip.................done. 20:46:08 INFO - Return code: 0 20:46:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:46:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:46:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f608a082f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1810240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189f0b0>, '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 0x189ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a0440>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1449203129.498243-731067672', '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 20:46:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:46:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:46:08 INFO - Using env: {'DISPLAY': ':0', 20:46:08 INFO - 'HOME': '/home/cltbld', 20:46:08 INFO - 'LANG': 'en_US.UTF-8', 20:46:08 INFO - 'LANGUAGE': 'en_US:en', 20:46:08 INFO - 'LOGNAME': 'cltbld', 20:46:08 INFO - 'MAIL': '/var/mail/cltbld', 20:46:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:08 INFO - 'MOZ_NO_REMOTE': '1', 20:46:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:46:08 INFO - 'NO_EM_RESTART': '1', 20:46:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:46:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:08 INFO - 'PWD': '/builds/slave/test', 20:46:08 INFO - 'SHELL': '/bin/bash', 20:46:08 INFO - 'SHLVL': '1', 20:46:08 INFO - 'TERM': 'linux', 20:46:08 INFO - 'TMOUT': '86400', 20:46:08 INFO - 'USER': 'cltbld', 20:46:08 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1449203129.498243-731067672', 20:46:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:08 INFO - '_': '/tools/buildbot/bin/python'} 20:46:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:08 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 20:46:08 INFO - Cleaning up... 20:46:08 INFO - Return code: 0 20:46:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:46:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:46:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f608a082f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1810240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189f0b0>, '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 0x189ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a0440>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1449203129.498243-731067672', '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 20:46:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 20:46:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 20:46:08 INFO - Using env: {'DISPLAY': ':0', 20:46:08 INFO - 'HOME': '/home/cltbld', 20:46:08 INFO - 'LANG': 'en_US.UTF-8', 20:46:08 INFO - 'LANGUAGE': 'en_US:en', 20:46:08 INFO - 'LOGNAME': 'cltbld', 20:46:08 INFO - 'MAIL': '/var/mail/cltbld', 20:46:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:08 INFO - 'MOZ_NO_REMOTE': '1', 20:46:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:46:08 INFO - 'NO_EM_RESTART': '1', 20:46:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:46:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:08 INFO - 'PWD': '/builds/slave/test', 20:46:08 INFO - 'SHELL': '/bin/bash', 20:46:08 INFO - 'SHLVL': '1', 20:46:08 INFO - 'TERM': 'linux', 20:46:08 INFO - 'TMOUT': '86400', 20:46:08 INFO - 'USER': 'cltbld', 20:46:08 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1449203129.498243-731067672', 20:46:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:08 INFO - '_': '/tools/buildbot/bin/python'} 20:46:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:09 INFO - Downloading/unpacking psutil>=0.7.1 20:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:46:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:46:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:46:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:46:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:46:10 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 20:46:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 20:46:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:46:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:46:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:46:10 INFO - Installing collected packages: psutil 20:46:10 INFO - Running setup.py install for psutil 20:46:10 INFO - building 'psutil._psutil_linux' extension 20:46:10 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 20:46:11 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 20:46:11 INFO - building 'psutil._psutil_posix' extension 20:46:11 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 20:46:11 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 20:46:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:46:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:46:11 INFO - Successfully installed psutil 20:46:11 INFO - Cleaning up... 20:46:11 INFO - Return code: 0 20:46:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:46:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:46:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:11 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 0x7f608a082f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1810240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189f0b0>, '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 0x189ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a0440>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1449203129.498243-731067672', '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 20:46:11 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 20:46:11 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 20:46:11 INFO - Using env: {'DISPLAY': ':0', 20:46:11 INFO - 'HOME': '/home/cltbld', 20:46:11 INFO - 'LANG': 'en_US.UTF-8', 20:46:11 INFO - 'LANGUAGE': 'en_US:en', 20:46:11 INFO - 'LOGNAME': 'cltbld', 20:46:11 INFO - 'MAIL': '/var/mail/cltbld', 20:46:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:11 INFO - 'MOZ_NO_REMOTE': '1', 20:46:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:46:11 INFO - 'NO_EM_RESTART': '1', 20:46:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:46:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:11 INFO - 'PWD': '/builds/slave/test', 20:46:11 INFO - 'SHELL': '/bin/bash', 20:46:11 INFO - 'SHLVL': '1', 20:46:11 INFO - 'TERM': 'linux', 20:46:11 INFO - 'TMOUT': '86400', 20:46:11 INFO - 'USER': 'cltbld', 20:46:11 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1449203129.498243-731067672', 20:46:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:11 INFO - '_': '/tools/buildbot/bin/python'} 20:46:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:46:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:46:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:46:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:46:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:46:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:46:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 20:46:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:46:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:46:13 INFO - Installing collected packages: mozsystemmonitor 20:46:13 INFO - Running setup.py install for mozsystemmonitor 20:46:13 INFO - Successfully installed mozsystemmonitor 20:46:13 INFO - Cleaning up... 20:46:13 INFO - Return code: 0 20:46:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:46:13 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')]} 20:46:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:13 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')]} 20:46:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:13 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 0x7f608a082f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1810240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189f0b0>, '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 0x189ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a0440>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1449203129.498243-731067672', '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 20:46:13 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 20:46:13 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 20:46:13 INFO - Using env: {'DISPLAY': ':0', 20:46:13 INFO - 'HOME': '/home/cltbld', 20:46:13 INFO - 'LANG': 'en_US.UTF-8', 20:46:13 INFO - 'LANGUAGE': 'en_US:en', 20:46:13 INFO - 'LOGNAME': 'cltbld', 20:46:13 INFO - 'MAIL': '/var/mail/cltbld', 20:46:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:13 INFO - 'MOZ_NO_REMOTE': '1', 20:46:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:46:13 INFO - 'NO_EM_RESTART': '1', 20:46:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:46:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:13 INFO - 'PWD': '/builds/slave/test', 20:46:13 INFO - 'SHELL': '/bin/bash', 20:46:13 INFO - 'SHLVL': '1', 20:46:13 INFO - 'TERM': 'linux', 20:46:13 INFO - 'TMOUT': '86400', 20:46:13 INFO - 'USER': 'cltbld', 20:46:13 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1449203129.498243-731067672', 20:46:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:13 INFO - '_': '/tools/buildbot/bin/python'} 20:46:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:13 INFO - Downloading/unpacking blobuploader==1.2.4 20:46:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:46:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:46:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:46:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:46:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:46:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:46:15 INFO - Downloading blobuploader-1.2.4.tar.gz 20:46:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 20:46:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:46:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:46:15 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 20:46:15 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 20:46:15 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 20:46:15 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 20:46:15 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 20:46:15 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 20:46:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 20:46:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:46:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:46:15 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 20:46:15 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 20:46:15 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 20:46:15 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 20:46:15 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 20:46:15 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 20:46:16 INFO - Downloading docopt-0.6.1.tar.gz 20:46:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 20:46:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:46:16 INFO - Installing collected packages: blobuploader, requests, docopt 20:46:16 INFO - Running setup.py install for blobuploader 20:46:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:46:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:46:16 INFO - Running setup.py install for requests 20:46:16 INFO - Running setup.py install for docopt 20:46:16 INFO - Successfully installed blobuploader requests docopt 20:46:16 INFO - Cleaning up... 20:46:16 INFO - Return code: 0 20:46:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:46:16 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')]} 20:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:16 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')]} 20:46:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:16 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 0x7f608a082f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1810240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189f0b0>, '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 0x189ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a0440>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1449203129.498243-731067672', '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 20:46:16 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 20:46:16 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 20:46:16 INFO - Using env: {'DISPLAY': ':0', 20:46:16 INFO - 'HOME': '/home/cltbld', 20:46:16 INFO - 'LANG': 'en_US.UTF-8', 20:46:16 INFO - 'LANGUAGE': 'en_US:en', 20:46:16 INFO - 'LOGNAME': 'cltbld', 20:46:16 INFO - 'MAIL': '/var/mail/cltbld', 20:46:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:16 INFO - 'MOZ_NO_REMOTE': '1', 20:46:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:46:16 INFO - 'NO_EM_RESTART': '1', 20:46:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:46:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:16 INFO - 'PWD': '/builds/slave/test', 20:46:16 INFO - 'SHELL': '/bin/bash', 20:46:16 INFO - 'SHLVL': '1', 20:46:16 INFO - 'TERM': 'linux', 20:46:16 INFO - 'TMOUT': '86400', 20:46:16 INFO - 'USER': 'cltbld', 20:46:16 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1449203129.498243-731067672', 20:46:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:16 INFO - '_': '/tools/buildbot/bin/python'} 20:46:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:46:16 INFO - Running setup.py (path:/tmp/pip-jOoLIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:46:17 INFO - Running setup.py (path:/tmp/pip-CQD2vH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:46:17 INFO - Running setup.py (path:/tmp/pip-UKQH0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:46:17 INFO - Running setup.py (path:/tmp/pip-B6ghTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:46:17 INFO - Running setup.py (path:/tmp/pip-Edln2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:46:17 INFO - Running setup.py (path:/tmp/pip-mXOTPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:46:17 INFO - Running setup.py (path:/tmp/pip-n3VjcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:46:17 INFO - Running setup.py (path:/tmp/pip-Cn6mQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:46:17 INFO - Running setup.py (path:/tmp/pip-fGxQMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:46:17 INFO - Running setup.py (path:/tmp/pip-3TtugM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:46:17 INFO - Running setup.py (path:/tmp/pip-PbtXcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:46:17 INFO - Running setup.py (path:/tmp/pip-PIE2mn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:46:17 INFO - Running setup.py (path:/tmp/pip-Pk7YbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:46:17 INFO - Running setup.py (path:/tmp/pip-Rpj8CD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:46:17 INFO - Running setup.py (path:/tmp/pip-wXVKXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:46:18 INFO - Running setup.py (path:/tmp/pip-amcbj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:46:18 INFO - Running setup.py (path:/tmp/pip-ZU6YUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:46:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:46:18 INFO - Running setup.py install for manifestparser 20:46:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:46:18 INFO - Running setup.py install for mozcrash 20:46:18 INFO - Running setup.py install for mozdebug 20:46:18 INFO - Running setup.py install for mozdevice 20:46:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:46:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:46:18 INFO - Running setup.py install for mozfile 20:46:18 INFO - Running setup.py install for mozhttpd 20:46:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:46:18 INFO - Running setup.py install for mozinfo 20:46:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:46:18 INFO - Running setup.py install for mozInstall 20:46:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:46:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:46:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:46:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:46:18 INFO - Running setup.py install for mozleak 20:46:19 INFO - Running setup.py install for mozlog 20:46:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:46:19 INFO - Running setup.py install for moznetwork 20:46:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:46:19 INFO - Running setup.py install for mozprocess 20:46:19 INFO - Running setup.py install for mozprofile 20:46:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:46:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:46:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:46:19 INFO - Running setup.py install for mozrunner 20:46:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:46:19 INFO - Running setup.py install for mozscreenshot 20:46:19 INFO - Running setup.py install for moztest 20:46:19 INFO - Running setup.py install for mozversion 20:46:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:46:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:46:19 INFO - Cleaning up... 20:46:19 INFO - Return code: 0 20:46:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:46:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:46:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:46:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x7f608a082f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1810240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189f0b0>, '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 0x189ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a0440>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1449203129.498243-731067672', '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 20:46:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 20:46:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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 20:46:19 INFO - Using env: {'DISPLAY': ':0', 20:46:19 INFO - 'HOME': '/home/cltbld', 20:46:19 INFO - 'LANG': 'en_US.UTF-8', 20:46:19 INFO - 'LANGUAGE': 'en_US:en', 20:46:19 INFO - 'LOGNAME': 'cltbld', 20:46:19 INFO - 'MAIL': '/var/mail/cltbld', 20:46:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:19 INFO - 'MOZ_NO_REMOTE': '1', 20:46:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:46:19 INFO - 'NO_EM_RESTART': '1', 20:46:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:46:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:19 INFO - 'PWD': '/builds/slave/test', 20:46:19 INFO - 'SHELL': '/bin/bash', 20:46:19 INFO - 'SHLVL': '1', 20:46:19 INFO - 'TERM': 'linux', 20:46:19 INFO - 'TMOUT': '86400', 20:46:19 INFO - 'USER': 'cltbld', 20:46:19 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1449203129.498243-731067672', 20:46:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:19 INFO - '_': '/tools/buildbot/bin/python'} 20:46:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:46:20 INFO - Running setup.py (path:/tmp/pip-nNdTFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:46:20 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)) 20:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:46:20 INFO - Running setup.py (path:/tmp/pip-Cxk3po-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:46:20 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)) 20:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:46:20 INFO - Running setup.py (path:/tmp/pip-YWiNIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:46:20 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)) 20:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:46:20 INFO - Running setup.py (path:/tmp/pip-v0nTtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:46:20 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)) 20:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:46:20 INFO - Running setup.py (path:/tmp/pip-b1ibD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:46:20 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)) 20:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:46:20 INFO - Running setup.py (path:/tmp/pip-u14dvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:46:20 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)) 20:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:46:20 INFO - Running setup.py (path:/tmp/pip-LYsQNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:46:20 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)) 20:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:46:20 INFO - Running setup.py (path:/tmp/pip-2Wwktw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:46:20 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)) 20:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:46:20 INFO - Running setup.py (path:/tmp/pip-Xolm0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:46:20 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)) 20:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:46:20 INFO - Running setup.py (path:/tmp/pip-_iHAX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:46:20 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)) 20:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:46:20 INFO - Running setup.py (path:/tmp/pip-hN05DV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:46:21 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)) 20:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:46:21 INFO - Running setup.py (path:/tmp/pip-pM3Eaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:46:21 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)) 20:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:46:21 INFO - Running setup.py (path:/tmp/pip-RP6nqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:46:21 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)) 20:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:46:21 INFO - Running setup.py (path:/tmp/pip-oTx_q6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:46:21 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)) 20:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:46:21 INFO - Running setup.py (path:/tmp/pip-TlTkGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:46:21 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)) 20:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:46:21 INFO - Running setup.py (path:/tmp/pip-SYedrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:46:21 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)) 20:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:46:21 INFO - Running setup.py (path:/tmp/pip-vFHFtj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:46:21 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)) 20:46:21 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)) 20:46:21 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)) 20:46:21 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)) 20:46:21 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)) 20:46:21 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)) 20:46:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:46:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:46:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:46:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:46:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:46:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:46:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:46:23 INFO - Downloading blessings-1.5.1.tar.gz 20:46:23 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 20:46:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:46:23 INFO - Installing collected packages: blessings 20:46:23 INFO - Running setup.py install for blessings 20:46:23 INFO - Successfully installed blessings 20:46:23 INFO - Cleaning up... 20:46:23 INFO - Return code: 0 20:46:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:46:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:46:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:46:23 INFO - Reading from file tmpfile_stdout 20:46:23 INFO - Current package versions: 20:46:23 INFO - argparse == 1.2.1 20:46:23 INFO - blessings == 1.5.1 20:46:23 INFO - blobuploader == 1.2.4 20:46:23 INFO - docopt == 0.6.1 20:46:23 INFO - manifestparser == 1.1 20:46:23 INFO - mozInstall == 1.12 20:46:23 INFO - mozcrash == 0.16 20:46:23 INFO - mozdebug == 0.1 20:46:23 INFO - mozdevice == 0.47 20:46:23 INFO - mozfile == 1.2 20:46:23 INFO - mozhttpd == 0.7 20:46:23 INFO - mozinfo == 0.9 20:46:23 INFO - mozleak == 0.1 20:46:23 INFO - mozlog == 3.1 20:46:23 INFO - moznetwork == 0.27 20:46:23 INFO - mozprocess == 0.22 20:46:23 INFO - mozprofile == 0.27 20:46:23 INFO - mozrunner == 6.11 20:46:23 INFO - mozscreenshot == 0.1 20:46:23 INFO - mozsystemmonitor == 0.0 20:46:23 INFO - moztest == 0.7 20:46:23 INFO - mozversion == 1.4 20:46:23 INFO - psutil == 3.1.1 20:46:23 INFO - requests == 1.2.3 20:46:23 INFO - wsgiref == 0.1.2 20:46:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:46:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:46:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:23 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 0x7f608a082f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1810240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189f0b0>, '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 0x189ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a0440>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1449203129.498243-731067672', '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 20:46:23 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 20:46:23 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 20:46:23 INFO - Using env: {'DISPLAY': ':0', 20:46:23 INFO - 'HOME': '/home/cltbld', 20:46:23 INFO - 'LANG': 'en_US.UTF-8', 20:46:23 INFO - 'LANGUAGE': 'en_US:en', 20:46:23 INFO - 'LOGNAME': 'cltbld', 20:46:23 INFO - 'MAIL': '/var/mail/cltbld', 20:46:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:23 INFO - 'MOZ_NO_REMOTE': '1', 20:46:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:46:23 INFO - 'NO_EM_RESTART': '1', 20:46:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:46:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:23 INFO - 'PWD': '/builds/slave/test', 20:46:23 INFO - 'SHELL': '/bin/bash', 20:46:23 INFO - 'SHLVL': '1', 20:46:23 INFO - 'TERM': 'linux', 20:46:23 INFO - 'TMOUT': '86400', 20:46:23 INFO - 'USER': 'cltbld', 20:46:23 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1449203129.498243-731067672', 20:46:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:23 INFO - '_': '/tools/buildbot/bin/python'} 20:46:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:23 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)) 20:46:23 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)) 20:46:23 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)) 20:46:23 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)) 20:46:23 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)) 20:46:23 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)) 20:46:23 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)) 20:46:23 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)) 20:46:23 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)) 20:46:23 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)) 20:46:23 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)) 20:46:23 INFO - Cleaning up... 20:46:23 INFO - Return code: 0 20:46:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:46:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:46:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:23 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 0x7f608a082f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1810240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189f0b0>, '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 0x189ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a0440>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1449203129.498243-731067672', '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 20:46:23 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 20:46:23 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 20:46:23 INFO - Using env: {'DISPLAY': ':0', 20:46:23 INFO - 'HOME': '/home/cltbld', 20:46:23 INFO - 'LANG': 'en_US.UTF-8', 20:46:23 INFO - 'LANGUAGE': 'en_US:en', 20:46:23 INFO - 'LOGNAME': 'cltbld', 20:46:23 INFO - 'MAIL': '/var/mail/cltbld', 20:46:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:23 INFO - 'MOZ_NO_REMOTE': '1', 20:46:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:46:23 INFO - 'NO_EM_RESTART': '1', 20:46:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:46:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:23 INFO - 'PWD': '/builds/slave/test', 20:46:23 INFO - 'SHELL': '/bin/bash', 20:46:23 INFO - 'SHLVL': '1', 20:46:23 INFO - 'TERM': 'linux', 20:46:23 INFO - 'TMOUT': '86400', 20:46:23 INFO - 'USER': 'cltbld', 20:46:23 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1449203129.498243-731067672', 20:46:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:23 INFO - '_': '/tools/buildbot/bin/python'} 20:46:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:24 INFO - Downloading/unpacking jsonschema 20:46:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:46:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:46:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:46:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:46:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:46:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:46:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:46:25 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 20:46:25 INFO - Downloading/unpacking functools32 (from jsonschema) 20:46:25 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 20:46:25 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 20:46:25 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 20:46:25 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 20:46:25 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 20:46:25 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 20:46:25 INFO - Downloading functools32-3.2.3-2.tar.gz 20:46:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 20:46:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:46:25 INFO - warning: no files found matching '*.txt' 20:46:25 INFO - no previously-included directories found matching 'build' 20:46:25 INFO - no previously-included directories found matching 'dist' 20:46:25 INFO - no previously-included directories found matching '.git*' 20:46:26 INFO - Installing collected packages: jsonschema, functools32 20:46:26 INFO - Running setup.py install for functools32 20:46:26 INFO - warning: no files found matching '*.txt' 20:46:26 INFO - no previously-included directories found matching 'build' 20:46:26 INFO - no previously-included directories found matching 'dist' 20:46:26 INFO - no previously-included directories found matching '.git*' 20:46:26 INFO - Successfully installed jsonschema functools32 20:46:26 INFO - Cleaning up... 20:46:26 INFO - Return code: 0 20:46:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:46:26 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')]} 20:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:26 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')]} 20:46:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:26 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 0x7f608a082f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1810240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189f0b0>, '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 0x189ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a0440>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1449203129.498243-731067672', '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 20:46:26 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 20:46:26 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 20:46:26 INFO - Using env: {'DISPLAY': ':0', 20:46:26 INFO - 'HOME': '/home/cltbld', 20:46:26 INFO - 'LANG': 'en_US.UTF-8', 20:46:26 INFO - 'LANGUAGE': 'en_US:en', 20:46:26 INFO - 'LOGNAME': 'cltbld', 20:46:26 INFO - 'MAIL': '/var/mail/cltbld', 20:46:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:26 INFO - 'MOZ_NO_REMOTE': '1', 20:46:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:46:26 INFO - 'NO_EM_RESTART': '1', 20:46:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:46:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:26 INFO - 'PWD': '/builds/slave/test', 20:46:26 INFO - 'SHELL': '/bin/bash', 20:46:26 INFO - 'SHLVL': '1', 20:46:26 INFO - 'TERM': 'linux', 20:46:26 INFO - 'TMOUT': '86400', 20:46:26 INFO - 'USER': 'cltbld', 20:46:26 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1449203129.498243-731067672', 20:46:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:26 INFO - '_': '/tools/buildbot/bin/python'} 20:46:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:26 INFO - Downloading/unpacking flake8 20:46:26 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 20:46:26 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 20:46:26 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 20:46:26 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 20:46:26 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 20:46:26 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 20:46:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:46:28 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 20:46:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:46:28 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 20:46:28 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 20:46:28 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 20:46:28 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 20:46:28 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 20:46:28 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 20:46:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:46:28 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 20:46:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:46:28 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 20:46:28 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 20:46:28 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 20:46:28 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 20:46:28 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 20:46:28 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 20:46:28 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 20:46:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:46:28 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 20:46:28 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 20:46:28 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 20:46:28 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 20:46:28 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 20:46:28 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 20:46:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 20:46:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:46:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:46:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:46:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:46:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:46:28 INFO - no previously-included directories found matching 'docs/_build' 20:46:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:46:28 INFO - Running setup.py install for pep8 20:46:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:46:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:46:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:46:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:46:28 INFO - no previously-included directories found matching 'docs/_build' 20:46:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:46:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:46:28 INFO - Cleaning up... 20:46:28 INFO - Return code: 0 20:46:28 INFO - Running post-action listener: _resource_record_post_action 20:46:28 INFO - Running post-action listener: _start_resource_monitoring 20:46:28 INFO - Starting resource monitoring. 20:46:28 INFO - ##### 20:46:28 INFO - ##### Running install step. 20:46:28 INFO - ##### 20:46:28 INFO - Running pre-action listener: _resource_record_pre_action 20:46:28 INFO - Running main action method: install 20:46:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:46:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:46:29 INFO - Reading from file tmpfile_stdout 20:46:29 INFO - Detecting whether we're running mozinstall >=1.0... 20:46:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:46:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:46:29 INFO - Reading from file tmpfile_stdout 20:46:29 INFO - Output received: 20:46:29 INFO - Usage: mozinstall [options] installer 20:46:29 INFO - Options: 20:46:29 INFO - -h, --help show this help message and exit 20:46:29 INFO - -d DEST, --destination=DEST 20:46:29 INFO - Directory to install application into. [default: 20:46:29 INFO - "/builds/slave/test"] 20:46:29 INFO - --app=APP Application being installed. [default: firefox] 20:46:29 INFO - mkdir: /builds/slave/test/build/application 20:46:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:46:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:46:44 INFO - Reading from file tmpfile_stdout 20:46:44 INFO - Output received: 20:46:44 INFO - /builds/slave/test/build/application/firefox/firefox 20:46:44 INFO - Running post-action listener: _resource_record_post_action 20:46:44 INFO - ##### 20:46:44 INFO - ##### Running run-tests step. 20:46:44 INFO - ##### 20:46:44 INFO - Running pre-action listener: _resource_record_pre_action 20:46:44 INFO - Running main action method: run_tests 20:46:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:46:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:46:44 INFO - Python 2.7.3 20:46:44 INFO - Return code: 0 20:46:44 INFO - grabbing minidump binary from tooltool 20:46:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:46:44 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 0x189f0b0>, '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 0x189ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a0440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:46:44 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 20:46:44 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 20:46:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:46:44 INFO - Return code: 0 20:46:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:46:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:46:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:46:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:46:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:46:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:46:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:46:45 INFO - Return code: 0 20:46:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Ash-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bNvlkaFfQgma7Y0-f3h5og/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost'] in /builds/slave/test/build 20:46:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Ash-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bNvlkaFfQgma7Y0-f3h5og/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost 20:46:45 INFO - Using env: {'DISPLAY': ':0', 20:46:45 INFO - 'HOME': '/home/cltbld', 20:46:45 INFO - 'LANG': 'en_US.UTF-8', 20:46:45 INFO - 'LANGUAGE': 'en_US:en', 20:46:45 INFO - 'LOGNAME': 'cltbld', 20:46:45 INFO - 'MAIL': '/var/mail/cltbld', 20:46:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:46:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:46:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:45 INFO - 'MOZ_NO_REMOTE': '1', 20:46:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:46:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:46:45 INFO - 'NO_EM_RESTART': '1', 20:46:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:46:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:45 INFO - 'PWD': '/builds/slave/test', 20:46:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:46:45 INFO - 'SHELL': '/bin/bash', 20:46:45 INFO - 'SHLVL': '1', 20:46:45 INFO - 'TERM': 'linux', 20:46:45 INFO - 'TMOUT': '86400', 20:46:45 INFO - 'USER': 'cltbld', 20:46:45 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1449203129.498243-731067672', 20:46:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:45 INFO - '_': '/tools/buildbot/bin/python'} 20:46:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Ash-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bNvlkaFfQgma7Y0-f3h5og/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost'] with output_timeout 3600 20:46:45 INFO - mozversion INFO | application_buildid: 20151203193821 20:46:45 INFO - mozversion INFO | application_changeset: e442bf66404c23b17ce4577f9e4a102c1b63057e 20:46:45 INFO - mozversion INFO | application_display_name: Nightly 20:46:45 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:46:45 INFO - mozversion INFO | application_name: Firefox 20:46:45 INFO - mozversion INFO | application_remotingname: firefox 20:46:45 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/projects/ash 20:46:45 INFO - mozversion INFO | application_vendor: Mozilla 20:46:45 INFO - mozversion INFO | application_version: 45.0a1 20:46:45 INFO - mozversion INFO | platform_buildid: 20151203193821 20:46:45 INFO - mozversion INFO | platform_changeset: e442bf66404c23b17ce4577f9e4a102c1b63057e 20:46:45 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/projects/ash 20:46:45 INFO - mozversion INFO | platform_version: 45.0a1 20:46:45 INFO - 2015-12-03 20:46:45,871 DEBUG : using testdate: 1449204405 20:46:45 INFO - 2015-12-03 20:46:45,871 DEBUG : actual date: 1449204405 20:46:45 INFO - 2015-12-03 20:46:45,918 INFO : starting webserver on 'localhost:54296' 20:46:45 INFO - 2015-12-03 20:46:45,919 INFO : Starting test suite talos-linux64-ix-060 20:46:45 INFO - 2015-12-03 20:46:45,919 INFO : Starting test dromaeo_css 20:46:45 INFO - 2015-12-03 20:46:45,919 DEBUG : operating with platform_type : linux_ 20:46:45 INFO - 2015-12-03 20:46:45,920 INFO : Initialising browser for dromaeo_css test... 20:46:45 INFO - 2015-12-03 20:46:45,937 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU64mJM/profile http://localhost:54296/getInfo.html 20:46:49 INFO - 2015-12-03 20:46:49,870 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:46:49 INFO - 2015-12-03 20:46:49,870 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:46:49 INFO - 2015-12-03 20:46:49,870 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:46:49 INFO - 2015-12-03 20:46:49,870 DEBUG : BROWSER_OUTPUT: __metrics 20:46:49 INFO - 2015-12-03 20:46:49,934 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] 20:46:49 INFO - 2015-12-03 20:46:49,990 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:46:51 INFO - 2015-12-03 20:46:51,808 INFO : Browser initialized. 20:46:51 INFO - 2015-12-03 20:46:51,809 INFO : Running cycle 1/1 for dromaeo_css test... 20:46:51 INFO - 2015-12-03 20:46:51,809 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU64mJM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:47:03 INFO - 2015-12-03 20:47:03,822 DEBUG : BROWSER_OUTPUT: RSS: Main: 150470656 20:47:03 INFO - 2015-12-03 20:47:03,822 DEBUG : BROWSER_OUTPUT: 20:47:55 INFO - 2015-12-03 20:47:55,075 DEBUG : BROWSER_OUTPUT: 1449204475068 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] 20:50:06 INFO - 2015-12-03 20:50:06,816 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54296/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54296/tests/dromaeo/cssquery-ext.html) 20:50:08 INFO - 2015-12-03 20:50:08,003 DEBUG : BROWSER_OUTPUT: RSS: Main: 256008192 20:50:08 INFO - 2015-12-03 20:50:08,003 DEBUG : BROWSER_OUTPUT: 20:53:10 INFO - 2015-12-03 20:53:10,570 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54296/tests/dromaeo/cssquery-ext.html (next: http://localhost:54296/tests/dromaeo/cssquery-jquery.html) 20:53:11 INFO - 2015-12-03 20:53:11,136 DEBUG : BROWSER_OUTPUT: RSS: Main: 228253696 20:53:11 INFO - 2015-12-03 20:53:11,136 DEBUG : BROWSER_OUTPUT: 20:56:13 INFO - 2015-12-03 20:56:13,122 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54296/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54296/tests/dromaeo/cssquery-mootools.html) 20:56:13 INFO - 2015-12-03 20:56:13,708 DEBUG : BROWSER_OUTPUT: RSS: Main: 220094464 20:56:13 INFO - 2015-12-03 20:56:13,709 DEBUG : BROWSER_OUTPUT: 20:59:15 INFO - 2015-12-03 20:59:15,756 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54296/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54296/tests/dromaeo/cssquery-prototype.html) 20:59:16 INFO - 2015-12-03 20:59:16,325 DEBUG : BROWSER_OUTPUT: RSS: Main: 212127744 20:59:16 INFO - 2015-12-03 20:59:16,325 DEBUG : BROWSER_OUTPUT: 21:02:19 INFO - 2015-12-03 21:02:19,015 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54296/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54296/tests/dromaeo/cssquery-yui.html) 21:02:19 INFO - 2015-12-03 21:02:19,588 DEBUG : BROWSER_OUTPUT: RSS: Main: 216854528 21:02:19 INFO - 2015-12-03 21:02:19,588 DEBUG : BROWSER_OUTPUT: 21:05:22 INFO - 2015-12-03 21:05:22,123 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54296/tests/dromaeo/cssquery-yui.html (next: http://localhost:54296/tests/dromaeo/cssquery-dojo.html) 21:05:22 INFO - 2015-12-03 21:05:22,373 DEBUG : BROWSER_OUTPUT: RSS: Main: 232038400 21:05:22 INFO - 2015-12-03 21:05:22,373 DEBUG : BROWSER_OUTPUT: 21:05:22 INFO - 2015-12-03 21:05:22,374 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:05:22 INFO - 2015-12-03 21:05:22,374 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:05:22 INFO - 2015-12-03 21:05:22,375 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:05:22 INFO - 2015-12-03 21:05:22,375 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:05:22 INFO - 2015-12-03 21:05:22,378 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2593.5331640304744;2683.8255513391614;2687.2878687147895;2698.069166137683;2713.3759235375865;4464.977675111628;4564.406627138475;4633.8609841704765;4646.9079766254945;4682;4494.2359798834195;4542.409486766715;4633.119707255619;4633.374494443249;4642.744649044301;4087.9386809197886;4247.384129301249;4255.1915136124035;4257.723247988879;4340.544242854502;4288.807003684841;4357;4360;4364.476262848462;4405.295152775557;4076.5311989121333;4182.56083111275;4210.936835947463;4293.141371725667;4331.198728235255;4273.166732487166;4283.87148385549;4287.506936702288;4290.377895205209;4318.287482565373;4274.978625106854;4275.893102672427;4299.973131387486;4305.461817272841;4311.719738217037;4344.152890186415;4443.266860967937;4450.933236001462;4506.278995360726;4624.791884365211;4932.950670493285;4987.576056035241;4987.750612469362;4989.301497790312;5030.421501527335;5004.924926126111;5011.824586139468;5012.147934851084;5015;5042.042012017705;4385.912281754379;4475.910481790346;4477.865664030084;4581.106684196617;4709.505501922317;5058.4435712071645;5067.721275329893;5070.61970352225;5073.594112470993;5073.923891141636;4858.975705121452;4882.926756098661;4884.706917584886;4886.071646387175;4927.7536123193695;4729.337892695025;4840.298156767249;4845.030993801254;4873.707577545359;4980.950190498121;4895.143349913751;4942.9258561121615;4942.975285123552;4945.3571035765835;4989.226669866104;4915.754212289371;4915.9508404916205;4916.975415122902;4919.188333924933;4959.553640172329;3938.940915886264;4033.253848038122;4036.9394459083137;4077.1641813428178;4088.6115818997146;3560.003199104255;3574.928501430009;3579.4451859961746;3591.1919818040733;3615.1504396466808;4270.572942705767;4295.076558539929;4297.39836422901;4309.698321117492;4339.240632889232;4732.52674732524;4813.927791083137;4852.126617208936;4920.384951881015;5067.189249720027;4311.288637374861;4329.2640251156745;4345.435093437833;4347.369631403492;4382.342648602735;4411.228035093845;4445.977770111193;4449.844255451044;4452.703141468499;4494.640428765691;4510.706804057726;4613.5847773700525;4614.930776038362;4634.814607415666;4735.526447355237;5027.597792176544;5038.168702164102;5038.193888977746;5058.114829904678;5066.594672426123;4782.569568738831;4782.689125206851;4784.043191361811;4792.281157826214;4801.1117943180625;4696.647751418589;4799.448063472745;4804.135255654016;4890.070886531547;4999.400071991239;4964.032013757283;4965.900681986413;4966.776495057658;4993.525615066563;5017.799288028438;4806.591439727662;4808.8797780055775;4809.95190048109;4811.591014763784;4858;4645.163870503342;4770.950390913993;4774.045190961891;4803.927941080817;4857.878553036202;4578.130155270488;4629.722216667011;4644.558766917137;4689.179393606173;4699.412573428322;4832.830850920201;4901.387326584177;4903.215485522299;4903.509649035068;4947.802087916587;4460.30865215892;4554.681172317906;4736.313234580897;4776.116418462596;4786.856394308176 21:05:22 INFO - 2015-12-03 21:05:22,379 DEBUG : BROWSER_OUTPUT: |1;ext.html;552.206482097822;560.6187792301233;569.4817715878552;571.7512881896374;587.3069777662358;27917;28300.716992830115;28381.148565543015;28445.715542844566;28466.85766571167;37680.43479347805;38540.61459385405;38569.807150964276;38621.22757544847;38684.226315473745;7781.883271750914;7936.325412339958;7951.244631760002;7958.602069896511;7961.920380796176;7071.85856282874;7278.781636550885;7837.216278372146;7915.366770658334;10084.647037353694;10119.595216191343;10223.846642300372;10231;10232.07911287984;10248.282620216587;10045.949770251138;10117.645882394154;10140.543675534545;10151;10154.847677284846;9725.367851089657;9888.653897113638;9940.155086817556;9947.90052099477;9950.751231219205;38380;38793.612063879285;38810;38895.22209555793;38926.02684932871;2801.453716525278;2857.4713677969644;2897.608822808936;3315.436375816093;3422.4866270059692;28219;28419;28452.004179853604;28680.569791453145;28824.855875720696;3459.896203113911;3503.1242189452637;3503.597086335053;3592.8562857485667;3593.586737525192;230292;230425;230850.84574577186;231088;232372;47396;47997.76001120042;56654.7167264161;57021.42978570161;57022.42977570254;59997;61896.69051654803;62072.68963655153;62184.68907655523;62199.6890015547;12925.54760583375;13011;13051.21692698441;13086.803697944539;13104.2137471752;8290.709825156091;8511.148885111563;8513.063563008063;8528.872066919;9624.085711857502;19009.42971710851;19280.32518861833;19329.80670193308;19370.80629193718;19498.415047548595;6809.625470599066;7074.646267686595;7115.466340024519;7156.3898122922965;7212.495125341281;819.5861090149436;833.3666413525643;878.3719640457103;986.4722373530127;1072.8337107748312;24561.508769824504;24746.381340466633;24839.62740558893;25019.749802502105;25118.24645260645;915.4507295622707;926.745145085107;929.2705226397246;947.516766449116;1007.4056306779036;12826.102172847997;12904.96463812091;12970.416331265116;13058.804117938238;13351.599452016455;271344;273238;273626;274846;276046;46036;46254.306185407244;46260;46267.074658506644;46291.76854115708;1223.2599277437023;1235.6293112066523;1237.3998610673816;1250.2373552133192;1352.8714772096635;24587.87706061458;25177.37056573527;25583.872080639478;25616.871915640302;25682.229533114038;39484.60515394809;39837.40243896286;39904;39913.2017359657;39919.80040099781;250689;252087;252985;253187;253337;24355.564443555504;25311.746882531676;25326.620100698136;27997.160085197476;28801.279968000967;33673;36844.26311473809;37224.81387593045;37530;37751.81124094472;31500.536708355907;31994.6800532001;32298.515522266716;32744.50883236801;33095.50356744699;32283;32679.50980735243;32780.67219327872;32886.34227315488;33770;28188.295292617848;28719.138425847257;33502.99491015273;33566;34003.65996340005;26982.730172698022;30035.549466758453;30469.847650761603;31692.524612130375;32668.83665581657;23458.01213793625;23565.64651530194;23675.64486532669;23901.163459279538;24074.27777166688 21:05:22 INFO - 2015-12-03 21:05:22,382 DEBUG : BROWSER_OUTPUT: |2;jquery.html;326.9574955255818;332.81362437035244;335.3740214123414;335.68948722431753;337.0495203526056;12601.684957876058;12980.091393602452;15039.624009399771;15585.22073896305;15800.68398632028;11430.485628146733;13741.58775236742;13756.449742010333;14005.089669171497;14017.088889222194;4591.885202869921;4684.273937539687;4733.053389322149;4739.028499157665;5075.441701412841;5033;5067.265246539249;5069.797208111671;5074.898502029957;5075.137226671456;4949.331840201581;5010.298558201855;5012.72430016349;5024.748762561876;5025.3467049283545;4957.652964292501;4970.378702662168;4982.501749825006;4986.301917731521;4987.975060124694;4435.556444355571;4436.134953684033;4436.157130145262;4437.600615944548;4438.911221775578;18758.34345797904;18784.812151878443;19214.61570768591;19243.749156304937;19255.748376355634;1819.3359423810214;1877.6244751049844;1931.33368987699;1931.768187817457;1956.9608607827906;9095.727128186165;9316.347855650107;12227.14409991301;12420.62738117858;12882.871171288354;1702.9744553831702;1751.8686098542532;1763.3475614022893;1769.575301927528;1771.477414162825;51702;52420;54649.45350546523;54714;55452.16821747637;9416;9530.95234523823;9557.139857412867;9579.994100619473;9614.855777163348;10329.12202462784;10630;11765.352905590275;11782;22149.224777133044;8024.959875200587;8042.798930026796;8127.634256458356;8155.79610509742;8364.414490985573;6535.150430444012;6552.57408268461;6646.102776125258;6663.167104111986;6744.359285867835;7548;7617.581033043236;7625.428092893055;7651.732189373345;7736.883946740803;2943.6909124541617;2991.760659147263;3032.6360836699737;3046.162305366042;3095.3654500827274;888.9555522223992;919.6689191890914;956.9664762056962;980.3431700760508;995.5121990224737;15760.211989400485;15785.605359866095;15837.604059898595;16141.757873631905;16170.919145404197;829.9751007469786;874.3879284500874;879.6745204274459;881.4490943160524;882.7263548300048;8077.2554916644085;9314.161725444743;9367.156955874005;9407.106324899123;9745.220382369393;475751;482262;483733;486466;487121;73006;73321.26678733251;73669.6316518414;74176;74471;1050.4296077364388;1059.4702648675661;1060.2631171335847;1081.0108750493368;1082.1396989393452;11421;14407.78388324197;14654.853451465775;14726.190059546827;14730.779038314648;29949;29955.70044299529;31671.366572667957;34001;35458.64541354657;42765.144697105265;43645.12709745724;43766.78116609396;45303.77348113238;46836.53163468322;8839.734807955772;8899.599518021834;9072.047435019227;9073.274138068806;9074.31942604294;15832.28754706064;16055.116968566841;16535.751963720795;16575.41986030483;16576.502704918872;13137.211767293993;13580.25308608036;13823.86176138266;14047;14062.648433789238;13229.140105893086;13256.668583285495;13262.53581124656;13692.863071369158;13868.237246951514;13477.123986940818;13804.240766757925;13874.791878121634;14033.719325613227;14272.14367137975;8851.380403371702;9101.954490227507;9265.073492650681;9271;9289.303302252494;9657.613695452103;9759.560819762986;10940.945295273472;13212.339383031001;13250.536231231861 21:05:22 INFO - 2015-12-03 21:05:22,382 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1418.5957002254358;1617.684551512455;1664.7752553405294;1688.662267546491;1690.1718158102533;5702.771889124435;7038.6128762918015;7194.820129496765;7196.856062878739;7209.206987231413;6905.378515933565;7055.365017148456;7061.8940715889175;7073.115860517435;7078.150621925363;1754.2106052276526;1783.0015191492805;2039.3270220827167;2054.7226124473154;2104.6948192512077;2085.14509051289;2088.550961543268;2091.759447663523;2095.4970807006284;2098.213170061227;2003.388966365258;2024.1498570600384;2047.2118234479683;2051.7435320584927;2052.9940329238716;2030.7258520099745;2055.9074841632164;2076.0346438905904;2076.9480762980897;2083.510375061867;2073.9896300518553;2093.058123844276;2098.6222479953603;2098.674705420662;2100.6218880601486;7114.359707626287;7150.606716630583;7153.141623005273;7171.211166771651;7180.928190718078;4153.190127925056;4200.978995105005;4208.789560521962;4221.02916329246;4227.450431443924;2368.171140100968;2714.09077958884;2818.309514169021;2827.660680718327;2840.4603125406106;850.0479463001416;852.6376290076693;895.852184389575;936.8079543693594;946.4463288975958;9210.769730756718;9228.538573071386;9235.399699019543;9265.768355791091;9274.165325120704;3951.0517475806173;3968.404739289072;4038.656714179269;4050.0482386639114;4105.753654780723;8086.838263234702;8087.110417854032;8099.635516401659;8158.551279679675;8221;4284.4430224070675;4287.056847493546;4291.957080429218;4298.26929421999;4298.76356800379;3889.144388234584;3892.065904182976;3897.415387691869;3901.51231096113;3902.2780785554764;2892.4938135826146;3041.2548925513393;3354.8825791097684;3439.8280085995602;3527.876524321636;1114.1588100983868;1138.8007098757685;1140.6920131564598;1145.1010956399186;1149.7068247596976;1148.3683973814536;1165.5454372794618;1189.8393716848288;1216.6289281769145;1217.5129948020863;6766.28953959837;6767.627780472023;6795.898061529081;6796;6816.147981502312;1033.834586466162;1073.8013467508536;1076.4025965589017;1079.8056349856945;1111.944402779874;5267.604929630293;5345.770472791202;5362.812301569426;5384.596155288369;5409.026375252413;8373.916260837314;8448.155184481502;8574.657013719507;8601.354898382646;8604.31165506758;8276.131006244377;8369.832603347899;8408.873866892001;8525.531095789667;8527.872081918777;5997.400259974055;6261.843453913689;6269.373062693694;6293.779717709858;6313.273973493016;6520.152380190545;6679.56582822115;6691.933080669326;6725.630090345078;6756.898646520208;7366.742164024234;7502.624868756649;7588.354989825927;7667.271609197117;7672.194419585863;7713.267239612228;7840.137584865774;7862.921370786219;7950.642221099949;7976.481528700616;5655.151727240782;6147.877042459215;6148.354422785722;6190.566660333733;6253.906191407042;5729.71351432435;5929.436703513159;6567.671616419065;6722.428593569602;6751.122354094133;6000.5799594028;6028.788992385245;6309.179806625109;6316.684165791784;6542.247641521286;6188.164597779422;6207.96896015517;6250.812475625738;6393.392627700361;6407.903881441689;6297;6369.808905732835;6376.202974628171;6393.041043843275;6395.232572091379;5937.960856849948;5952.851178720567;5963.493103086286;5963.493103086286;5964.970175149097;5762.567807414377;5855.121731740273;5963;5989.311229208697;6015.6691381974415 21:05:22 INFO - 2015-12-03 21:05:22,382 DEBUG : BROWSER_OUTPUT: |4;prototype.html;292.2139444893237;297.06276697020877;298.4314880153309;300.3452473607536;301.9048999565137;5215.113430716778;5279.20811878218;5289.920651190235;5295.8146464873735;5356.276902618155;4971.801127954886;5091.847244582668;5132.153194722866;5245.86885327867;5269.947300526994;4081.8979525511804;4083.4283200351974;4085.0400155963325;4086.5913408659194;4090.8772736817796;3878.9030274243228;4080.9795951020205;4082.7346222495444;4086.9795651021705;4089.9182016359655;3938.487996560443;3947.2105578884193;4015.4779878615886;4030.798460076999;4063.4920634920636;4032.052467670095;4034.979825100885;4045.352743561031;4050.574689657573;4054.5742697016685;3566.1262990567216;3566.857325706969;3567.0369000369756;3570.946435803465;3575.3921833288405;5093.541581257705;5095.388553373619;5102.38771347437;5111.718855462948;5111.974440127813;4571.657125715551;4664.696794708333;4680.602148817355;4688.367070445481;4691.953080469186;5500.752466138993;5506.339239291271;5510.173473978895;5513.20058591506;5521.033819081685;3875.2830726315724;3881.786501742403;3888.105735680781;3888.183481468895;3899.220155968789;5787.884242315172;5808;5811.767529298865;5817.418258174149;5819.67991760453;3905.906346223062;4009.9599004009588;4012.0772222389014;4018.3570628699267;4025.9798701006894;4067.3695577185586;4068.5931406859077;4073.735207211522;4074.837006519706;4075.286824805647;4622;4633.629309655287;4640.23436133041;4641.234196357564;4643.74459404736;5520.641158324696;5528.806491772769;5528.889422211533;5530.032244357221;5530.419305972815;1414.5968399006233;1414.9575512734634;1422.30307149496;1443.0547991065869;1445.6096853849401;927.9164875161133;932.1796818799413;933.8132373525322;934.8924873639619;963.5471328475605;4881.95118048822;4883.633727470454;4894.706317620954;4896.902061958741;4901.387326584177;5729.48434640876;5736.770529178786;5737.110747834093;5745.971270143623;5746.856328591819;4721.669483136147;4772.5227477252;4855.344528488679;4874.829380971649;4889.339939108246;3055.5111182211185;3099.1942095055447;3104.1153271317567;3109.9844500777804;3115.065480355884;5477.096279113981;5477.507024367826;5481.260029895913;5489.945100549024;5491.725413729378;5925.792597259161;5935.258092738408;5935.436133567304;5940;5945.970270148621;5345.251664766935;5484.561235101182;5505.064139096443;5508.504234618904;5509.449055094458;5811.970940145272;5824.475797178275;5826.067829147316;5826.213461182686;5836.912446313224;5669.773209071756;5671.517920976763;5676.886462270649;5681.602287839812;5681.630694004876;5330;5493.258410114583;5493.835184944458;5495.587830912617;5502.202180683858;3882.9805850970565;3921.274564205631;3927.6072392760493;3935.468711723995;3936.547297060875;5786.045302525036;5792.507636850914;5794.188813566188;5798.971005144947;5802.448767367094;5573.080441727069;5583.581231407579;5586.497215250647;5591.748371323219;5592.133219351007;5439.374471935778;5586.832395028156;5594.41258667834;5599.748011339418;5611.859703507445;5469.124940009579;5477.72611369422;5483.561315094863;5493.670379777226;5494.478024587658;5634.52106570946;5636.126400407943;5640.4077571856005;5645.350784659652;5648.745806438638;5382.623216374816;5508.504234618904;5508.586855985897;5509.862253443696;5510.338759348743 21:05:22 INFO - 2015-12-03 21:05:22,383 DEBUG : BROWSER_OUTPUT: |5;yui.html;769.1424062170681;785.6425326476452;788.259036505685;797.7008621766837;799.4403917257918;11424.54301827927;11598.768024639512;11607.187496875202;11612.419379031046;11630.592929247478;10555.788884222311;10560.894391056087;10649.52077156528;10659.893401065987;10748.892511074888;613.4203177996795;623.4264476681441;625.2372106030635;625.4808508937571;625.5964902637796;606.3300053440951;777.8599852026633;793.7896457438783;796.9083555391146;797.7845981584968;829.7303376402693;836.6946064686376;837.8533756592602;845.9238668519832;847.4999750147412;622.9127922090911;629.2260519560965;840.5797101449275;841.1966571923798;841.5161282262693;470.1631096647972;613.5091926458815;619.8729260501586;626.408044398044;626.6115008694638;11753.706157346049;11904.58333958316;11914.642560723192;11929.403529823474;11930.463129159209;11029.338239705563;11322.773544529146;11583.420828958519;11686.12354073448;11868.050555955502;9465.716028519155;9543.570539325747;9583.808323833484;9598.232141428669;9704.805903881954;3215.1640573450836;3235;3260.673932606744;3270.6238782540076;3325.966740332614;37348.62651373506;40797.79601102005;40880;40902.38646420306;41030.79484602588;9109.590068446936;9159.450432974043;9164.495952722531;9169.083091690778;9254.398464099811;16445.25996330168;16459.34162633481;16465.58836029085;16466.341346346013;16472.176391180394;6047.697615119227;6085.817425477243;6277.8744425111245;6312.495000399957;6315.179026726496;3571.8928432147077;3575.4458059000895;3600.063983364344;3626.220362622049;3667.5232219811787;2687.5565531687052;2704.7558123263125;2709.065372446503;2715;2716.687580928179;462.4242817691995;463.3466811795352;470.6493662221667;473.4507970753909;478.7510494542818;549.2009126720612;560.6608002158716;593.1517929361055;604.29901314475;619.2259675405743;7561.3194812467145;8532.530710810965;8614.956925215334;8699.826003479895;8703.695370661997;472.37410431178137;477.7276952137248;482.1466005170828;573.4316643978715;630.1146888621494;3458.4639380896;3586.1393265616584;3719.795411252353;3722.8324725386883;3764.153065560227;47934.76032619815;48588.27117593239;50809;51636;51977.220341694905;40693;40887.97780055522;40888.591114089075;40921.59078409178;41257.58742412597;39475;40288.59711402907;40567;40761.38857917133;40972.59027409747;7780.961095194488;7936.682532698627;8154.266116049584;8341.332693384393;8533.615987280711;32075.198120047186;32408.351832962737;32495.187620308734;32537.34925301528;33032.84385046512;36873.262534749694;37138.44292335671;38805.41791873068;38838.80580597079;39887.40168897527;9995.300328977193;10229.488525573543;10398.168146548107;10413.563524037201;10492.685219443429;10882.945585272022;11391.829122563002;11429.371384573928;11496.310221386744;11774.3524106175;10363.170946324126;10474.109700675528;10684.46577671129;10711.839322410015;10840.457977100956;10752.408617525798;10949.83575246388;11071.83392249133;11246.381449020382;11644.941775291069;10509.579616815241;10868.456577171268;10931.125509959025;11190.32858028521;11419.371934543347;8962.32782541299;9040.864387034331;9063.909360906306;9252.49111298885;9425.245980321695;8790.252828509649;8803.515806630441;8881.955590222007;8955.641774329215;9120.315976301672 21:05:22 INFO - 2015-12-03 21:05:22,384 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:05:22 INFO - 2015-12-03 21:05:22,384 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:05:22 INFO - 2015-12-03 21:05:22,384 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,936 21:05:22 INFO - 2015-12-03 21:05:22,384 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:05:22 INFO - 2015-12-03 21:05:22,384 DEBUG : BROWSER_OUTPUT: __startTimestamp1449205522374__endTimestamp 21:05:22 INFO - 2015-12-03 21:05:22,384 DEBUG : BROWSER_OUTPUT: 21:05:22 INFO - 2015-12-03 21:05:22,384 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:05:22 INFO - 2015-12-03 21:05:22,384 DEBUG : BROWSER_OUTPUT: Number of tests: 6 21:05:22 INFO - 2015-12-03 21:05:22,384 DEBUG : BROWSER_OUTPUT: 21:05:22 INFO - 2015-12-03 21:05:22,385 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4563.87 Median:4646.91 stddev:476.71 (10.3%) stddev-sans-first:452.42 21:05:22 INFO - 2015-12-03 21:05:22,385 DEBUG : BROWSER_OUTPUT: Values: 2593.5 2683.8 2687.3 2698.1 2713.4 4465.0 4564.4 4633.9 4646.9 4682.0 4494.2 4542.4 4633.1 4633.4 4642.7 4087.9 4247.4 4255.2 4257.7 4340.5 4288.8 4357.0 4360.0 4364.5 4405.3 4076.5 4182.6 4210.9 4293.1 4331.2 4273.2 4283.9 4287.5 4290.4 4318.3 4275.0 4275.9 4300.0 4305.5 4311.7 4344.2 4443.3 4450.9 4506.3 4624.8 4933.0 4987.6 4987.8 4989.3 5030.4 5004.9 5011.8 5012.1 5015.0 5042.0 4385.9 4475.9 4477.9 4581.1 4709.5 5058.4 5067.7 5070.6 5073.6 5073.9 4859.0 4882.9 4884.7 4886.1 4927.8 4729.3 4840.3 4845.0 4873.7 4981.0 4895.1 4942.9 4943.0 4945.4 4989.2 4915.8 4916.0 4917.0 4919.2 4959.6 3938.9 4033.3 4036.9 4077.2 4088.6 3560.0 3574.9 3579.4 3591.2 3615.2 4270.6 4295.1 4297.4 4309.7 4339.2 4732.5 4813.9 4852.1 4920.4 5067.2 4311.3 4329.3 4345.4 4347.4 4382.3 4411.2 4446.0 4449.8 4452.7 4494.6 4510.7 4613.6 4614.9 4634.8 4735.5 5027.6 5038.2 5038.2 5058.1 5066.6 4782.6 4782.7 4784.0 4792.3 4801.1 4696.6 4799.4 4804.1 4890.1 4999.4 4964.0 4965.9 4966.8 4993.5 5017.8 4806.6 4808.9 4810.0 4811.6 4858.0 4645.2 4771.0 4774.0 4803.9 4857.9 4578.1 4629.7 4644.6 4689.2 4699.4 4832.8 4901.4 4903.2 4903.5 4947.8 4460.3 4554.7 4736.3 4776.1 4786.9 21:05:22 INFO - 2015-12-03 21:05:22,385 DEBUG : BROWSER_OUTPUT: 21:05:22 INFO - 2015-12-03 21:05:22,385 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40940.20 Median:32483.68 stddev:65996.44 (203.2%) stddev-sans-first:66111.91 21:05:22 INFO - 2015-12-03 21:05:22,385 DEBUG : BROWSER_OUTPUT: Values: 552.2 560.6 569.5 571.8 587.3 27917.0 28300.7 28381.1 28445.7 28466.9 37680.4 38540.6 38569.8 38621.2 38684.2 7781.9 7936.3 7951.2 7958.6 7961.9 7071.9 7278.8 7837.2 7915.4 10084.6 10119.6 10223.8 10231.0 10232.1 10248.3 10045.9 10117.6 10140.5 10151.0 10154.8 9725.4 9888.7 9940.2 9947.9 9950.8 38380.0 38793.6 38810.0 38895.2 38926.0 2801.5 2857.5 2897.6 3315.4 3422.5 28219.0 28419.0 28452.0 28680.6 28824.9 3459.9 3503.1 3503.6 3592.9 3593.6 230292.0 230425.0 230850.8 231088.0 232372.0 47396.0 47997.8 56654.7 57021.4 57022.4 59997.0 61896.7 62072.7 62184.7 62199.7 12925.5 13011.0 13051.2 13086.8 13104.2 8290.7 8511.1 8513.1 8528.9 9624.1 19009.4 19280.3 19329.8 19370.8 19498.4 6809.6 7074.6 7115.5 7156.4 7212.5 819.6 833.4 878.4 986.5 1072.8 24561.5 24746.4 24839.6 25019.7 25118.2 915.5 926.7 929.3 947.5 1007.4 12826.1 12905.0 12970.4 13058.8 13351.6 271344.0 273238.0 273626.0 274846.0 276046.0 46036.0 46254.3 46260.0 46267.1 46291.8 1223.3 1235.6 1237.4 1250.2 1352.9 24587.9 25177.4 25583.9 25616.9 25682.2 39484.6 39837.4 39904.0 39913.2 39919.8 250689.0 252087.0 252985.0 253187.0 253337.0 24355.6 25311.7 25326.6 27997.2 28801.3 33673.0 36844.3 37224.8 37530.0 37751.8 31500.5 31994.7 32298.5 32744.5 33095.5 32283.0 32679.5 32780.7 32886.3 33770.0 28188.3 28719.1 33503.0 33566.0 34003.7 26982.7 30035.5 30469.8 31692.5 32668.8 23458.0 23565.6 23675.6 23901.2 24074.3 21:05:22 INFO - 2015-12-03 21:05:22,385 DEBUG : BROWSER_OUTPUT: 21:05:22 INFO - 2015-12-03 21:05:22,385 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26409.07 Median:4436.15 stddev:78880.17 (1778.1%) stddev-sans-first:79077.13 21:05:22 INFO - 2015-12-03 21:05:22,386 DEBUG : BROWSER_OUTPUT: Values: 327.0 332.8 335.4 335.7 337.0 12601.7 12980.1 15039.6 15585.2 15800.7 11430.5 13741.6 13756.4 14005.1 14017.1 4591.9 4684.3 4733.1 4739.0 5075.4 5033.0 5067.3 5069.8 5074.9 5075.1 4949.3 5010.3 5012.7 5024.7 5025.3 4957.7 4970.4 4982.5 4986.3 4988.0 4435.6 4436.1 4436.2 4437.6 4438.9 18758.3 18784.8 19214.6 19243.7 19255.7 1819.3 1877.6 1931.3 1931.8 1957.0 9095.7 9316.3 12227.1 12420.6 12882.9 1703.0 1751.9 1763.3 1769.6 1771.5 51702.0 52420.0 54649.5 54714.0 55452.2 9416.0 9531.0 9557.1 9580.0 9614.9 10329.1 10630.0 11765.4 11782.0 22149.2 8025.0 8042.8 8127.6 8155.8 8364.4 6535.2 6552.6 6646.1 6663.2 6744.4 7548.0 7617.6 7625.4 7651.7 7736.9 2943.7 2991.8 3032.6 3046.2 3095.4 889.0 919.7 957.0 980.3 995.5 15760.2 15785.6 15837.6 16141.8 16170.9 830.0 874.4 879.7 881.4 882.7 8077.3 9314.2 9367.2 9407.1 9745.2 475751.0 482262.0 483733.0 486466.0 487121.0 73006.0 73321.3 73669.6 74176.0 74471.0 1050.4 1059.5 1060.3 1081.0 1082.1 11421.0 14407.8 14654.9 14726.2 14730.8 29949.0 29955.7 31671.4 34001.0 35458.6 42765.1 43645.1 43766.8 45303.8 46836.5 8839.7 8899.6 9072.0 9073.3 9074.3 15832.3 16055.1 16535.8 16575.4 16576.5 13137.2 13580.3 13823.9 14047.0 14062.6 13229.1 13256.7 13262.5 13692.9 13868.2 13477.1 13804.2 13874.8 14033.7 14272.1 8851.4 9102.0 9265.1 9271.0 9289.3 9657.6 9759.6 10940.9 13212.3 13250.5 21:05:22 INFO - 2015-12-03 21:05:22,387 DEBUG : BROWSER_OUTPUT: 21:05:22 INFO - 2015-12-03 21:05:22,387 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4932.16 Median:5964.23 stddev:2509.28 (42.1%) stddev-sans-first:2502.42 21:05:22 INFO - 2015-12-03 21:05:22,387 DEBUG : BROWSER_OUTPUT: Values: 1418.6 1617.7 1664.8 1688.7 1690.2 5702.8 7038.6 7194.8 7196.9 7209.2 6905.4 7055.4 7061.9 7073.1 7078.2 1754.2 1783.0 2039.3 2054.7 2104.7 2085.1 2088.6 2091.8 2095.5 2098.2 2003.4 2024.1 2047.2 2051.7 2053.0 2030.7 2055.9 2076.0 2076.9 2083.5 2074.0 2093.1 2098.6 2098.7 2100.6 7114.4 7150.6 7153.1 7171.2 7180.9 4153.2 4201.0 4208.8 4221.0 4227.5 2368.2 2714.1 2818.3 2827.7 2840.5 850.0 852.6 895.9 936.8 946.4 9210.8 9228.5 9235.4 9265.8 9274.2 3951.1 3968.4 4038.7 4050.0 4105.8 8086.8 8087.1 8099.6 8158.6 8221.0 4284.4 4287.1 4292.0 4298.3 4298.8 3889.1 3892.1 3897.4 3901.5 3902.3 2892.5 3041.3 3354.9 3439.8 3527.9 1114.2 1138.8 1140.7 1145.1 1149.7 1148.4 1165.5 1189.8 1216.6 1217.5 6766.3 6767.6 6795.9 6796.0 6816.1 1033.8 1073.8 1076.4 1079.8 1111.9 5267.6 5345.8 5362.8 5384.6 5409.0 8373.9 8448.2 8574.7 8601.4 8604.3 8276.1 8369.8 8408.9 8525.5 8527.9 5997.4 6261.8 6269.4 6293.8 6313.3 6520.2 6679.6 6691.9 6725.6 6756.9 7366.7 7502.6 7588.4 7667.3 7672.2 7713.3 7840.1 7862.9 7950.6 7976.5 5655.2 6147.9 6148.4 6190.6 6253.9 5729.7 5929.4 6567.7 6722.4 6751.1 6000.6 6028.8 6309.2 6316.7 6542.2 6188.2 6208.0 6250.8 6393.4 6407.9 6297.0 6369.8 6376.2 6393.0 6395.2 5938.0 5952.9 5963.5 5963.5 5965.0 5762.6 5855.1 5963.0 5989.3 6015.7 21:05:22 INFO - 2015-12-03 21:05:22,387 DEBUG : BROWSER_OUTPUT: 21:05:22 INFO - 2015-12-03 21:05:22,387 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4608.77 Median:5274.58 stddev:1363.11 (25.8%) stddev-sans-first:1327.87 21:05:22 INFO - 2015-12-03 21:05:22,388 DEBUG : BROWSER_OUTPUT: Values: 292.2 297.1 298.4 300.3 301.9 5215.1 5279.2 5289.9 5295.8 5356.3 4971.8 5091.8 5132.2 5245.9 5269.9 4081.9 4083.4 4085.0 4086.6 4090.9 3878.9 4081.0 4082.7 4087.0 4089.9 3938.5 3947.2 4015.5 4030.8 4063.5 4032.1 4035.0 4045.4 4050.6 4054.6 3566.1 3566.9 3567.0 3570.9 3575.4 5093.5 5095.4 5102.4 5111.7 5112.0 4571.7 4664.7 4680.6 4688.4 4692.0 5500.8 5506.3 5510.2 5513.2 5521.0 3875.3 3881.8 3888.1 3888.2 3899.2 5787.9 5808.0 5811.8 5817.4 5819.7 3905.9 4010.0 4012.1 4018.4 4026.0 4067.4 4068.6 4073.7 4074.8 4075.3 4622.0 4633.6 4640.2 4641.2 4643.7 5520.6 5528.8 5528.9 5530.0 5530.4 1414.6 1415.0 1422.3 1443.1 1445.6 927.9 932.2 933.8 934.9 963.5 4882.0 4883.6 4894.7 4896.9 4901.4 5729.5 5736.8 5737.1 5746.0 5746.9 4721.7 4772.5 4855.3 4874.8 4889.3 3055.5 3099.2 3104.1 3110.0 3115.1 5477.1 5477.5 5481.3 5489.9 5491.7 5925.8 5935.3 5935.4 5940.0 5946.0 5345.3 5484.6 5505.1 5508.5 5509.4 5812.0 5824.5 5826.1 5826.2 5836.9 5669.8 5671.5 5676.9 5681.6 5681.6 5330.0 5493.3 5493.8 5495.6 5502.2 3883.0 3921.3 3927.6 3935.5 3936.5 5786.0 5792.5 5794.2 5799.0 5802.4 5573.1 5583.6 5586.5 5591.7 5592.1 5439.4 5586.8 5594.4 5599.7 5611.9 5469.1 5477.7 5483.6 5493.7 5494.5 5634.5 5636.1 5640.4 5645.4 5648.7 5382.6 5508.5 5508.6 5509.9 5510.3 21:05:22 INFO - 2015-12-03 21:05:22,388 DEBUG : BROWSER_OUTPUT: 21:05:22 INFO - 2015-12-03 21:05:22,388 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12160.56 Median:40947.09 stddev:13576.64 (33.2%) stddev-sans-first:13587.77 21:05:22 INFO - 2015-12-03 21:05:22,389 DEBUG : BROWSER_OUTPUT: Values: 769.1 785.6 788.3 797.7 799.4 11424.5 11598.8 11607.2 11612.4 11630.6 10555.8 10560.9 10649.5 10659.9 10748.9 613.4 623.4 625.2 625.5 625.6 606.3 777.9 793.8 796.9 797.8 829.7 836.7 837.9 845.9 847.5 622.9 629.2 840.6 841.2 841.5 470.2 613.5 619.9 626.4 626.6 11753.7 11904.6 11914.6 11929.4 11930.5 11029.3 11322.8 11583.4 11686.1 11868.1 9465.7 9543.6 9583.8 9598.2 9704.8 3215.2 3235.0 3260.7 3270.6 3326.0 37348.6 40797.8 40880.0 40902.4 41030.8 9109.6 9159.5 9164.5 9169.1 9254.4 16445.3 16459.3 16465.6 16466.3 16472.2 6047.7 6085.8 6277.9 6312.5 6315.2 3571.9 3575.4 3600.1 3626.2 3667.5 2687.6 2704.8 2709.1 2715.0 2716.7 462.4 463.3 470.6 473.5 478.8 549.2 560.7 593.2 604.3 619.2 7561.3 8532.5 8615.0 8699.8 8703.7 472.4 477.7 482.1 573.4 630.1 3458.5 3586.1 3719.8 3722.8 3764.2 47934.8 48588.3 50809.0 51636.0 51977.2 40693.0 40888.0 40888.6 40921.6 41257.6 39475.0 40288.6 40567.0 40761.4 40972.6 7781.0 7936.7 8154.3 8341.3 8533.6 32075.2 32408.4 32495.2 32537.3 33032.8 36873.3 37138.4 38805.4 38838.8 39887.4 9995.3 10229.5 10398.2 10413.6 10492.7 10882.9 11391.8 11429.4 11496.3 11774.4 10363.2 10474.1 10684.5 10711.8 10840.5 10752.4 10949.8 11071.8 11246.4 11644.9 10509.6 10868.5 10931.1 11190.3 11419.4 8962.3 9040.9 9063.9 9252.5 9425.2 8790.3 8803.5 8882.0 8955.6 9120.3 21:05:22 INFO - 2015-12-03 21:05:22,389 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:05:22 INFO - 2015-12-03 21:05:22,389 DEBUG : BROWSER_OUTPUT: 21:05:23 INFO - 2015-12-03 21:05:23,128 INFO : Browser exited with error code: 0 21:05:23 INFO - 2015-12-03 21:05:23,147 INFO : Completed test dromaeo_css (00:18:37) 21:05:23 INFO - 2015-12-03 21:05:23,147 INFO : Starting test kraken 21:05:23 INFO - 2015-12-03 21:05:23,147 DEBUG : operating with platform_type : linux_ 21:05:23 INFO - 2015-12-03 21:05:23,147 INFO : Initialising browser for kraken test... 21:05:23 INFO - 2015-12-03 21:05:23,153 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfg_Aue/profile http://localhost:54296/getInfo.html 21:05:27 INFO - 2015-12-03 21:05:27,324 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:05:27 INFO - 2015-12-03 21:05:27,324 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:05:27 INFO - 2015-12-03 21:05:27,324 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:05:27 INFO - 2015-12-03 21:05:27,324 DEBUG : BROWSER_OUTPUT: __metrics 21:05:27 INFO - 2015-12-03 21:05:27,386 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] 21:05:27 INFO - 2015-12-03 21:05:27,454 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:05:28 INFO - 2015-12-03 21:05:28,322 INFO : Browser initialized. 21:05:28 INFO - 2015-12-03 21:05:28,323 INFO : Running cycle 1/1 for kraken test... 21:05:28 INFO - 2015-12-03 21:05:28,323 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfg_Aue/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:05:40 INFO - 2015-12-03 21:05:40,357 DEBUG : BROWSER_OUTPUT: RSS: Main: 151171072 21:05:40 INFO - 2015-12-03 21:05:40,357 DEBUG : BROWSER_OUTPUT: 21:05:42 INFO - 2015-12-03 21:05:42,978 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54296/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54296/tests/kraken/driver.html?testName=audio-beat-detection) 21:05:43 INFO - 2015-12-03 21:05:43,564 DEBUG : BROWSER_OUTPUT: RSS: Main: 190373888 21:05:43 INFO - 2015-12-03 21:05:43,564 DEBUG : BROWSER_OUTPUT: 21:05:46 INFO - 2015-12-03 21:05:46,283 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54296/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54296/tests/kraken/driver.html?testName=audio-dft) 21:05:46 INFO - 2015-12-03 21:05:46,851 DEBUG : BROWSER_OUTPUT: RSS: Main: 179269632 21:05:46 INFO - 2015-12-03 21:05:46,851 DEBUG : BROWSER_OUTPUT: 21:05:49 INFO - 2015-12-03 21:05:49,854 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54296/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54296/tests/kraken/driver.html?testName=audio-fft) 21:05:50 INFO - 2015-12-03 21:05:50,419 DEBUG : BROWSER_OUTPUT: RSS: Main: 161579008 21:05:50 INFO - 2015-12-03 21:05:50,420 DEBUG : BROWSER_OUTPUT: 21:05:52 INFO - 2015-12-03 21:05:52,464 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54296/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54296/tests/kraken/driver.html?testName=audio-oscillator) 21:05:53 INFO - 2015-12-03 21:05:53,037 DEBUG : BROWSER_OUTPUT: RSS: Main: 163336192 21:05:53 INFO - 2015-12-03 21:05:53,037 DEBUG : BROWSER_OUTPUT: 21:05:55 INFO - 2015-12-03 21:05:55,291 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54296/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54296/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:05:55 INFO - 2015-12-03 21:05:55,852 DEBUG : BROWSER_OUTPUT: RSS: Main: 164769792 21:05:55 INFO - 2015-12-03 21:05:55,852 DEBUG : BROWSER_OUTPUT: 21:05:58 INFO - 2015-12-03 21:05:58,851 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54296/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54296/tests/kraken/driver.html?testName=imaging-darkroom) 21:05:59 INFO - 2015-12-03 21:05:59,432 DEBUG : BROWSER_OUTPUT: RSS: Main: 164847616 21:05:59 INFO - 2015-12-03 21:05:59,432 DEBUG : BROWSER_OUTPUT: 21:06:02 INFO - 2015-12-03 21:06:02,856 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54296/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54296/tests/kraken/driver.html?testName=imaging-desaturate) 21:06:03 INFO - 2015-12-03 21:06:03,439 DEBUG : BROWSER_OUTPUT: RSS: Main: 166944768 21:06:03 INFO - 2015-12-03 21:06:03,439 DEBUG : BROWSER_OUTPUT: 21:06:06 INFO - 2015-12-03 21:06:06,265 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54296/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54296/tests/kraken/driver.html?testName=json-parse-financial) 21:06:06 INFO - 2015-12-03 21:06:06,845 DEBUG : BROWSER_OUTPUT: RSS: Main: 165249024 21:06:06 INFO - 2015-12-03 21:06:06,845 DEBUG : BROWSER_OUTPUT: 21:06:08 INFO - 2015-12-03 21:06:08,607 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54296/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54296/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:06:09 INFO - 2015-12-03 21:06:09,176 DEBUG : BROWSER_OUTPUT: RSS: Main: 174542848 21:06:09 INFO - 2015-12-03 21:06:09,176 DEBUG : BROWSER_OUTPUT: 21:06:11 INFO - 2015-12-03 21:06:11,059 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54296/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54296/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:06:11 INFO - 2015-12-03 21:06:11,654 DEBUG : BROWSER_OUTPUT: RSS: Main: 173457408 21:06:11 INFO - 2015-12-03 21:06:11,654 DEBUG : BROWSER_OUTPUT: 21:06:13 INFO - 2015-12-03 21:06:13,798 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54296/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54296/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:06:14 INFO - 2015-12-03 21:06:14,379 DEBUG : BROWSER_OUTPUT: RSS: Main: 186937344 21:06:14 INFO - 2015-12-03 21:06:14,380 DEBUG : BROWSER_OUTPUT: 21:06:16 INFO - 2015-12-03 21:06:16,895 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54296/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54296/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:06:17 INFO - 2015-12-03 21:06:17,484 DEBUG : BROWSER_OUTPUT: RSS: Main: 190705664 21:06:17 INFO - 2015-12-03 21:06:17,484 DEBUG : BROWSER_OUTPUT: 21:06:20 INFO - 2015-12-03 21:06:20,091 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54296/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54296/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:06:20 INFO - 2015-12-03 21:06:20,672 DEBUG : BROWSER_OUTPUT: RSS: Main: 188669952 21:06:20 INFO - 2015-12-03 21:06:20,673 DEBUG : BROWSER_OUTPUT: 21:06:22 INFO - 2015-12-03 21:06:22,442 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54296/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54296/tests/kraken/driver.html?testName=ai-astar) 21:06:22 INFO - 2015-12-03 21:06:22,688 DEBUG : BROWSER_OUTPUT: RSS: Main: 246538240 21:06:22 INFO - 2015-12-03 21:06:22,688 DEBUG : BROWSER_OUTPUT: 21:06:22 INFO - 2015-12-03 21:06:22,692 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:06:22 INFO - 2015-12-03 21:06:22,692 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:06:22 INFO - 2015-12-03 21:06:22,692 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:06:22 INFO - 2015-12-03 21:06:22,692 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:06:22 INFO - 2015-12-03 21:06:22,692 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;112;104;111;111;114;101;110;114;103 21:06:22 INFO - 2015-12-03 21:06:22,692 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;129;154;167;130;161;151;128;163;132 21:06:22 INFO - 2015-12-03 21:06:22,692 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;162;160;160;162;160;165;161;162;161 21:06:22 INFO - 2015-12-03 21:06:22,692 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;71;80;91;72;73;72;102;93;71 21:06:22 INFO - 2015-12-03 21:06:22,692 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;129;94;94;95;129;94;95;137 21:06:22 INFO - 2015-12-03 21:06:22,692 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;109;109;109;110;109;109 21:06:22 INFO - 2015-12-03 21:06:22,693 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;148;147;147;147;147;150;146;147;147 21:06:22 INFO - 2015-12-03 21:06:22,693 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;97;96;95;96;96;96;95 21:06:22 INFO - 2015-12-03 21:06:22,693 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;71;71;71;71;70;71;78;68;69 21:06:22 INFO - 2015-12-03 21:06:22,693 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;67;68;69;70;68;69;69;69 21:06:22 INFO - 2015-12-03 21:06:22,693 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;90;83;87;84;84;83;85;85;84 21:06:22 INFO - 2015-12-03 21:06:22,693 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;126;126;123;128;117;118;119;125;121 21:06:22 INFO - 2015-12-03 21:06:22,693 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;154;136;148;152;151;158;149;147;146;136 21:06:22 INFO - 2015-12-03 21:06:22,693 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;68;68;69;69;69;70;70;69;68 21:06:22 INFO - 2015-12-03 21:06:22,693 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:06:22 INFO - 2015-12-03 21:06:22,693 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:06:22 INFO - 2015-12-03 21:06:22,693 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,983 21:06:22 INFO - 2015-12-03 21:06:22,693 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:06:22 INFO - 2015-12-03 21:06:22,693 DEBUG : BROWSER_OUTPUT: __startTimestamp1449205582689__endTimestamp 21:06:22 INFO - 2015-12-03 21:06:22,693 DEBUG : BROWSER_OUTPUT: 21:06:22 INFO - 2015-12-03 21:06:22,697 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:06:22 INFO - 2015-12-03 21:06:22,697 DEBUG : BROWSER_OUTPUT: Number of tests: 14 21:06:22 INFO - 2015-12-03 21:06:22,697 DEBUG : BROWSER_OUTPUT: 21:06:22 INFO - 2015-12-03 21:06:22,697 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.00 Median:111.00 stddev:4.64 (4.2%) stddev-sans-first:4.91 21:06:22 INFO - 2015-12-03 21:06:22,697 DEBUG : BROWSER_OUTPUT: Values: 110.0 112.0 104.0 111.0 111.0 114.0 101.0 110.0 114.0 103.0 21:06:22 INFO - 2015-12-03 21:06:22,697 DEBUG : BROWSER_OUTPUT: 21:06:22 INFO - 2015-12-03 21:06:22,697 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.50 Median:152.50 stddev:15.36 (10.1%) stddev-sans-first:16.24 21:06:22 INFO - 2015-12-03 21:06:22,697 DEBUG : BROWSER_OUTPUT: Values: 150.0 129.0 154.0 167.0 130.0 161.0 151.0 128.0 163.0 132.0 21:06:22 INFO - 2015-12-03 21:06:22,697 DEBUG : BROWSER_OUTPUT: 21:06:22 INFO - 2015-12-03 21:06:22,697 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.57 (1.0%) stddev-sans-first:1.59 21:06:22 INFO - 2015-12-03 21:06:22,697 DEBUG : BROWSER_OUTPUT: Values: 160.0 162.0 160.0 160.0 162.0 160.0 165.0 161.0 162.0 161.0 21:06:22 INFO - 2015-12-03 21:06:22,697 DEBUG : BROWSER_OUTPUT: 21:06:22 INFO - 2015-12-03 21:06:22,697 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.70 Median:72.50 stddev:11.43 (15.8%) stddev-sans-first:11.78 21:06:22 INFO - 2015-12-03 21:06:22,697 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 80.0 91.0 72.0 73.0 72.0 102.0 93.0 71.0 21:06:22 INFO - 2015-12-03 21:06:22,698 DEBUG : BROWSER_OUTPUT: 21:06:22 INFO - 2015-12-03 21:06:22,698 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.70 Median:94.50 stddev:18.06 (19.1%) stddev-sans-first:18.73 21:06:22 INFO - 2015-12-03 21:06:22,698 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 129.0 94.0 94.0 95.0 129.0 94.0 95.0 137.0 21:06:22 INFO - 2015-12-03 21:06:22,698 DEBUG : BROWSER_OUTPUT: 21:06:22 INFO - 2015-12-03 21:06:22,698 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 21:06:22 INFO - 2015-12-03 21:06:22,698 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 21:06:22 INFO - 2015-12-03 21:06:22,698 DEBUG : BROWSER_OUTPUT: 21:06:22 INFO - 2015-12-03 21:06:22,698 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:1.14 (0.8%) stddev-sans-first:1.12 21:06:22 INFO - 2015-12-03 21:06:22,698 DEBUG : BROWSER_OUTPUT: Values: 146.0 148.0 147.0 147.0 147.0 147.0 150.0 146.0 147.0 147.0 21:06:22 INFO - 2015-12-03 21:06:22,699 DEBUG : BROWSER_OUTPUT: 21:06:22 INFO - 2015-12-03 21:06:22,699 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 21:06:22 INFO - 2015-12-03 21:06:22,699 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 97.0 96.0 95.0 96.0 96.0 96.0 95.0 21:06:22 INFO - 2015-12-03 21:06:22,699 DEBUG : BROWSER_OUTPUT: 21:06:22 INFO - 2015-12-03 21:06:22,699 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.20 Median:71.00 stddev:2.66 (3.7%) stddev-sans-first:2.80 21:06:22 INFO - 2015-12-03 21:06:22,699 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 71.0 71.0 71.0 70.0 71.0 78.0 68.0 69.0 21:06:22 INFO - 2015-12-03 21:06:22,699 DEBUG : BROWSER_OUTPUT: 21:06:22 INFO - 2015-12-03 21:06:22,699 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:0.85 (1.2%) stddev-sans-first:0.88 21:06:22 INFO - 2015-12-03 21:06:22,699 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 67.0 68.0 69.0 70.0 68.0 69.0 69.0 69.0 21:06:22 INFO - 2015-12-03 21:06:22,699 DEBUG : BROWSER_OUTPUT: 21:06:22 INFO - 2015-12-03 21:06:22,699 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:85.00 stddev:2.11 (2.5%) stddev-sans-first:2.24 21:06:22 INFO - 2015-12-03 21:06:22,699 DEBUG : BROWSER_OUTPUT: Values: 85.0 90.0 83.0 87.0 84.0 84.0 83.0 85.0 85.0 84.0 21:06:22 INFO - 2015-12-03 21:06:22,699 DEBUG : BROWSER_OUTPUT: 21:06:22 INFO - 2015-12-03 21:06:22,700 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:125.50 stddev:4.26 (3.4%) stddev-sans-first:3.97 21:06:22 INFO - 2015-12-03 21:06:22,700 DEBUG : BROWSER_OUTPUT: Values: 129.0 126.0 126.0 123.0 128.0 117.0 118.0 119.0 125.0 121.0 21:06:22 INFO - 2015-12-03 21:06:22,700 DEBUG : BROWSER_OUTPUT: 21:06:22 INFO - 2015-12-03 21:06:22,700 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.70 Median:150.00 stddev:7.10 (4.7%) stddev-sans-first:7.16 21:06:22 INFO - 2015-12-03 21:06:22,700 DEBUG : BROWSER_OUTPUT: Values: 154.0 136.0 148.0 152.0 151.0 158.0 149.0 147.0 146.0 136.0 21:06:22 INFO - 2015-12-03 21:06:22,700 DEBUG : BROWSER_OUTPUT: 21:06:22 INFO - 2015-12-03 21:06:22,700 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 21:06:22 INFO - 2015-12-03 21:06:22,700 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 68.0 69.0 69.0 69.0 70.0 70.0 69.0 68.0 21:06:22 INFO - 2015-12-03 21:06:22,700 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:06:22 INFO - 2015-12-03 21:06:22,700 DEBUG : BROWSER_OUTPUT: 21:06:23 INFO - 2015-12-03 21:06:23,560 INFO : Browser exited with error code: 0 21:06:23 INFO - 2015-12-03 21:06:23,609 INFO : Completed test kraken (00:01:00) 21:06:23 INFO - 2015-12-03 21:06:23,609 INFO : Starting test v8_7 21:06:23 INFO - 2015-12-03 21:06:23,609 DEBUG : operating with platform_type : linux_ 21:06:23 INFO - 2015-12-03 21:06:23,609 INFO : Initialising browser for v8_7 test... 21:06:23 INFO - 2015-12-03 21:06:23,615 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiHNErS/profile http://localhost:54296/getInfo.html 21:06:27 INFO - 2015-12-03 21:06:27,903 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:06:27 INFO - 2015-12-03 21:06:27,904 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:06:27 INFO - 2015-12-03 21:06:27,904 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:06:27 INFO - 2015-12-03 21:06:27,904 DEBUG : BROWSER_OUTPUT: __metrics 21:06:28 INFO - 2015-12-03 21:06:28,008 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] 21:06:28 INFO - 2015-12-03 21:06:28,076 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:06:28 INFO - 2015-12-03 21:06:28,354 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 21:06:29 INFO - 2015-12-03 21:06:29,035 INFO : Browser initialized. 21:06:29 INFO - 2015-12-03 21:06:29,035 INFO : Running cycle 1/1 for v8_7 test... 21:06:29 INFO - 2015-12-03 21:06:29,036 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiHNErS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:06:41 INFO - 2015-12-03 21:06:41,036 DEBUG : BROWSER_OUTPUT: RSS: Main: 148987904 21:06:41 INFO - 2015-12-03 21:06:41,037 DEBUG : BROWSER_OUTPUT: 21:07:02 INFO - 2015-12-03 21:07:02,484 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54296/tests/v8_7/run.html (next: http://localhost:54296/tests/v8_7/run.html) 21:07:02 INFO - 2015-12-03 21:07:02,734 DEBUG : BROWSER_OUTPUT: RSS: Main: 469868544 21:07:02 INFO - 2015-12-03 21:07:02,735 DEBUG : BROWSER_OUTPUT: 21:07:02 INFO - 2015-12-03 21:07:02,735 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:07:02 INFO - 2015-12-03 21:07:02,735 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:07:02 INFO - 2015-12-03 21:07:02,735 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:07:02 INFO - 2015-12-03 21:07:02,735 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:07:02 INFO - 2015-12-03 21:07:02,735 DEBUG : BROWSER_OUTPUT: |0;Richards;165.39861065167054 21:07:02 INFO - 2015-12-03 21:07:02,736 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.15040953090096 21:07:02 INFO - 2015-12-03 21:07:02,736 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.6291446085261 21:07:02 INFO - 2015-12-03 21:07:02,736 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5202.072538860104 21:07:02 INFO - 2015-12-03 21:07:02,736 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1980.1980198019803 21:07:02 INFO - 2015-12-03 21:07:02,736 DEBUG : BROWSER_OUTPUT: |5;Earley;784.3137254901961 21:07:02 INFO - 2015-12-03 21:07:02,736 DEBUG : BROWSER_OUTPUT: |6;Boyer;12132.530120481928 21:07:02 INFO - 2015-12-03 21:07:02,736 DEBUG : BROWSER_OUTPUT: |7;RegExp;26763.157894736843 21:07:02 INFO - 2015-12-03 21:07:02,736 DEBUG : BROWSER_OUTPUT: |8;Splay;619.047619047619 21:07:02 INFO - 2015-12-03 21:07:02,736 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 21:07:02 INFO - 2015-12-03 21:07:02,737 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:07:02 INFO - 2015-12-03 21:07:02,737 DEBUG : BROWSER_OUTPUT: __startTimestamp1449205622731__endTimestamp 21:07:02 INFO - 2015-12-03 21:07:02,737 DEBUG : BROWSER_OUTPUT: 21:07:02 INFO - 2015-12-03 21:07:02,737 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:07:02 INFO - 2015-12-03 21:07:02,737 DEBUG : BROWSER_OUTPUT: Number of tests: 10 21:07:02 INFO - 2015-12-03 21:07:02,737 DEBUG : BROWSER_OUTPUT: 21:07:02 INFO - 2015-12-03 21:07:02,737 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.40 Median:165.40 stddev:0.00 (0.0%) 21:07:02 INFO - 2015-12-03 21:07:02,737 DEBUG : BROWSER_OUTPUT: Values: 165.4 21:07:02 INFO - 2015-12-03 21:07:02,737 DEBUG : BROWSER_OUTPUT: 21:07:02 INFO - 2015-12-03 21:07:02,737 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.15 Median:186.15 stddev:0.00 (0.0%) 21:07:02 INFO - 2015-12-03 21:07:02,737 DEBUG : BROWSER_OUTPUT: Values: 186.2 21:07:02 INFO - 2015-12-03 21:07:02,737 DEBUG : BROWSER_OUTPUT: 21:07:02 INFO - 2015-12-03 21:07:02,737 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.63 Median:278.63 stddev:0.00 (0.0%) 21:07:02 INFO - 2015-12-03 21:07:02,737 DEBUG : BROWSER_OUTPUT: Values: 278.6 21:07:02 INFO - 2015-12-03 21:07:02,737 DEBUG : BROWSER_OUTPUT: 21:07:02 INFO - 2015-12-03 21:07:02,737 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 21:07:02 INFO - 2015-12-03 21:07:02,738 DEBUG : BROWSER_OUTPUT: Values: 5202.1 21:07:02 INFO - 2015-12-03 21:07:02,738 DEBUG : BROWSER_OUTPUT: 21:07:02 INFO - 2015-12-03 21:07:02,738 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1980.20 Median:1980.20 stddev:0.00 (0.0%) 21:07:02 INFO - 2015-12-03 21:07:02,738 DEBUG : BROWSER_OUTPUT: Values: 1980.2 21:07:02 INFO - 2015-12-03 21:07:02,738 DEBUG : BROWSER_OUTPUT: 21:07:02 INFO - 2015-12-03 21:07:02,738 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:784.31 Median:784.31 stddev:0.00 (0.0%) 21:07:02 INFO - 2015-12-03 21:07:02,738 DEBUG : BROWSER_OUTPUT: Values: 784.3 21:07:02 INFO - 2015-12-03 21:07:02,738 DEBUG : BROWSER_OUTPUT: 21:07:02 INFO - 2015-12-03 21:07:02,738 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12132.53 Median:12132.53 stddev:0.00 (0.0%) 21:07:02 INFO - 2015-12-03 21:07:02,738 DEBUG : BROWSER_OUTPUT: Values: 12132.5 21:07:02 INFO - 2015-12-03 21:07:02,738 DEBUG : BROWSER_OUTPUT: 21:07:02 INFO - 2015-12-03 21:07:02,738 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26763.16 Median:26763.16 stddev:0.00 (0.0%) 21:07:02 INFO - 2015-12-03 21:07:02,738 DEBUG : BROWSER_OUTPUT: Values: 26763.2 21:07:02 INFO - 2015-12-03 21:07:02,738 DEBUG : BROWSER_OUTPUT: 21:07:02 INFO - 2015-12-03 21:07:02,739 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:619.05 Median:619.05 stddev:0.00 (0.0%) 21:07:02 INFO - 2015-12-03 21:07:02,739 DEBUG : BROWSER_OUTPUT: Values: 619.0 21:07:02 INFO - 2015-12-03 21:07:02,739 DEBUG : BROWSER_OUTPUT: 21:07:02 INFO - 2015-12-03 21:07:02,739 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 21:07:02 INFO - 2015-12-03 21:07:02,739 DEBUG : BROWSER_OUTPUT: Values: 4840.6 21:07:02 INFO - 2015-12-03 21:07:02,739 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:07:02 INFO - 2015-12-03 21:07:02,739 DEBUG : BROWSER_OUTPUT: 21:07:03 INFO - 2015-12-03 21:07:03,632 INFO : Browser exited with error code: 0 21:07:03 INFO - 2015-12-03 21:07:03,649 INFO : Completed test v8_7 (00:00:40) 21:07:03 INFO - 2015-12-03 21:07:03,731 INFO : Completed test suite (00:20:17) 21:07:03 INFO - 2015-12-03 21:07:03,732 DEBUG : Working with test: dromaeo_css 21:07:03 INFO - 2015-12-03 21:07:03,732 DEBUG : Generating results file: dromaeo_css 21:07:03 INFO - 2015-12-03 21:07:03,733 DEBUG : Working with test: kraken 21:07:03 INFO - 2015-12-03 21:07:03,733 DEBUG : Generating results file: kraken 21:07:03 INFO - 2015-12-03 21:07:03,733 INFO : javascript benchmark 21:07:03 INFO - 2015-12-03 21:07:03,733 DEBUG : Working with test: v8_7 21:07:03 INFO - 2015-12-03 21:07:03,733 DEBUG : Generating results file: v8_7 21:07:03 INFO - 2015-12-03 21:07:03,734 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:07:03 INFO - 2015-12-03 21:07:03,787 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,144,35]] 21:07:03 INFO - 2015-12-03 21:07:03,788 DEBUG : process_Request line: dromaeo_css 6312.17 graph.html#tests=[[72,144,35]] 21:07:03 INFO - 2015-12-03 21:07:03,788 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:07:03 INFO - 2015-12-03 21:07:03,816 DEBUG : process_Request line: kraken 1519.00 graph.html#tests=[[232,144,35]] 21:07:03 INFO - 2015-12-03 21:07:03,816 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:07:03 INFO - 2015-12-03 21:07:03,843 DEBUG : process_Request line: v8_7 19794.32 graph.html#tests=[[230,144,35]] 21:07:03 INFO - 2015-12-03 21:07:03,845 INFO : javascript benchmark 21:07:03 INFO - 2015-12-03 21:07:03,848 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2593.5331640304744, 2683.8255513391614, 2687.2878687147895, 2698.069166137683, 2713.3759235375865, 4464.977675111628, 4564.406627138475, 4633.8609841704765, 4646.9079766254945, 4682.0, 4494.2359798834195, 4542.409486766715, 4633.119707255619, 4633.374494443249, 4642.744649044301, 4087.9386809197886, 4247.384129301249, 4255.1915136124035, 4257.723247988879, 4340.544242854502, 4288.807003684841, 4357.0, 4360.0, 4364.476262848462, 4405.295152775557, 4076.5311989121333, 4182.56083111275, 4210.936835947463, 4293.141371725667, 4331.198728235255, 4273.166732487166, 4283.87148385549, 4287.506936702288, 4290.377895205209, 4318.287482565373, 4274.978625106854, 4275.893102672427, 4299.973131387486, 4305.461817272841, 4311.719738217037, 4344.152890186415, 4443.266860967937, 4450.933236001462, 4506.278995360726, 4624.791884365211, 4932.950670493285, 4987.576056035241, 4987.750612469362, 4989.301497790312, 5030.421501527335, 5004.924926126111, 5011.824586139468, 5012.147934851084, 5015.0, 5042.042012017705, 4385.912281754379, 4475.910481790346, 4477.865664030084, 4581.106684196617, 4709.505501922317, 5058.4435712071645, 5067.721275329893, 5070.61970352225, 5073.594112470993, 5073.923891141636, 4858.975705121452, 4882.926756098661, 4884.706917584886, 4886.071646387175, 4927.7536123193695, 4729.337892695025, 4840.298156767249, 4845.030993801254, 4873.707577545359, 4980.950190498121, 4895.143349913751, 4942.9258561121615, 4942.975285123552, 4945.3571035765835, 4989.226669866104, 4915.754212289371, 4915.9508404916205, 4916.975415122902, 4919.188333924933, 4959.553640172329, 3938.940915886264, 4033.253848038122, 4036.9394459083137, 4077.1641813428178, 4088.6115818997146, 3560.003199104255, 3574.928501430009, 3579.4451859961746, 3591.1919818040733, 3615.1504396466808, 4270.572942705767, 4295.076558539929, 4297.39836422901, 4309.698321117492, 4339.240632889232, 4732.52674732524, 4813.927791083137, 4852.126617208936, 4920.384951881015, 5067.189249720027, 4311.288637374861, 4329.2640251156745, 4345.435093437833, 4347.369631403492, 4382.342648602735, 4411.228035093845, 4445.977770111193, 4449.844255451044, 4452.703141468499, 4494.640428765691, 4510.706804057726, 4613.5847773700525, 4614.930776038362, 4634.814607415666, 4735.526447355237, 5027.597792176544, 5038.168702164102, 5038.193888977746, 5058.114829904678, 5066.594672426123, 4782.569568738831, 4782.689125206851, 4784.043191361811, 4792.281157826214, 4801.1117943180625, 4696.647751418589, 4799.448063472745, 4804.135255654016, 4890.070886531547, 4999.400071991239, 4964.032013757283, 4965.900681986413, 4966.776495057658, 4993.525615066563, 5017.799288028438, 4806.591439727662, 4808.8797780055775, 4809.95190048109, 4811.591014763784, 4858.0, 4645.163870503342, 4770.950390913993, 4774.045190961891, 4803.927941080817, 4857.878553036202, 4578.130155270488, 4629.722216667011, 4644.558766917137, 4689.179393606173, 4699.412573428322, 4832.830850920201, 4901.387326584177, 4903.215485522299, 4903.509649035068, 4947.802087916587, 4460.30865215892, 4554.681172317906, 4736.313234580897, 4776.116418462596, 4786.856394308176], "unit": "ms", "name": "dojo.html", "value": 4534.465215544948}, {"lowerIsBetter": false, "replicates": [552.206482097822, 560.6187792301233, 569.4817715878552, 571.7512881896374, 587.3069777662358, 27917.0, 28300.716992830115, 28381.148565543015, 28445.715542844566, 28466.85766571167, 37680.43479347805, 38540.61459385405, 38569.807150964276, 38621.22757544847, 38684.226315473745, 7781.883271750914, 7936.325412339958, 7951.244631760002, 7958.602069896511, 7961.920380796176, 7071.85856282874, 7278.781636550885, 7837.216278372146, 7915.366770658334, 10084.647037353694, 10119.595216191343, 10223.846642300372, 10231.0, 10232.07911287984, 10248.282620216587, 10045.949770251138, 10117.645882394154, 10140.543675534545, 10151.0, 10154.847677284846, 9725.367851089657, 9888.653897113638, 9940.155086817556, 9947.90052099477, 9950.751231219205, 38380.0, 38793.612063879285, 38810.0, 38895.22209555793, 38926.02684932871, 2801.453716525278, 2857.4713677969644, 2897.608822808936, 3315.436375816093, 3422.4866270059692, 28219.0, 28419.0, 28452.004179853604, 28680.569791453145, 28824.855875720696, 3459.896203113911, 3503.1242189452637, 3503.597086335053, 3592.8562857485667, 3593.586737525192, 230292.0, 230425.0, 230850.84574577186, 231088.0, 232372.0, 47396.0, 47997.76001120042, 56654.7167264161, 57021.42978570161, 57022.42977570254, 59997.0, 61896.69051654803, 62072.68963655153, 62184.68907655523, 62199.6890015547, 12925.54760583375, 13011.0, 13051.21692698441, 13086.803697944539, 13104.2137471752, 8290.709825156091, 8511.148885111563, 8513.063563008063, 8528.872066919, 9624.085711857502, 19009.42971710851, 19280.32518861833, 19329.80670193308, 19370.80629193718, 19498.415047548595, 6809.625470599066, 7074.646267686595, 7115.466340024519, 7156.3898122922965, 7212.495125341281, 819.5861090149436, 833.3666413525643, 878.3719640457103, 986.4722373530127, 1072.8337107748312, 24561.508769824504, 24746.381340466633, 24839.62740558893, 25019.749802502105, 25118.24645260645, 915.4507295622707, 926.745145085107, 929.2705226397246, 947.516766449116, 1007.4056306779036, 12826.102172847997, 12904.96463812091, 12970.416331265116, 13058.804117938238, 13351.599452016455, 271344.0, 273238.0, 273626.0, 274846.0, 276046.0, 46036.0, 46254.306185407244, 46260.0, 46267.074658506644, 46291.76854115708, 1223.2599277437023, 1235.6293112066523, 1237.3998610673816, 1250.2373552133192, 1352.8714772096635, 24587.87706061458, 25177.37056573527, 25583.872080639478, 25616.871915640302, 25682.229533114038, 39484.60515394809, 39837.40243896286, 39904.0, 39913.2017359657, 39919.80040099781, 250689.0, 252087.0, 252985.0, 253187.0, 253337.0, 24355.564443555504, 25311.746882531676, 25326.620100698136, 27997.160085197476, 28801.279968000967, 33673.0, 36844.26311473809, 37224.81387593045, 37530.0, 37751.81124094472, 31500.536708355907, 31994.6800532001, 32298.515522266716, 32744.50883236801, 33095.50356744699, 32283.0, 32679.50980735243, 32780.67219327872, 32886.34227315488, 33770.0, 28188.295292617848, 28719.138425847257, 33502.99491015273, 33566.0, 34003.65996340005, 26982.730172698022, 30035.549466758453, 30469.847650761603, 31692.524612130375, 32668.83665581657, 23458.01213793625, 23565.64651530194, 23675.64486532669, 23901.163459279538, 24074.27777166688], "unit": "ms", "name": "ext.html", "value": 16871.949207641297}, {"lowerIsBetter": false, "replicates": [326.9574955255818, 332.81362437035244, 335.3740214123414, 335.68948722431753, 337.0495203526056, 12601.684957876058, 12980.091393602452, 15039.624009399771, 15585.22073896305, 15800.68398632028, 11430.485628146733, 13741.58775236742, 13756.449742010333, 14005.089669171497, 14017.088889222194, 4591.885202869921, 4684.273937539687, 4733.053389322149, 4739.028499157665, 5075.441701412841, 5033.0, 5067.265246539249, 5069.797208111671, 5074.898502029957, 5075.137226671456, 4949.331840201581, 5010.298558201855, 5012.72430016349, 5024.748762561876, 5025.3467049283545, 4957.652964292501, 4970.378702662168, 4982.501749825006, 4986.301917731521, 4987.975060124694, 4435.556444355571, 4436.134953684033, 4436.157130145262, 4437.600615944548, 4438.911221775578, 18758.34345797904, 18784.812151878443, 19214.61570768591, 19243.749156304937, 19255.748376355634, 1819.3359423810214, 1877.6244751049844, 1931.33368987699, 1931.768187817457, 1956.9608607827906, 9095.727128186165, 9316.347855650107, 12227.14409991301, 12420.62738117858, 12882.871171288354, 1702.9744553831702, 1751.8686098542532, 1763.3475614022893, 1769.575301927528, 1771.477414162825, 51702.0, 52420.0, 54649.45350546523, 54714.0, 55452.16821747637, 9416.0, 9530.95234523823, 9557.139857412867, 9579.994100619473, 9614.855777163348, 10329.12202462784, 10630.0, 11765.352905590275, 11782.0, 22149.224777133044, 8024.959875200587, 8042.798930026796, 8127.634256458356, 8155.79610509742, 8364.414490985573, 6535.150430444012, 6552.57408268461, 6646.102776125258, 6663.167104111986, 6744.359285867835, 7548.0, 7617.581033043236, 7625.428092893055, 7651.732189373345, 7736.883946740803, 2943.6909124541617, 2991.760659147263, 3032.6360836699737, 3046.162305366042, 3095.3654500827274, 888.9555522223992, 919.6689191890914, 956.9664762056962, 980.3431700760508, 995.5121990224737, 15760.211989400485, 15785.605359866095, 15837.604059898595, 16141.757873631905, 16170.919145404197, 829.9751007469786, 874.3879284500874, 879.6745204274459, 881.4490943160524, 882.7263548300048, 8077.2554916644085, 9314.161725444743, 9367.156955874005, 9407.106324899123, 9745.220382369393, 475751.0, 482262.0, 483733.0, 486466.0, 487121.0, 73006.0, 73321.26678733251, 73669.6316518414, 74176.0, 74471.0, 1050.4296077364388, 1059.4702648675661, 1060.2631171335847, 1081.0108750493368, 1082.1396989393452, 11421.0, 14407.78388324197, 14654.853451465775, 14726.190059546827, 14730.779038314648, 29949.0, 29955.70044299529, 31671.366572667957, 34001.0, 35458.64541354657, 42765.144697105265, 43645.12709745724, 43766.78116609396, 45303.77348113238, 46836.53163468322, 8839.734807955772, 8899.599518021834, 9072.047435019227, 9073.274138068806, 9074.31942604294, 15832.28754706064, 16055.116968566841, 16535.751963720795, 16575.41986030483, 16576.502704918872, 13137.211767293993, 13580.25308608036, 13823.86176138266, 14047.0, 14062.648433789238, 13229.140105893086, 13256.668583285495, 13262.53581124656, 13692.863071369158, 13868.237246951514, 13477.123986940818, 13804.240766757925, 13874.791878121634, 14033.719325613227, 14272.14367137975, 8851.380403371702, 9101.954490227507, 9265.073492650681, 9271.0, 9289.303302252494, 9657.613695452103, 9759.560819762986, 10940.945295273472, 13212.339383031001, 13250.536231231861], "unit": "ms", "name": "jquery.html", "value": 8563.511079095691}, {"lowerIsBetter": false, "replicates": [1418.5957002254358, 1617.684551512455, 1664.7752553405294, 1688.662267546491, 1690.1718158102533, 5702.771889124435, 7038.6128762918015, 7194.820129496765, 7196.856062878739, 7209.206987231413, 6905.378515933565, 7055.365017148456, 7061.8940715889175, 7073.115860517435, 7078.150621925363, 1754.2106052276526, 1783.0015191492805, 2039.3270220827167, 2054.7226124473154, 2104.6948192512077, 2085.14509051289, 2088.550961543268, 2091.759447663523, 2095.4970807006284, 2098.213170061227, 2003.388966365258, 2024.1498570600384, 2047.2118234479683, 2051.7435320584927, 2052.9940329238716, 2030.7258520099745, 2055.9074841632164, 2076.0346438905904, 2076.9480762980897, 2083.510375061867, 2073.9896300518553, 2093.058123844276, 2098.6222479953603, 2098.674705420662, 2100.6218880601486, 7114.359707626287, 7150.606716630583, 7153.141623005273, 7171.211166771651, 7180.928190718078, 4153.190127925056, 4200.978995105005, 4208.789560521962, 4221.02916329246, 4227.450431443924, 2368.171140100968, 2714.09077958884, 2818.309514169021, 2827.660680718327, 2840.4603125406106, 850.0479463001416, 852.6376290076693, 895.852184389575, 936.8079543693594, 946.4463288975958, 9210.769730756718, 9228.538573071386, 9235.399699019543, 9265.768355791091, 9274.165325120704, 3951.0517475806173, 3968.404739289072, 4038.656714179269, 4050.0482386639114, 4105.753654780723, 8086.838263234702, 8087.110417854032, 8099.635516401659, 8158.551279679675, 8221.0, 4284.4430224070675, 4287.056847493546, 4291.957080429218, 4298.26929421999, 4298.76356800379, 3889.144388234584, 3892.065904182976, 3897.415387691869, 3901.51231096113, 3902.2780785554764, 2892.4938135826146, 3041.2548925513393, 3354.8825791097684, 3439.8280085995602, 3527.876524321636, 1114.1588100983868, 1138.8007098757685, 1140.6920131564598, 1145.1010956399186, 1149.7068247596976, 1148.3683973814536, 1165.5454372794618, 1189.8393716848288, 1216.6289281769145, 1217.5129948020863, 6766.28953959837, 6767.627780472023, 6795.898061529081, 6796.0, 6816.147981502312, 1033.834586466162, 1073.8013467508536, 1076.4025965589017, 1079.8056349856945, 1111.944402779874, 5267.604929630293, 5345.770472791202, 5362.812301569426, 5384.596155288369, 5409.026375252413, 8373.916260837314, 8448.155184481502, 8574.657013719507, 8601.354898382646, 8604.31165506758, 8276.131006244377, 8369.832603347899, 8408.873866892001, 8525.531095789667, 8527.872081918777, 5997.400259974055, 6261.843453913689, 6269.373062693694, 6293.779717709858, 6313.273973493016, 6520.152380190545, 6679.56582822115, 6691.933080669326, 6725.630090345078, 6756.898646520208, 7366.742164024234, 7502.624868756649, 7588.354989825927, 7667.271609197117, 7672.194419585863, 7713.267239612228, 7840.137584865774, 7862.921370786219, 7950.642221099949, 7976.481528700616, 5655.151727240782, 6147.877042459215, 6148.354422785722, 6190.566660333733, 6253.906191407042, 5729.71351432435, 5929.436703513159, 6567.671616419065, 6722.428593569602, 6751.122354094133, 6000.5799594028, 6028.788992385245, 6309.179806625109, 6316.684165791784, 6542.247641521286, 6188.164597779422, 6207.96896015517, 6250.812475625738, 6393.392627700361, 6407.903881441689, 6297.0, 6369.808905732835, 6376.202974628171, 6393.041043843275, 6395.232572091379, 5937.960856849948, 5952.851178720567, 5963.493103086286, 5963.493103086286, 5964.970175149097, 5762.567807414377, 5855.121731740273, 5963.0, 5989.311229208697, 6015.6691381974415], "unit": "ms", "name": "mootools.html", "value": 4092.1390797404574}, {"lowerIsBetter": false, "replicates": [292.2139444893237, 297.06276697020877, 298.4314880153309, 300.3452473607536, 301.9048999565137, 5215.113430716778, 5279.20811878218, 5289.920651190235, 5295.8146464873735, 5356.276902618155, 4971.801127954886, 5091.847244582668, 5132.153194722866, 5245.86885327867, 5269.947300526994, 4081.8979525511804, 4083.4283200351974, 4085.0400155963325, 4086.5913408659194, 4090.8772736817796, 3878.9030274243228, 4080.9795951020205, 4082.7346222495444, 4086.9795651021705, 4089.9182016359655, 3938.487996560443, 3947.2105578884193, 4015.4779878615886, 4030.798460076999, 4063.4920634920636, 4032.052467670095, 4034.979825100885, 4045.352743561031, 4050.574689657573, 4054.5742697016685, 3566.1262990567216, 3566.857325706969, 3567.0369000369756, 3570.946435803465, 3575.3921833288405, 5093.541581257705, 5095.388553373619, 5102.38771347437, 5111.718855462948, 5111.974440127813, 4571.657125715551, 4664.696794708333, 4680.602148817355, 4688.367070445481, 4691.953080469186, 5500.752466138993, 5506.339239291271, 5510.173473978895, 5513.20058591506, 5521.033819081685, 3875.2830726315724, 3881.786501742403, 3888.105735680781, 3888.183481468895, 3899.220155968789, 5787.884242315172, 5808.0, 5811.767529298865, 5817.418258174149, 5819.67991760453, 3905.906346223062, 4009.9599004009588, 4012.0772222389014, 4018.3570628699267, 4025.9798701006894, 4067.3695577185586, 4068.5931406859077, 4073.735207211522, 4074.837006519706, 4075.286824805647, 4622.0, 4633.629309655287, 4640.23436133041, 4641.234196357564, 4643.74459404736, 5520.641158324696, 5528.806491772769, 5528.889422211533, 5530.032244357221, 5530.419305972815, 1414.5968399006233, 1414.9575512734634, 1422.30307149496, 1443.0547991065869, 1445.6096853849401, 927.9164875161133, 932.1796818799413, 933.8132373525322, 934.8924873639619, 963.5471328475605, 4881.95118048822, 4883.633727470454, 4894.706317620954, 4896.902061958741, 4901.387326584177, 5729.48434640876, 5736.770529178786, 5737.110747834093, 5745.971270143623, 5746.856328591819, 4721.669483136147, 4772.5227477252, 4855.344528488679, 4874.829380971649, 4889.339939108246, 3055.5111182211185, 3099.1942095055447, 3104.1153271317567, 3109.9844500777804, 3115.065480355884, 5477.096279113981, 5477.507024367826, 5481.260029895913, 5489.945100549024, 5491.725413729378, 5925.792597259161, 5935.258092738408, 5935.436133567304, 5940.0, 5945.970270148621, 5345.251664766935, 5484.561235101182, 5505.064139096443, 5508.504234618904, 5509.449055094458, 5811.970940145272, 5824.475797178275, 5826.067829147316, 5826.213461182686, 5836.912446313224, 5669.773209071756, 5671.517920976763, 5676.886462270649, 5681.602287839812, 5681.630694004876, 5330.0, 5493.258410114583, 5493.835184944458, 5495.587830912617, 5502.202180683858, 3882.9805850970565, 3921.274564205631, 3927.6072392760493, 3935.468711723995, 3936.547297060875, 5786.045302525036, 5792.507636850914, 5794.188813566188, 5798.971005144947, 5802.448767367094, 5573.080441727069, 5583.581231407579, 5586.497215250647, 5591.748371323219, 5592.133219351007, 5439.374471935778, 5586.832395028156, 5594.41258667834, 5599.748011339418, 5611.859703507445, 5469.124940009579, 5477.72611369422, 5483.561315094863, 5493.670379777226, 5494.478024587658, 5634.52106570946, 5636.126400407943, 5640.4077571856005, 5645.350784659652, 5648.745806438638, 5382.623216374816, 5508.504234618904, 5508.586855985897, 5509.862253443696, 5510.338759348743], "unit": "ms", "name": "prototype.html", "value": 4167.642910687941}, {"lowerIsBetter": false, "replicates": [769.1424062170681, 785.6425326476452, 788.259036505685, 797.7008621766837, 799.4403917257918, 11424.54301827927, 11598.768024639512, 11607.187496875202, 11612.419379031046, 11630.592929247478, 10555.788884222311, 10560.894391056087, 10649.52077156528, 10659.893401065987, 10748.892511074888, 613.4203177996795, 623.4264476681441, 625.2372106030635, 625.4808508937571, 625.5964902637796, 606.3300053440951, 777.8599852026633, 793.7896457438783, 796.9083555391146, 797.7845981584968, 829.7303376402693, 836.6946064686376, 837.8533756592602, 845.9238668519832, 847.4999750147412, 622.9127922090911, 629.2260519560965, 840.5797101449275, 841.1966571923798, 841.5161282262693, 470.1631096647972, 613.5091926458815, 619.8729260501586, 626.408044398044, 626.6115008694638, 11753.706157346049, 11904.58333958316, 11914.642560723192, 11929.403529823474, 11930.463129159209, 11029.338239705563, 11322.773544529146, 11583.420828958519, 11686.12354073448, 11868.050555955502, 9465.716028519155, 9543.570539325747, 9583.808323833484, 9598.232141428669, 9704.805903881954, 3215.1640573450836, 3235.0, 3260.673932606744, 3270.6238782540076, 3325.966740332614, 37348.62651373506, 40797.79601102005, 40880.0, 40902.38646420306, 41030.79484602588, 9109.590068446936, 9159.450432974043, 9164.495952722531, 9169.083091690778, 9254.398464099811, 16445.25996330168, 16459.34162633481, 16465.58836029085, 16466.341346346013, 16472.176391180394, 6047.697615119227, 6085.817425477243, 6277.8744425111245, 6312.495000399957, 6315.179026726496, 3571.8928432147077, 3575.4458059000895, 3600.063983364344, 3626.220362622049, 3667.5232219811787, 2687.5565531687052, 2704.7558123263125, 2709.065372446503, 2715.0, 2716.687580928179, 462.4242817691995, 463.3466811795352, 470.6493662221667, 473.4507970753909, 478.7510494542818, 549.2009126720612, 560.6608002158716, 593.1517929361055, 604.29901314475, 619.2259675405743, 7561.3194812467145, 8532.530710810965, 8614.956925215334, 8699.826003479895, 8703.695370661997, 472.37410431178137, 477.7276952137248, 482.1466005170828, 573.4316643978715, 630.1146888621494, 3458.4639380896, 3586.1393265616584, 3719.795411252353, 3722.8324725386883, 3764.153065560227, 47934.76032619815, 48588.27117593239, 50809.0, 51636.0, 51977.220341694905, 40693.0, 40887.97780055522, 40888.591114089075, 40921.59078409178, 41257.58742412597, 39475.0, 40288.59711402907, 40567.0, 40761.38857917133, 40972.59027409747, 7780.961095194488, 7936.682532698627, 8154.266116049584, 8341.332693384393, 8533.615987280711, 32075.198120047186, 32408.351832962737, 32495.187620308734, 32537.34925301528, 33032.84385046512, 36873.262534749694, 37138.44292335671, 38805.41791873068, 38838.80580597079, 39887.40168897527, 9995.300328977193, 10229.488525573543, 10398.168146548107, 10413.563524037201, 10492.685219443429, 10882.945585272022, 11391.829122563002, 11429.371384573928, 11496.310221386744, 11774.3524106175, 10363.170946324126, 10474.109700675528, 10684.46577671129, 10711.839322410015, 10840.457977100956, 10752.408617525798, 10949.83575246388, 11071.83392249133, 11246.381449020382, 11644.941775291069, 10509.579616815241, 10868.456577171268, 10931.125509959025, 11190.32858028521, 11419.371934543347, 8962.32782541299, 9040.864387034331, 9063.909360906306, 9252.49111298885, 9425.245980321695, 8790.252828509649, 8803.515806630441, 8881.955590222007, 8955.641774329215, 9120.315976301672], "unit": "ms", "name": "yui.html", "value": 5660.323890561511}], "name": "dromaeo_css", "value": 6312.169295087424}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 104.0, 111.0, 111.0, 114.0, 101.0, 110.0, 114.0, 103.0], "unit": "ms", "name": "ai-astar", "value": 109.0}, {"lowerIsBetter": true, "replicates": [150.0, 129.0, 154.0, 167.0, 130.0, 161.0, 151.0, 128.0, 163.0, 132.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.5}, {"lowerIsBetter": true, "replicates": [160.0, 162.0, 160.0, 160.0, 162.0, 160.0, 165.0, 161.0, 162.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 80.0, 91.0, 72.0, 73.0, 72.0, 102.0, 93.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 79.7}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 129.0, 94.0, 94.0, 95.0, 129.0, 94.0, 95.0, 137.0], "unit": "ms", "name": "audio-oscillator", "value": 105.7}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [146.0, 148.0, 147.0, 147.0, 147.0, 147.0, 150.0, 146.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 97.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 71.0, 71.0, 71.0, 70.0, 71.0, 78.0, 68.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 71.2}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 68.0, 69.0, 70.0, 68.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [85.0, 90.0, 83.0, 87.0, 84.0, 84.0, 83.0, 85.0, 85.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.0}, {"lowerIsBetter": true, "replicates": [129.0, 126.0, 126.0, 123.0, 128.0, 117.0, 118.0, 119.0, 125.0, 121.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.2}, {"lowerIsBetter": true, "replicates": [154.0, 136.0, 148.0, 152.0, 151.0, 158.0, 149.0, 147.0, 146.0, 136.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.7}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 68.0, 69.0, 69.0, 69.0, 70.0, 70.0, 69.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.9}], "name": "kraken", "value": 1519.0000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.39861065167054], "unit": "score", "name": "Richards", "value": 213.43589200000002}, {"lowerIsBetter": false, "replicates": [186.15040953090096], "unit": "score", "name": "DeltaBlue", "value": 355.1858960000002}, {"lowerIsBetter": false, "replicates": [278.6291446085261], "unit": "score", "name": "Encrypt", "value": 955.3236090000001}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [1980.1980198019803], "unit": "score", "name": "RayTrace", "value": 373.6944450000001}, {"lowerIsBetter": false, "replicates": [784.3137254901961], "unit": "score", "name": "Earley", "value": 849.7403250000002}, {"lowerIsBetter": false, "replicates": [12132.530120481928], "unit": "score", "name": "Boyer", "value": 54.93190566037737}, {"lowerIsBetter": false, "replicates": [26763.157894736843], "unit": "score", "name": "RegExp", "value": 34.0387708947886}, {"lowerIsBetter": false, "replicates": [619.047619047619], "unit": "score", "name": "Splay", "value": 131.63930769230765}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19794.32116439756}]} 21:07:03 INFO - RETURN: dromaeo_css: 6312.17 21:07:03 INFO - RETURN: kraken: 1519.00 21:07:03 INFO - RETURN: v8_7: 19794.32 21:07:03 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,144,35]]", "result": "19794.32"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,144,35]]", "result": "1519.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,144,35]]", "result": "6312.17"}}} 21:07:03 INFO - Return code: 0 21:07:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 21:07:03 INFO - # TBPL SUCCESS # 21:07:03 INFO - Running post-action listener: _resource_record_post_action 21:07:03 INFO - Running post-run listener: _resource_record_post_run 21:07:05 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 333070336; Read time: 12; Write time: 230668 21:07:05 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 13340672; Read time: 0; Write time: 2028 21:07:05 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 4096; Write bytes: 319729664; Read time: 12; Write time: 228640 21:07:05 INFO - Running post-run listener: _upload_blobber_files 21:07:05 INFO - Blob upload gear active. 21:07:05 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 21:07:05 INFO - Copying logs to upload dir... 21:07:05 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1290.032975 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2015-12-03 21:07:04.700860) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 21:07:04.704812) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1449203129.498243-731067672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/bNvlkaFfQgma7Y0-f3h5og/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010176 build_url: 'https://queue.taskcluster.net/v1/task/bNvlkaFfQgma7Y0-f3h5og/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 21:07:04.756475) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 21:07:04.756827) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1449203129.498243-731067672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004537 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 21:07:04.806776) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 21:07:04.807092) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 21:07:04.807418) ========= ========= Total master_lag: 0.23 =========