builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-003 starttime: 1449134853.36 results: success (0) buildid: 20151203005925 builduid: 9e23c050f9004bf79f445e6bf9cb82bb revision: 92499b34eeffbfdaf5df19f63c464988435356db ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 01:27:33.363154) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 01:27:33.364455) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 01:27:33.364972) ========= 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=21869f6c619b95355032545b000001da-1449134672.635411-155353781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004621 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 01:27:33.402418) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 01:27:33.402728) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 01:27:33.429249) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 01:27:33.429613) ========= 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=21869f6c619b95355032545b000001da-1449134672.635411-155353781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004731 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 01:27:33.479546) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 01:27:33.479886) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 01:27:33.480296) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 01:27:33.480716) ========= 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=21869f6c619b95355032545b000001da-1449134672.635411-155353781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-03 01:27:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2015-12-03 01:27:33 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179662 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 01:27:33.676021) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 01:27:33.676367) ========= 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=21869f6c619b95355032545b000001da-1449134672.635411-155353781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017635 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 01:27:33.726455) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 01:27:33.726868) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 92499b34eeffbfdaf5df19f63c464988435356db --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 92499b34eeffbfdaf5df19f63c464988435356db --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=21869f6c619b95355032545b000001da-1449134672.635411-155353781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-03 01:27:33,960 truncating revision to first 12 chars 2015-12-03 01:27:33,960 Setting DEBUG logging. 2015-12-03 01:27:33,960 attempt 1/10 2015-12-03 01:27:33,960 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/92499b34eeff?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-03 01:27:34,250 unpacking tar archive at: fx-team-92499b34eeff/testing/mozharness/ program finished with exit code 0 elapsedTime=0.598365 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 01:27:34.338928) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 01:27:34.339242) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 01:27:34.366165) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 01:27:34.366549) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 01:27:34.366982) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-12-03 01:27:34.367292) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=21869f6c619b95355032545b000001da-1449134672.635411-155353781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:27:34 INFO - MultiFileLogger online at 20151203 01:27:34 in /builds/slave/test 01:27:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 01:27:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:27:34 INFO - {'append_to_log': False, 01:27:34 INFO - 'base_work_dir': '/builds/slave/test', 01:27:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 01:27:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:27:34 INFO - 'branch': 'Fx-Team-Non-PGO', 01:27:34 INFO - 'buildbot_json_path': 'buildprops.json', 01:27:34 INFO - 'config_files': ('talos/linux_config.py',), 01:27:34 INFO - 'default_actions': ('clobber', 01:27:34 INFO - 'read-buildbot-config', 01:27:34 INFO - 'download-and-extract', 01:27:34 INFO - 'populate-webroot', 01:27:34 INFO - 'create-virtualenv', 01:27:34 INFO - 'install', 01:27:34 INFO - 'run-tests'), 01:27:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:27:34 INFO - 'download_minidump_stackwalk': True, 01:27:34 INFO - 'download_symbols': 'ondemand', 01:27:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:27:34 INFO - 'tooltool.py': '/tools/tooltool.py', 01:27:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:27:34 INFO - '/tools/misc-python/virtualenv.py')}, 01:27:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:27:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:27:34 INFO - 'installer_path': 'installer.exe', 01:27:34 INFO - 'log_level': 'info', 01:27:34 INFO - 'log_name': 'talos', 01:27:34 INFO - 'log_to_console': True, 01:27:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:27:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:27:34 INFO - 'opt_config_files': (), 01:27:34 INFO - 'pip_index': False, 01:27:34 INFO - 'sps_profile': False, 01:27:34 INFO - 'sps_profile_interval': 0, 01:27:34 INFO - 'suite': 'dromaeojs-e10s', 01:27:34 INFO - 'system_bits': '64', 01:27:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:27:34 INFO - 'title': 'talos-linux64-ix-003', 01:27:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:27:34 INFO - 'use_talos_json': True, 01:27:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:27:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:27:34 INFO - 'work_dir': 'build'} 01:27:34 INFO - ##### 01:27:34 INFO - ##### Running clobber step. 01:27:34 INFO - ##### 01:27:34 INFO - Running pre-action listener: _resource_record_pre_action 01:27:34 INFO - Running main action method: clobber 01:27:34 INFO - rmtree: /builds/slave/test/build 01:27:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:27:35 INFO - Running post-action listener: _resource_record_post_action 01:27:35 INFO - ##### 01:27:35 INFO - ##### Running read-buildbot-config step. 01:27:35 INFO - ##### 01:27:35 INFO - Running pre-action listener: _resource_record_pre_action 01:27:35 INFO - Running main action method: read_buildbot_config 01:27:35 INFO - Using buildbot properties: 01:27:35 INFO - { 01:27:35 INFO - "properties": { 01:27:35 INFO - "buildnumber": 509, 01:27:35 INFO - "product": "firefox", 01:27:35 INFO - "script_repo_revision": "production", 01:27:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 01:27:35 INFO - "repository": "", 01:27:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 01:27:35 INFO - "buildid": "20151203005925", 01:27:35 INFO - "slavename": "talos-linux64-ix-003", 01:27:35 INFO - "pgo_build": "False", 01:27:35 INFO - "basedir": "/builds/slave/test", 01:27:35 INFO - "project": "", 01:27:35 INFO - "platform": "ubuntu64_hw", 01:27:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:27:35 INFO - "slavebuilddir": "test", 01:27:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 01:27:35 INFO - "branch": "fx-team", 01:27:35 INFO - "repo_path": "integration/fx-team", 01:27:35 INFO - "stage_platform": "linux64", 01:27:35 INFO - "builduid": "9e23c050f9004bf79f445e6bf9cb82bb", 01:27:35 INFO - "revision": "92499b34eeffbfdaf5df19f63c464988435356db" 01:27:35 INFO - }, 01:27:35 INFO - "sourcestamp": { 01:27:35 INFO - "repository": "", 01:27:35 INFO - "hasPatch": false, 01:27:35 INFO - "project": "", 01:27:35 INFO - "branch": "fx-team-linux64-talos", 01:27:35 INFO - "changes": [ 01:27:35 INFO - { 01:27:35 INFO - "category": null, 01:27:35 INFO - "files": [ 01:27:35 INFO - { 01:27:35 INFO - "url": null, 01:27:35 INFO - "name": "https://queue.taskcluster.net/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 01:27:35 INFO - } 01:27:35 INFO - ], 01:27:35 INFO - "repository": "", 01:27:35 INFO - "rev": "92499b34eeffbfdaf5df19f63c464988435356db", 01:27:35 INFO - "who": "pbrosset@mozilla.com", 01:27:35 INFO - "when": 1449134738, 01:27:35 INFO - "number": 6738181, 01:27:35 INFO - "comments": "Bug 1225514 - Simple fix for searching with attribute selectors in the inspector; r=bgrins", 01:27:35 INFO - "project": "", 01:27:35 INFO - "at": "Thu 03 Dec 2015 01:25:38", 01:27:35 INFO - "branch": "fx-team-linux64-talos", 01:27:35 INFO - "revlink": "", 01:27:35 INFO - "properties": [ 01:27:35 INFO - [ 01:27:35 INFO - "buildid", 01:27:35 INFO - "20151203005925", 01:27:35 INFO - "Change" 01:27:35 INFO - ], 01:27:35 INFO - [ 01:27:35 INFO - "builduid", 01:27:35 INFO - "9e23c050f9004bf79f445e6bf9cb82bb", 01:27:35 INFO - "Change" 01:27:35 INFO - ], 01:27:35 INFO - [ 01:27:35 INFO - "pgo_build", 01:27:35 INFO - "False", 01:27:35 INFO - "Change" 01:27:35 INFO - ] 01:27:35 INFO - ], 01:27:35 INFO - "revision": "92499b34eeffbfdaf5df19f63c464988435356db" 01:27:35 INFO - } 01:27:35 INFO - ], 01:27:35 INFO - "revision": "92499b34eeffbfdaf5df19f63c464988435356db" 01:27:35 INFO - } 01:27:35 INFO - } 01:27:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 01:27:35 INFO - Running post-action listener: _resource_record_post_action 01:27:35 INFO - ##### 01:27:35 INFO - ##### Running download-and-extract step. 01:27:35 INFO - ##### 01:27:35 INFO - Running pre-action listener: _resource_record_pre_action 01:27:35 INFO - Running main action method: download_and_extract 01:27:35 INFO - mkdir: /builds/slave/test/build/tests 01:27: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')]} 01:27:35 INFO - https://queue.taskcluster.net/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:27:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/test_packages.json 01:27:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/test_packages.json 01:27:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 01:27:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 01:27:36 INFO - Downloaded 1302 bytes. 01:27:36 INFO - Reading from file /builds/slave/test/build/test_packages.json 01:27:36 INFO - Using the following test package requirements: 01:27:36 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 01:27:36 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:27:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:27:36 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:27:36 INFO - u'jsshell-linux-x86_64.zip'], 01:27:36 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:27:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:27:36 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 01:27:36 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:27:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:27:36 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:27:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:27:36 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:27:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:27:36 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 01:27:36 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:27:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:27:36 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:27: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')]} 01:27:36 INFO - https://queue.taskcluster.net/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:27:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:27:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:27:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyCNorK9SBueuTbFU1lNyA/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 01:27:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyCNorK9SBueuTbFU1lNyA/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 01:27:37 INFO - Downloaded 21774562 bytes. 01:27:37 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 01:27:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:27:37 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 01:27:38 INFO - Return code: 0 01:27:38 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 01:27:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:27:38 INFO - https://queue.taskcluster.net/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:27:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:27:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:27:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyCNorK9SBueuTbFU1lNyA/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 01:27:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyCNorK9SBueuTbFU1lNyA/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 01:27:41 INFO - Downloaded 21774562 bytes. 01:27:41 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 01:27:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:27:41 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 01:27:42 INFO - Return code: 0 01:27:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:27:42 INFO - https://queue.taskcluster.net/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:27:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 01:27:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 01:27:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyCNorK9SBueuTbFU1lNyA/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 01:27:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyCNorK9SBueuTbFU1lNyA/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 01:27:44 INFO - Downloaded 11132001 bytes. 01:27:44 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 01:27:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 01:27:44 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 01:27:45 INFO - Return code: 0 01:27:45 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')]} 01:27:45 INFO - https://queue.taskcluster.net/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:27:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:27:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:27:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyCNorK9SBueuTbFU1lNyA/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 01:27:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyCNorK9SBueuTbFU1lNyA/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 01:27:49 INFO - Downloaded 57683488 bytes. 01:27:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:27:49 INFO - mkdir: /builds/slave/test/properties 01:27:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:27:49 INFO - Writing to file /builds/slave/test/properties/build_url 01:27:49 INFO - Contents: 01:27:49 INFO - build_url:https://queue.taskcluster.net/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:27:49 INFO - Running post-action listener: _resource_record_post_action 01:27:49 INFO - Running post-action listener: set_extra_try_arguments 01:27:49 INFO - ##### 01:27:49 INFO - ##### Running populate-webroot step. 01:27:49 INFO - ##### 01:27:49 INFO - Running pre-action listener: _resource_record_pre_action 01:27:49 INFO - Running main action method: populate_webroot 01:27:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:27:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:27:49 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 01:27:49 INFO - '../fennec_ids.txt'], 01:27:49 INFO - 'tests': ['tcheck2']}, 01:27:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:27:49 INFO - '--tppagecycles', 01:27:49 INFO - '7'], 01:27:49 INFO - 'tests': ['tsvgm']}}, 01:27:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:27:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:27:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:27:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:27:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:27:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:27:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:27:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:27:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:27:49 INFO - 'talos_options': ['--e10s'], 01:27:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:27:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:27:49 INFO - 'tests': ['damp', 'tps']}, 01:27:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:27:49 INFO - 'talos_options': ['--e10s'], 01:27:49 INFO - 'tests': ['damp', 'tps']}, 01:27:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:27:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:27:49 INFO - 'other': {'tests': ['a11yr', 01:27:49 INFO - 'ts_paint', 01:27:49 INFO - 'tpaint', 01:27:49 INFO - 'sessionrestore', 01:27:49 INFO - 'sessionrestore_no_auto_restore']}, 01:27:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:27:49 INFO - 'tests': ['a11yr', 01:27:49 INFO - 'ts_paint', 01:27:49 INFO - 'tpaint', 01:27:49 INFO - 'sessionrestore', 01:27:49 INFO - 'sessionrestore_no_auto_restore']}, 01:27:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:27:49 INFO - 'tests': ['a11yr', 01:27:49 INFO - 'ts_paint', 01:27:49 INFO - 'tpaint', 01:27:49 INFO - 'sessionrestore', 01:27:49 INFO - 'sessionrestore_no_auto_restore']}, 01:27:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:27:49 INFO - 'tests': ['a11yr', 01:27:49 INFO - 'ts_paint', 01:27:49 INFO - 'tpaint', 01:27:49 INFO - 'sessionrestore', 01:27:49 INFO - 'sessionrestore_no_auto_restore']}, 01:27:49 INFO - 'other_l64': {'tests': ['a11yr', 01:27:49 INFO - 'ts_paint', 01:27:49 INFO - 'tpaint', 01:27:49 INFO - 'sessionrestore', 01:27:49 INFO - 'sessionrestore_no_auto_restore']}, 01:27:49 INFO - 'other_nol64': {'tests': ['a11yr', 01:27:49 INFO - 'ts_paint', 01:27:49 INFO - 'tpaint', 01:27:49 INFO - 'sessionrestore', 01:27:49 INFO - 'sessionrestore_no_auto_restore']}, 01:27:49 INFO - 'svgr': {'tests': ['tsvgx', 01:27:49 INFO - 'tsvgr_opacity', 01:27:49 INFO - 'tart', 01:27:49 INFO - 'tscrollx', 01:27:49 INFO - 'cart']}, 01:27:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:27:49 INFO - 'tests': ['tsvgx', 01:27:49 INFO - 'tsvgr_opacity', 01:27:49 INFO - 'tart', 01:27:49 INFO - 'tscrollx', 01:27:49 INFO - 'cart']}, 01:27:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:27:49 INFO - 'tests': ['tp5o']}, 01:27:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:27:49 INFO - 'talos_options': ['--e10s'], 01:27:49 INFO - 'tests': ['tp5o']}, 01:27:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:27:49 INFO - 'talos_options': ['--xperf_path', 01:27:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:27:49 INFO - 'tests': ['tp5n']}, 01:27:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:27:49 INFO - 'talos_options': ['--e10s', 01:27:49 INFO - '--xperf_path', 01:27:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:27:49 INFO - 'tests': ['tp5n']}}, 01:27:49 INFO - 'talos.zip': {'path': '', 01:27:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:27:49 INFO - Running post-action listener: _resource_record_post_action 01:27:49 INFO - ##### 01:27:49 INFO - ##### Running create-virtualenv step. 01:27:49 INFO - ##### 01:27:49 INFO - Running pre-action listener: _resource_record_pre_action 01:27:49 INFO - Running main action method: create_virtualenv 01:27:49 INFO - Creating virtualenv /builds/slave/test/build/venv 01:27:49 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 01:27:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:27:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:27:49 INFO - Using real prefix '/usr' 01:27:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:27:50 INFO - Installing distribute.............................................................................................................................................................................................done. 01:27:52 INFO - Installing pip.................done. 01:27:52 INFO - Return code: 0 01:27:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:27: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')]} 01:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:27:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27: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')]} 01:27:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:27:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:52 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 0x7fad34174f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dca0b0>, '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 0x1dcafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcb440>, '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': '21869f6c619b95355032545b000001da-1449134672.635411-155353781', '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 01:27:52 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 01:27:52 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 01:27:52 INFO - Using env: {'DISPLAY': ':0', 01:27:52 INFO - 'HOME': '/home/cltbld', 01:27:52 INFO - 'LANG': 'en_US.UTF-8', 01:27:52 INFO - 'LANGUAGE': 'en_US:en', 01:27:52 INFO - 'LOGNAME': 'cltbld', 01:27:52 INFO - 'MAIL': '/var/mail/cltbld', 01:27:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:52 INFO - 'MOZ_NO_REMOTE': '1', 01:27:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:27:52 INFO - 'NO_EM_RESTART': '1', 01:27:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:27:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:27:52 INFO - 'PWD': '/builds/slave/test', 01:27:52 INFO - 'SHELL': '/bin/bash', 01:27:52 INFO - 'SHLVL': '1', 01:27:52 INFO - 'TERM': 'linux', 01:27:52 INFO - 'TMOUT': '86400', 01:27:52 INFO - 'USER': 'cltbld', 01:27:52 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1449134672.635411-155353781', 01:27:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:52 INFO - '_': '/tools/buildbot/bin/python'} 01:27:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:27:52 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 01:27:52 INFO - Cleaning up... 01:27:52 INFO - Return code: 0 01:27:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:27: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')]} 01:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:27:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27: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')]} 01:27:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:27:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:52 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 0x7fad34174f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dca0b0>, '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 0x1dcafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcb440>, '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': '21869f6c619b95355032545b000001da-1449134672.635411-155353781', '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 01:27:52 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 01:27:52 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 01:27:52 INFO - Using env: {'DISPLAY': ':0', 01:27:52 INFO - 'HOME': '/home/cltbld', 01:27:52 INFO - 'LANG': 'en_US.UTF-8', 01:27:52 INFO - 'LANGUAGE': 'en_US:en', 01:27:52 INFO - 'LOGNAME': 'cltbld', 01:27:52 INFO - 'MAIL': '/var/mail/cltbld', 01:27:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:52 INFO - 'MOZ_NO_REMOTE': '1', 01:27:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:27:52 INFO - 'NO_EM_RESTART': '1', 01:27:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:27:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:27:52 INFO - 'PWD': '/builds/slave/test', 01:27:52 INFO - 'SHELL': '/bin/bash', 01:27:52 INFO - 'SHLVL': '1', 01:27:52 INFO - 'TERM': 'linux', 01:27:52 INFO - 'TMOUT': '86400', 01:27:52 INFO - 'USER': 'cltbld', 01:27:52 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1449134672.635411-155353781', 01:27:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:52 INFO - '_': '/tools/buildbot/bin/python'} 01:27:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:27:52 INFO - Downloading/unpacking psutil>=0.7.1 01:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:54 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 01:27:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 01:27:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:27:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:27:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:27:54 INFO - Installing collected packages: psutil 01:27:54 INFO - Running setup.py install for psutil 01:27:54 INFO - building 'psutil._psutil_linux' extension 01:27:54 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 01:27:54 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 01:27:54 INFO - building 'psutil._psutil_posix' extension 01:27:54 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 01:27:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 01:27:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:27:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:27:55 INFO - Successfully installed psutil 01:27:55 INFO - Cleaning up... 01:27:55 INFO - Return code: 0 01:27:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:27:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:27:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:27:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:55 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 0x7fad34174f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dca0b0>, '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 0x1dcafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcb440>, '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': '21869f6c619b95355032545b000001da-1449134672.635411-155353781', '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 01:27:55 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 01:27:55 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 01:27:55 INFO - Using env: {'DISPLAY': ':0', 01:27:55 INFO - 'HOME': '/home/cltbld', 01:27:55 INFO - 'LANG': 'en_US.UTF-8', 01:27:55 INFO - 'LANGUAGE': 'en_US:en', 01:27:55 INFO - 'LOGNAME': 'cltbld', 01:27:55 INFO - 'MAIL': '/var/mail/cltbld', 01:27:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:55 INFO - 'MOZ_NO_REMOTE': '1', 01:27:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:27:55 INFO - 'NO_EM_RESTART': '1', 01:27:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:27:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:27:55 INFO - 'PWD': '/builds/slave/test', 01:27:55 INFO - 'SHELL': '/bin/bash', 01:27:55 INFO - 'SHLVL': '1', 01:27:55 INFO - 'TERM': 'linux', 01:27:55 INFO - 'TMOUT': '86400', 01:27:55 INFO - 'USER': 'cltbld', 01:27:55 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1449134672.635411-155353781', 01:27:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:55 INFO - '_': '/tools/buildbot/bin/python'} 01:27:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:27:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:27:55 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 01:27:55 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 01:27:55 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 01:27:55 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 01:27:55 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 01:27:55 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 01:27:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:27:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 01:27:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:27:57 INFO - Installing collected packages: mozsystemmonitor 01:27:57 INFO - Running setup.py install for mozsystemmonitor 01:27:57 INFO - Successfully installed mozsystemmonitor 01:27:57 INFO - Cleaning up... 01:27:57 INFO - Return code: 0 01:27:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:27:57 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')]} 01:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:27:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:57 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')]} 01:27:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:27:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:57 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 0x7fad34174f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dca0b0>, '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 0x1dcafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcb440>, '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': '21869f6c619b95355032545b000001da-1449134672.635411-155353781', '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 01:27:57 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 01:27:57 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 01:27:57 INFO - Using env: {'DISPLAY': ':0', 01:27:57 INFO - 'HOME': '/home/cltbld', 01:27:57 INFO - 'LANG': 'en_US.UTF-8', 01:27:57 INFO - 'LANGUAGE': 'en_US:en', 01:27:57 INFO - 'LOGNAME': 'cltbld', 01:27:57 INFO - 'MAIL': '/var/mail/cltbld', 01:27:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:57 INFO - 'MOZ_NO_REMOTE': '1', 01:27:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:27:57 INFO - 'NO_EM_RESTART': '1', 01:27:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:27:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:27:57 INFO - 'PWD': '/builds/slave/test', 01:27:57 INFO - 'SHELL': '/bin/bash', 01:27:57 INFO - 'SHLVL': '1', 01:27:57 INFO - 'TERM': 'linux', 01:27:57 INFO - 'TMOUT': '86400', 01:27:57 INFO - 'USER': 'cltbld', 01:27:57 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1449134672.635411-155353781', 01:27:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:57 INFO - '_': '/tools/buildbot/bin/python'} 01:27:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:27:57 INFO - Downloading/unpacking blobuploader==1.2.4 01:27:57 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 01:27:57 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 01:27:57 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 01:27:57 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 01:27:57 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 01:27:57 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 01:27:59 INFO - Downloading blobuploader-1.2.4.tar.gz 01:27:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 01:27:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:27:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 01:27:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:27:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:00 INFO - Downloading docopt-0.6.1.tar.gz 01:28:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 01:28:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:28:00 INFO - Installing collected packages: blobuploader, requests, docopt 01:28:00 INFO - Running setup.py install for blobuploader 01:28:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:28:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:28:00 INFO - Running setup.py install for requests 01:28:00 INFO - Running setup.py install for docopt 01:28:00 INFO - Successfully installed blobuploader requests docopt 01:28:00 INFO - Cleaning up... 01:28:00 INFO - Return code: 0 01:28:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:28:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:28:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:28:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:00 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 0x7fad34174f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dca0b0>, '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 0x1dcafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcb440>, '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': '21869f6c619b95355032545b000001da-1449134672.635411-155353781', '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 01:28:00 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 01:28:00 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 01:28:00 INFO - Using env: {'DISPLAY': ':0', 01:28:00 INFO - 'HOME': '/home/cltbld', 01:28:00 INFO - 'LANG': 'en_US.UTF-8', 01:28:00 INFO - 'LANGUAGE': 'en_US:en', 01:28:00 INFO - 'LOGNAME': 'cltbld', 01:28:00 INFO - 'MAIL': '/var/mail/cltbld', 01:28:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:28:00 INFO - 'MOZ_NO_REMOTE': '1', 01:28:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:28:00 INFO - 'NO_EM_RESTART': '1', 01:28:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:28:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:28:00 INFO - 'PWD': '/builds/slave/test', 01:28:00 INFO - 'SHELL': '/bin/bash', 01:28:00 INFO - 'SHLVL': '1', 01:28:00 INFO - 'TERM': 'linux', 01:28:00 INFO - 'TMOUT': '86400', 01:28:00 INFO - 'USER': 'cltbld', 01:28:00 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1449134672.635411-155353781', 01:28:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:28:00 INFO - '_': '/tools/buildbot/bin/python'} 01:28:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:28:00 INFO - Running setup.py (path:/tmp/pip-0E1uWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:28:00 INFO - Running setup.py (path:/tmp/pip-KsLkd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:28:01 INFO - Running setup.py (path:/tmp/pip-b0ctPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:28:01 INFO - Running setup.py (path:/tmp/pip-dtaITV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:28:01 INFO - Running setup.py (path:/tmp/pip-peC9pJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:28:01 INFO - Running setup.py (path:/tmp/pip-EDc_t0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:28:01 INFO - Running setup.py (path:/tmp/pip-cjU2T4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:28:01 INFO - Running setup.py (path:/tmp/pip-9mZM1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:28:01 INFO - Running setup.py (path:/tmp/pip-aXtB98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:28:01 INFO - Running setup.py (path:/tmp/pip-y3ithC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:28:01 INFO - Running setup.py (path:/tmp/pip-63IkJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:28:01 INFO - Running setup.py (path:/tmp/pip-g33O8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:28:01 INFO - Running setup.py (path:/tmp/pip-K5965i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:28:01 INFO - Running setup.py (path:/tmp/pip-viNw9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:28:01 INFO - Running setup.py (path:/tmp/pip-8KoABm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:28:01 INFO - Running setup.py (path:/tmp/pip-oHv8P4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:28:02 INFO - Running setup.py (path:/tmp/pip-byTUIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:28:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:28:02 INFO - Running setup.py install for manifestparser 01:28:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:28:02 INFO - Running setup.py install for mozcrash 01:28:02 INFO - Running setup.py install for mozdebug 01:28:02 INFO - Running setup.py install for mozdevice 01:28:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:28:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:28:02 INFO - Running setup.py install for mozfile 01:28:02 INFO - Running setup.py install for mozhttpd 01:28:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:28:02 INFO - Running setup.py install for mozinfo 01:28:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:28:02 INFO - Running setup.py install for mozInstall 01:28:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:28:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:28:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:28:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:28:02 INFO - Running setup.py install for mozleak 01:28:03 INFO - Running setup.py install for mozlog 01:28:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:28:03 INFO - Running setup.py install for moznetwork 01:28:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:28:03 INFO - Running setup.py install for mozprocess 01:28:03 INFO - Running setup.py install for mozprofile 01:28:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:28:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:28:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:28:03 INFO - Running setup.py install for mozrunner 01:28:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:28:03 INFO - Running setup.py install for mozscreenshot 01:28:03 INFO - Running setup.py install for moztest 01:28:03 INFO - Running setup.py install for mozversion 01:28:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:28:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:28:03 INFO - Cleaning up... 01:28:03 INFO - Return code: 0 01:28:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:28:03 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')]} 01:28:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:28:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:03 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')]} 01:28:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:28:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:03 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 0x7fad34174f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dca0b0>, '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 0x1dcafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcb440>, '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': '21869f6c619b95355032545b000001da-1449134672.635411-155353781', '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 01:28:03 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 01:28:03 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 01:28:03 INFO - Using env: {'DISPLAY': ':0', 01:28:03 INFO - 'HOME': '/home/cltbld', 01:28:03 INFO - 'LANG': 'en_US.UTF-8', 01:28:03 INFO - 'LANGUAGE': 'en_US:en', 01:28:03 INFO - 'LOGNAME': 'cltbld', 01:28:03 INFO - 'MAIL': '/var/mail/cltbld', 01:28:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:28:03 INFO - 'MOZ_NO_REMOTE': '1', 01:28:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:28:03 INFO - 'NO_EM_RESTART': '1', 01:28:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:28:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:28:03 INFO - 'PWD': '/builds/slave/test', 01:28:03 INFO - 'SHELL': '/bin/bash', 01:28:03 INFO - 'SHLVL': '1', 01:28:03 INFO - 'TERM': 'linux', 01:28:03 INFO - 'TMOUT': '86400', 01:28:03 INFO - 'USER': 'cltbld', 01:28:03 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1449134672.635411-155353781', 01:28:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:28:03 INFO - '_': '/tools/buildbot/bin/python'} 01:28:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:28:04 INFO - Running setup.py (path:/tmp/pip-ArEWDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:28:04 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)) 01:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:28:04 INFO - Running setup.py (path:/tmp/pip-fi4Hi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:28:04 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)) 01:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:28:04 INFO - Running setup.py (path:/tmp/pip-m30pJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:28:04 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)) 01:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:28:04 INFO - Running setup.py (path:/tmp/pip-lx1WJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:28:04 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)) 01:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:28:04 INFO - Running setup.py (path:/tmp/pip-QAqSx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:28:04 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)) 01:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:28:04 INFO - Running setup.py (path:/tmp/pip-Fns_MX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:28:04 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)) 01:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:28:04 INFO - Running setup.py (path:/tmp/pip-zEBmiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:28:04 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)) 01:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:28:04 INFO - Running setup.py (path:/tmp/pip-eJX0Lc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:28:04 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)) 01:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:28:04 INFO - Running setup.py (path:/tmp/pip-G1DAT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:28:04 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)) 01:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:28:04 INFO - Running setup.py (path:/tmp/pip-w0nnDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:28:04 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)) 01:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:28:04 INFO - Running setup.py (path:/tmp/pip-8H6kLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:28:04 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)) 01:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:28:04 INFO - Running setup.py (path:/tmp/pip-3mkPV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:28:04 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)) 01:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:28:04 INFO - Running setup.py (path:/tmp/pip-nk_XTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:28:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 01:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:28:05 INFO - Running setup.py (path:/tmp/pip-PlQo4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:28:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:28:05 INFO - Running setup.py (path:/tmp/pip-upK4Ed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:28:05 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)) 01:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:28:05 INFO - Running setup.py (path:/tmp/pip-CxP_rQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:28:05 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)) 01:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:28:05 INFO - Running setup.py (path:/tmp/pip-GF6VSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:28:05 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)) 01:28:05 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)) 01:28:05 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)) 01:28:05 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)) 01:28:05 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)) 01:28:05 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)) 01:28:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:28:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:07 INFO - Downloading blessings-1.5.1.tar.gz 01:28:07 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 01:28:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:28:07 INFO - Installing collected packages: blessings 01:28:07 INFO - Running setup.py install for blessings 01:28:07 INFO - Successfully installed blessings 01:28:07 INFO - Cleaning up... 01:28:07 INFO - Return code: 0 01:28:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:28:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:28:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:28:07 INFO - Reading from file tmpfile_stdout 01:28:07 INFO - Current package versions: 01:28:07 INFO - argparse == 1.2.1 01:28:07 INFO - blessings == 1.5.1 01:28:07 INFO - blobuploader == 1.2.4 01:28:07 INFO - docopt == 0.6.1 01:28:07 INFO - manifestparser == 1.1 01:28:07 INFO - mozInstall == 1.12 01:28:07 INFO - mozcrash == 0.16 01:28:07 INFO - mozdebug == 0.1 01:28:07 INFO - mozdevice == 0.47 01:28:07 INFO - mozfile == 1.2 01:28:07 INFO - mozhttpd == 0.7 01:28:07 INFO - mozinfo == 0.9 01:28:07 INFO - mozleak == 0.1 01:28:07 INFO - mozlog == 3.1 01:28:07 INFO - moznetwork == 0.27 01:28:07 INFO - mozprocess == 0.22 01:28:07 INFO - mozprofile == 0.27 01:28:07 INFO - mozrunner == 6.11 01:28:07 INFO - mozscreenshot == 0.1 01:28:07 INFO - mozsystemmonitor == 0.0 01:28:07 INFO - moztest == 0.7 01:28:07 INFO - mozversion == 1.4 01:28:07 INFO - psutil == 3.1.1 01:28:07 INFO - requests == 1.2.3 01:28:07 INFO - wsgiref == 0.1.2 01:28:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:28:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:28:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:28:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fad34174f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dca0b0>, '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 0x1dcafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcb440>, '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': '21869f6c619b95355032545b000001da-1449134672.635411-155353781', '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 01:28:07 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 01:28:07 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 01:28:07 INFO - Using env: {'DISPLAY': ':0', 01:28:07 INFO - 'HOME': '/home/cltbld', 01:28:07 INFO - 'LANG': 'en_US.UTF-8', 01:28:07 INFO - 'LANGUAGE': 'en_US:en', 01:28:07 INFO - 'LOGNAME': 'cltbld', 01:28:07 INFO - 'MAIL': '/var/mail/cltbld', 01:28:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:28:07 INFO - 'MOZ_NO_REMOTE': '1', 01:28:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:28:07 INFO - 'NO_EM_RESTART': '1', 01:28:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:28:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:28:07 INFO - 'PWD': '/builds/slave/test', 01:28:07 INFO - 'SHELL': '/bin/bash', 01:28:07 INFO - 'SHLVL': '1', 01:28:07 INFO - 'TERM': 'linux', 01:28:07 INFO - 'TMOUT': '86400', 01:28:07 INFO - 'USER': 'cltbld', 01:28:07 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1449134672.635411-155353781', 01:28:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:28:07 INFO - '_': '/tools/buildbot/bin/python'} 01:28:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:28:07 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)) 01:28:07 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)) 01:28:07 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)) 01:28:07 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)) 01:28:07 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)) 01:28:07 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)) 01:28:07 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)) 01:28:07 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)) 01:28:07 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)) 01:28:07 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)) 01:28:07 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)) 01:28:07 INFO - Cleaning up... 01:28:07 INFO - Return code: 0 01:28:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:28:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:28:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:28:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad34174f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dca0b0>, '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 0x1dcafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcb440>, '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': '21869f6c619b95355032545b000001da-1449134672.635411-155353781', '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 01:28:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:28:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:28:07 INFO - Using env: {'DISPLAY': ':0', 01:28:07 INFO - 'HOME': '/home/cltbld', 01:28:07 INFO - 'LANG': 'en_US.UTF-8', 01:28:07 INFO - 'LANGUAGE': 'en_US:en', 01:28:07 INFO - 'LOGNAME': 'cltbld', 01:28:07 INFO - 'MAIL': '/var/mail/cltbld', 01:28:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:28:07 INFO - 'MOZ_NO_REMOTE': '1', 01:28:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:28:07 INFO - 'NO_EM_RESTART': '1', 01:28:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:28:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:28:07 INFO - 'PWD': '/builds/slave/test', 01:28:07 INFO - 'SHELL': '/bin/bash', 01:28:07 INFO - 'SHLVL': '1', 01:28:07 INFO - 'TERM': 'linux', 01:28:07 INFO - 'TMOUT': '86400', 01:28:07 INFO - 'USER': 'cltbld', 01:28:07 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1449134672.635411-155353781', 01:28:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:28:07 INFO - '_': '/tools/buildbot/bin/python'} 01:28:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:28:07 INFO - Downloading/unpacking jsonschema 01:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:28:09 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 01:28:09 INFO - Downloading/unpacking functools32 (from jsonschema) 01:28: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 01:28: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 01:28: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 01:28: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 01:28: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 01:28: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 01:28:09 INFO - Downloading functools32-3.2.3-2.tar.gz 01:28:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 01:28:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:28:09 INFO - warning: no files found matching '*.txt' 01:28:09 INFO - no previously-included directories found matching 'build' 01:28:09 INFO - no previously-included directories found matching 'dist' 01:28:09 INFO - no previously-included directories found matching '.git*' 01:28:09 INFO - Installing collected packages: jsonschema, functools32 01:28:09 INFO - Running setup.py install for functools32 01:28:10 INFO - warning: no files found matching '*.txt' 01:28:10 INFO - no previously-included directories found matching 'build' 01:28:10 INFO - no previously-included directories found matching 'dist' 01:28:10 INFO - no previously-included directories found matching '.git*' 01:28:10 INFO - Successfully installed jsonschema functools32 01:28:10 INFO - Cleaning up... 01:28:10 INFO - Return code: 0 01:28:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:28:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:28:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad34174f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dca0b0>, '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 0x1dcafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcb440>, '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': '21869f6c619b95355032545b000001da-1449134672.635411-155353781', '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 01:28:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 01:28:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:28:10 INFO - Using env: {'DISPLAY': ':0', 01:28:10 INFO - 'HOME': '/home/cltbld', 01:28:10 INFO - 'LANG': 'en_US.UTF-8', 01:28:10 INFO - 'LANGUAGE': 'en_US:en', 01:28:10 INFO - 'LOGNAME': 'cltbld', 01:28:10 INFO - 'MAIL': '/var/mail/cltbld', 01:28:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:28:10 INFO - 'MOZ_NO_REMOTE': '1', 01:28:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:28:10 INFO - 'NO_EM_RESTART': '1', 01:28:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:28:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:28:10 INFO - 'PWD': '/builds/slave/test', 01:28:10 INFO - 'SHELL': '/bin/bash', 01:28:10 INFO - 'SHLVL': '1', 01:28:10 INFO - 'TERM': 'linux', 01:28:10 INFO - 'TMOUT': '86400', 01:28:10 INFO - 'USER': 'cltbld', 01:28:10 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1449134672.635411-155353781', 01:28:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:28:10 INFO - '_': '/tools/buildbot/bin/python'} 01:28:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:28:10 INFO - Downloading/unpacking flake8 01:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:28:11 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 01:28:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:28: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 01:28: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 01:28: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 01:28: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 01:28: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 01:28: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 01:28:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:28:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 01:28:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:12 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 01:28:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 01:28:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:28:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:28:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:28:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:28:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:28:12 INFO - no previously-included directories found matching 'docs/_build' 01:28:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:28:12 INFO - Running setup.py install for pep8 01:28:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:28:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:28:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:28:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:28:12 INFO - no previously-included directories found matching 'docs/_build' 01:28:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:28:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:28:12 INFO - Cleaning up... 01:28:12 INFO - Return code: 0 01:28:12 INFO - Running post-action listener: _resource_record_post_action 01:28:12 INFO - Running post-action listener: _start_resource_monitoring 01:28:12 INFO - Starting resource monitoring. 01:28:12 INFO - ##### 01:28:12 INFO - ##### Running install step. 01:28:12 INFO - ##### 01:28:12 INFO - Running pre-action listener: _resource_record_pre_action 01:28:12 INFO - Running main action method: install 01:28:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:28:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:28:13 INFO - Reading from file tmpfile_stdout 01:28:13 INFO - Detecting whether we're running mozinstall >=1.0... 01:28:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:28:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:28:13 INFO - Reading from file tmpfile_stdout 01:28:13 INFO - Output received: 01:28:13 INFO - Usage: mozinstall [options] installer 01:28:13 INFO - Options: 01:28:13 INFO - -h, --help show this help message and exit 01:28:13 INFO - -d DEST, --destination=DEST 01:28:13 INFO - Directory to install application into. [default: 01:28:13 INFO - "/builds/slave/test"] 01:28:13 INFO - --app=APP Application being installed. [default: firefox] 01:28:13 INFO - mkdir: /builds/slave/test/build/application 01:28:13 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'] 01:28:13 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 01:28:27 INFO - Reading from file tmpfile_stdout 01:28:27 INFO - Output received: 01:28:27 INFO - /builds/slave/test/build/application/firefox/firefox 01:28:27 INFO - Running post-action listener: _resource_record_post_action 01:28:27 INFO - ##### 01:28:27 INFO - ##### Running run-tests step. 01:28:27 INFO - ##### 01:28:27 INFO - Running pre-action listener: _resource_record_pre_action 01:28:27 INFO - Running main action method: run_tests 01:28:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:28:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:28:27 INFO - Python 2.7.3 01:28:27 INFO - Return code: 0 01:28:27 INFO - grabbing minidump binary from tooltool 01:28:27 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')]} 01:28:27 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 0x1dca0b0>, '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 0x1dcafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcb440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:28:27 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 01:28:27 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 01:28:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:28:27 INFO - Return code: 0 01:28:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:28:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:28:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:28:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:28:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:28:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:28:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:28:28 INFO - Return code: 0 01:28:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost'] in /builds/slave/test/build 01:28:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --webServer localhost 01:28:28 INFO - Using env: {'DISPLAY': ':0', 01:28:28 INFO - 'HOME': '/home/cltbld', 01:28:28 INFO - 'LANG': 'en_US.UTF-8', 01:28:28 INFO - 'LANGUAGE': 'en_US:en', 01:28:28 INFO - 'LOGNAME': 'cltbld', 01:28:28 INFO - 'MAIL': '/var/mail/cltbld', 01:28:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:28:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:28:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:28:28 INFO - 'MOZ_NO_REMOTE': '1', 01:28:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:28:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:28:28 INFO - 'NO_EM_RESTART': '1', 01:28:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:28:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:28:28 INFO - 'PWD': '/builds/slave/test', 01:28:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:28:28 INFO - 'SHELL': '/bin/bash', 01:28:28 INFO - 'SHLVL': '1', 01:28:28 INFO - 'TERM': 'linux', 01:28:28 INFO - 'TMOUT': '86400', 01:28:28 INFO - 'USER': 'cltbld', 01:28:28 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1449134672.635411-155353781', 01:28:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:28:28 INFO - '_': '/tools/buildbot/bin/python'} 01:28:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost'] with output_timeout 3600 01:28:28 INFO - mozversion INFO | application_buildid: 20151203005925 01:28:28 INFO - mozversion INFO | application_changeset: 92499b34eeffbfdaf5df19f63c464988435356db 01:28:28 INFO - mozversion INFO | application_display_name: Nightly 01:28:28 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:28:28 INFO - mozversion INFO | application_name: Firefox 01:28:28 INFO - mozversion INFO | application_remotingname: firefox 01:28:28 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 01:28:28 INFO - mozversion INFO | application_vendor: Mozilla 01:28:28 INFO - mozversion INFO | application_version: 45.0a1 01:28:28 INFO - mozversion INFO | platform_buildid: 20151203005925 01:28:28 INFO - mozversion INFO | platform_changeset: 92499b34eeffbfdaf5df19f63c464988435356db 01:28:28 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 01:28:28 INFO - mozversion INFO | platform_version: 45.0a1 01:28:28 INFO - 2015-12-03 01:28:28,893 DEBUG : using testdate: 1449134908 01:28:28 INFO - 2015-12-03 01:28:28,893 DEBUG : actual date: 1449134908 01:28:28 INFO - 2015-12-03 01:28:28,902 INFO : starting webserver on 'localhost:57802' 01:28:28 INFO - 2015-12-03 01:28:28,903 INFO : Starting test suite talos-linux64-ix-003.e 01:28:28 INFO - 2015-12-03 01:28:28,903 INFO : Starting test dromaeo_css 01:28:28 INFO - 2015-12-03 01:28:28,904 DEBUG : operating with platform_type : linux_ 01:28:28 INFO - 2015-12-03 01:28:28,904 INFO : Initialising browser for dromaeo_css test... 01:28:28 INFO - 2015-12-03 01:28:28,920 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL0NHFU/profile http://localhost:57802/getInfo.html 01:28:33 INFO - 2015-12-03 01:28:33,297 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:28:33 INFO - 2015-12-03 01:28:33,297 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:28:33 INFO - 2015-12-03 01:28:33,297 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:28:33 INFO - 2015-12-03 01:28:33,298 DEBUG : BROWSER_OUTPUT: __metrics 01:28:33 INFO - 2015-12-03 01:28:33,434 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] 01:28:34 INFO - 2015-12-03 01:28:34,352 INFO : Browser initialized. 01:28:34 INFO - 2015-12-03 01:28:34,352 INFO : Running cycle 1/1 for dromaeo_css test... 01:28:34 INFO - 2015-12-03 01:28:34,352 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL0NHFU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:28:46 INFO - 2015-12-03 01:28:46,277 DEBUG : BROWSER_OUTPUT: RSS: Main: 142811136 01:28:46 INFO - 2015-12-03 01:28:46,278 DEBUG : BROWSER_OUTPUT: 01:29:35 INFO - 2015-12-03 01:29:35,932 DEBUG : BROWSER_OUTPUT: 1449134975924 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] 01:31:47 INFO - 2015-12-03 01:31:47,559 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57802/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57802/tests/dromaeo/cssquery-ext.html) 01:31:48 INFO - 2015-12-03 01:31:48,688 DEBUG : BROWSER_OUTPUT: RSS: Main: 145453056 01:31:48 INFO - 2015-12-03 01:31:48,689 DEBUG : BROWSER_OUTPUT: 01:34:50 INFO - 2015-12-03 01:34:50,718 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57802/tests/dromaeo/cssquery-ext.html (next: http://localhost:57802/tests/dromaeo/cssquery-jquery.html) 01:34:51 INFO - 2015-12-03 01:34:51,319 DEBUG : BROWSER_OUTPUT: RSS: Main: 145063936 01:34:51 INFO - 2015-12-03 01:34:51,320 DEBUG : BROWSER_OUTPUT: 01:37:53 INFO - 2015-12-03 01:37:53,125 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57802/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57802/tests/dromaeo/cssquery-mootools.html) 01:37:53 INFO - 2015-12-03 01:37:53,731 DEBUG : BROWSER_OUTPUT: RSS: Main: 145936384 01:37:53 INFO - 2015-12-03 01:37:53,731 DEBUG : BROWSER_OUTPUT: 01:40:55 INFO - 2015-12-03 01:40:55,515 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57802/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57802/tests/dromaeo/cssquery-prototype.html) 01:40:56 INFO - 2015-12-03 01:40:56,116 DEBUG : BROWSER_OUTPUT: RSS: Main: 144830464 01:40:56 INFO - 2015-12-03 01:40:56,116 DEBUG : BROWSER_OUTPUT: 01:43:58 INFO - 2015-12-03 01:43:58,681 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57802/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57802/tests/dromaeo/cssquery-yui.html) 01:43:59 INFO - 2015-12-03 01:43:59,274 DEBUG : BROWSER_OUTPUT: RSS: Main: 146042880 01:43:59 INFO - 2015-12-03 01:43:59,274 DEBUG : BROWSER_OUTPUT: 01:47:01 INFO - 2015-12-03 01:47:01,707 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57802/tests/dromaeo/cssquery-yui.html (next: http://localhost:57802/tests/dromaeo/cssquery-dojo.html) 01:47:01 INFO - 2015-12-03 01:47:01,957 DEBUG : BROWSER_OUTPUT: RSS: Main: 147419136 01:47:01 INFO - 2015-12-03 01:47:01,957 DEBUG : BROWSER_OUTPUT: 01:47:01 INFO - 2015-12-03 01:47:01,958 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:47:01 INFO - 2015-12-03 01:47:01,959 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:47:01 INFO - 2015-12-03 01:47:01,959 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:47:01 INFO - 2015-12-03 01:47:01,959 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:47:01 INFO - 2015-12-03 01:47:01,960 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2655.0574546036155;2684.610731443942;2709.756121949023;2727.290904364865;2735.8084934054623;4559.293309537019;4740.3600513930605;4765.64257680674;4789.90420191596;4814.879628009301;4700.741459219742;4712.622990160788;4730.621550275978;4834.927476087862;4846.055019271234;4306.181825453162;4389.429374181352;4453.4433195850515;4453.88865278369;4499.595036446719;4323.437953066113;4379.255526560476;4440.400545926307;4492.505824359334;4500.707454015478;4245.8513952011845;4286.828526858953;4358.607725304706;4360.803763830603;4393.868183954486;4323.913521729548;4352.347147927804;4367.10474352757;4370.912581748379;4392.802323895432;4335.653147748204;4339.826406943718;4347;4347.978260108711;4398.054418300081;4411.757353345564;4515.14212299662;4563.475200351935;4648.3957085578995;4675.836345727883;5040.117979353635;5043.722595257259;5052.722100284483;5093.694378337312;5119.948800511985;5092.28707980883;5099.745012749385;5110.97444512775;5112.744362781846;5127.410347810012;4551.112533056055;4638.443386793607;4657.767111644438;4713.858584242478;4738.810447582127;5164.04465173944;5194.844154675366;5195.636305458582;5204.375474943031;5242.868928276824;4777.402824646919;4936;4978.601711863114;4995.775190116454;5008.398992120969;4933.407991041026;4988.176950803149;5060.7722652480725;5081.441041485434;5137.922931156036;5015.824446144367;5066.088104141216;5075;5080.974595127001;5133.204353325241;4829.975850120797;4968.30443737877;5009.624278179152;5029.924551131736;5031.094403007493;4110.506739191316;4116.75299482032;4145.2952997990415;4185.497740271187;4244.257254980366;3688.963110368862;3703.6481534254203;3711.5917249102577;3737.1965027519213;3746.6253374662315;4192.224438478891;4418.447694038246;4440.045390241049;4445.73325600465;4467.5755803198645;4999.450060493343;5035.924461133086;5129.128048231735;5129.79480820763;5163.148080566664;4409.096135292258;4420.889477763018;4421.29259318514;4432.135733531994;4464.55354464551;4271.807768650418;4370.497392799869;4532.4334458192725;4534.410526631516;4560.4071470708595;4745.881352966135;4822.662413631012;4826.131296366688;4839;4862.343583616166;5116.8720781979255;5120.564751996122;5140.614453916046;5150.639455238097;5187.948120518747;4640.489546149854;4774.594159496482;4810.783514741915;4903.754812259302;4964.255361695775;5085.313482679939;5106.974465127651;5110.080185566485;5113.974430127825;5124.718140502308;5191.714455704972;5214.817481388285;5215.087359712111;5215.322008138917;5256.027634887558;4739.739314337745;4873.561379475864;4931.408231012158;5007.073691367109;5075.1625981712605;4884.9511504884495;4894.559489645949;4897.2654101885;4908.509149085063;4920.876978075434;4803.159447096814;4804.8318308859025;4807.038592281488;4808.471068182567;4819.59033482158;4811.206150985048;4886.65793394459;4957;4964.602831773522;4973.751312434291;4854.80580776765;4870.293807397837;4900.313956046085;4908.828191013297;4955.132851751001 01:47:01 INFO - 2015-12-03 01:47:01,964 DEBUG : BROWSER_OUTPUT: |1;ext.html;571.5770329955833;573.5354362965998;580.0574067140899;593.4362355762024;601.4677010845401;35347.82326088369;35822.82088589557;35843.28313433736;35929.82035089828;36017.2796544069;39922.60077399225;40348.19303613933;40373.59626403743;40473.59526404735;40491.190176196535;7916.6437510312035;8006.359491240687;8051.63767630458;8062.274395304421;8064;7909.050913890313;7987.400944929124;8002.039755229352;8006.039275286974;8012.5593092379895;7915.287624113828;7934.801629959268;7985;7995.400344974121;8039.35685145187;7917;7955.4033447491665;8007.439479236485;8011.67953281868;8017.478863873888;7836.177201393829;7971.043474783063;7971.6014199290385;8004.8399032019615;8025.759227223192;37140.628593713984;37391.4391284131;37411.25177496462;37441.25117497662;37502.624973750186;2895;3019.3357461358687;3037.0736925237793;3223.5325877747596;3278.49183376577;27485.31286717828;27683.861580691966;27885.721142788516;28088.43823123526;28447.431051379062;2754.1599812057316;2786.3312804926873;2799.300174956261;2801.80387372884;2881.6109825173544;197205;198803.0059849706;198841;199588.99999999854;199840.00079999506;48853.755731221114;49923.75038124859;51489.22766158511;52601.7369913148;53712.46287537153;47245.5275447248;47757.76121119442;48076.27885581719;48100.759496203;48183.27725084127;13721.108127971649;13764.793528097087;13896.722065558632;13927.164370137622;13932.303384830719;9902.108810206972;9909.851352229722;10003.449810260505;10112.848307275397;10134.189264858793;18074.18666160026;18281.81718182828;18328.633427331377;18465.261389544266;18485.5378615533;7294.598797066213;7635.656395462218;7669.7315593953945;7685.308322251024;7700.807479813049;887.3477993674644;920.7652048727532;940.7648087978006;946.7727745341206;1041.2815157541272;25613.23160305194;25687.229383118538;25751.484970300487;25827.741722582534;25998.74001260001;927.8840144981878;956.6412595276771;979.740368802268;1017.1760873692333;1017.4099022566893;13282.601521954357;13442.865571344357;13519.729605407836;13544.661383465493;13766.105203161962;256317;257436;260763;261679;262305;43734;44010.7799461007;44119.77940110279;44166;44196.55803441989;1187.2105050141558;1193.6001439517859;1212.6362091372378;1224.761171571535;1231.0151878497165;24624.384390390383;25301.367465813502;25455.36361590975;25677.61483577785;25845.22464326073;39190.60809391984;39847;40142.598574013886;40267.597324027556;40273.798631006655;246794;247678;249046;249411;249816.76191047524;28838;29215;29289.267768305963;29293.41413171682;29648;32698.182545436553;33258.168545786546;33347.83326083354;33389.33221335511;35348.409321580075;31266.53100203544;31790.36419271648;31960.840195799803;32449.188770280933;32629;31433.528497072104;32111.518327224643;32861.50707739338;33315.66684333126;33415.498767518024;29983.850080749457;30184.24539386533;32567.348653027282;32955.67044329622;33036.1740956478;25366;26837.463250735265;26871.596926046517;26937.461250774482;27083.052093176644;22905.31284061481;23309;23315.88342058347;23511.882440587688;23554.764452355943 01:47:01 INFO - 2015-12-03 01:47:01,964 DEBUG : BROWSER_OUTPUT: |2;jquery.html;330.4465021089676;331.61698238534495;335.3109360264655;335.8941933291013;340.88409940620187;14963.102213867161;15429.382824687013;15597.766033509506;15729.449469268578;16297.429589964353;9682.12860842524;9843.950780246107;12503.624891253277;13960.58118256454;14106.858931410683;4492.528284530118;4610.331501932218;4617.522392834295;4623.8844028899375;5044.319016932704;5026.974865125688;5074.340335756347;5076.238564215379;5078;5083.313752643401;3336.7664263501565;3432.5709286339206;5002.324686167375;5022.799088036492;5075.873103172432;5184.222366644995;5185.740712964337;5208.505192006773;5215.530602245797;5226.346706661686;4961.578265847407;5011.348524691767;5025.748712564357;5151.922721159186;5189.870253243699;17843.821561784345;17860.19629116693;18123.72814407785;19350.322738704217;19372.128254228595;1893.6118095790468;1894.7915729269769;1905.0093951145327;1906.8855868647925;2002.888396939698;8805.29390723737;8855.380123391365;8884.777880552972;9686.806263874683;12810;1791.6954117800005;1804.9548761280942;1806.7922188948307;1819.818018198183;1847.861410394226;55466;56890;57697.423025769625;58687;59151.99999999957;9567.712968610953;9842.311038227255;9950.978923932464;10038.849417258747;10068.899311006797;12596.81104783429;12646.051546134076;12662.430190641444;12680.23918564889;12696;6921.204061532888;6939.097917270722;7077.292270772985;7082.362587367162;7161.749338773222;6738.898916516257;6753.763618273337;6765.492588055916;6780.118584584071;6782.457403407716;4185.518665353523;4207.410962465257;4213;4219.894502637459;4223.303154979394;1757.3322137587634;1784.6698360803293;1789.9821001790076;1793.0944872839132;1832.7525784018987;378.78977167671655;383.77932688704107;854.7649396415911;885.2121611765534;922.9939366090993;9567.61729530811;14971.101733896001;15516.379344826306;15730.764038539432;15901.284442200129;832.9125441828642;878.5212059427628;880.6961598248594;891.2468963725642;944.5654998700675;8485.109063548362;8705.6517739291;8748.343874209333;8805.119488051272;8919.955400222958;492794;494826;510273;510363;512787;71095.2890471099;71431.64284178546;71853.64073179601;72229;73151;1049.7113293844254;1057.9894201058198;1068.9518971646294;1076.1444651502075;1077.1544337694872;13586.38861251266;14280.642983925485;14455.49405770793;14579.708405831612;14739.26303684833;31784;32031.67968320287;32576.51135232926;33421.16447088842;33737;42002;42470.362944555236;42614.78692606641;43186.78406607947;44753.55246447624;8639.179277968582;8840.071792461698;9231.630734770533;9235.07649235071;9262;9948.751281218027;10036;10800.675979720621;16458.177091145633;16989.235484402983;13235.205887646773;13693.315334233448;14045.36795844169;14139.64650883736;14153.929230353782;10386.688399348031;13376.130551514121;13544.525941591997;13964;14065.718685626434;14172.574822755334;14239.074460160056;14554.272286385427;14644.560663180122;14655.120692758468;8711.47731136134;8785.560721963748;8810.251128654136;9011.774705632411;9051.773705657411;8867.185371917587;13063.085584009408;13210.603681889559;13640.795388069386;14327.283635818376 01:47:01 INFO - 2015-12-03 01:47:01,967 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1490.076152785272;1634.7793047938526;1700.2773821126018;1710.8973461592304;1721.9913900430504;6330.272018717849;6492.837679058026;7090.4327653787705;7218.097737782778;7257.600831954241;6835.589864608127;7028.753993610225;7064.046353742243;7084.326988936055;7096.0420343253645;1998.390490900275;2022.312413779322;2025.0684685044896;2030.2995466564087;2031.431199264201;2052.8152466278034;2055.2498338106557;2064.525159213382;2122.1405330840958;2132.275026490993;2053.1992522916075;2060.7115003899467;2088.425682937197;2093.8638988465777;2097.286922446368;2093.3196711068886;2101.3800928726064;2101.7582977957577;2113.9894300528476;2118.851680382374;2056.341970569418;2084.7289852319254;2086.499240182345;2098.6327392706216;2101.2645574049116;7159.89260161098;7224.6026468544205;7247.782566523013;7260.45546584003;7265.382442492394;4057.5130984282073;4112.91774164518;4123.690723195772;4141.337386018253;4157;2698.473797609467;2727.0864260472767;2751.6010178524202;2758.600002999574;2786.2755683522228;862.5773371048141;863.5725315968573;866.5320726807516;882.0253619750148;889.7464222696565;9421.717348479488;9527.237820974375;9532.857007144898;9575.425474471554;9627.566759495769;3818.7517811342173;3837.5586807517493;3879.127196380848;3896.7467114637457;3925.7055720821054;8242.670293188325;8335.54154521495;8342.040665323444;8349.457285276438;8362;4132.028973191298;4147.212029714345;4148.771817550003;4151.8962025949595;4155.501339839238;3312.685294896981;3393.2195595013286;3683.613220611851;3692.4276737105793;3800.9429858552144;3477.94783078254;3490.89527314181;3503.789772613651;3521.031716278044;3528.3825330567047;1098.4837126550508;1114.8940850619178;1115.5482029777952;1120.1486869978876;1120.5013768872773;1137.4256000719583;1142.9314241145557;1157.3171828621155;1162.2910024884814;1186.489809381974;6851;6901.309869013058;6925.307469253135;6925.549839260432;6964.338387853247;1018.6282007067367;1040.7606250562412;1042.5829668132656;1084.7233955341337;1094.7974624694457;5545.805896793673;5573.442655734475;5581.358143813432;5591.161325801162;5622.465865742748;8306.958465207636;8452.57737113142;8500.10748871372;8623.051464338918;8678.349123815738;8296.087430382653;8371.748847534584;8372.497650141011;8494.023187333412;8522.48865068098;6614.503912206604;6667.6666166691475;6715.1941766988275;6863.588184708933;6938.444924406136;6823.351781580742;6857.382835544626;6877.174739031148;6887.483438742214;6919.273476284918;7517.924820751722;7603.619819009138;7736.303732664087;7741.109772376023;7862.646180921758;7586.81032974158;7730.574818385043;7744.186860379579;7854.646540905559;7865.488743231672;5353.304070470814;5455.8363249102595;6285.2457705075685;6377.298497165215;6447.065175549613;6894.8621027580175;6897.793066207821;6908.861822763617;6920.861582768417;6950.930490695028;6344.619322840645;6515.6742162892615;6532.444742196966;6670.733170673313;6687.996800479967;6254.6247225166635;6476.190476190476;6502.317256687979;6533.314002029719;6675.766348177791;6578.76974305897;6617.106690596708;6666.866662666623;6669.233038200669;6669.899951500828;6028.09578563219;6052.697365131814;6112.083187521907;6273.905891411724;6281.59169653971;6247.5001999839;6306.842328941813;6311.368863113836;6332.715027823667;6333.619982801047 01:47:01 INFO - 2015-12-03 01:47:01,969 DEBUG : BROWSER_OUTPUT: |4;prototype.html;288.22323837258585;293.3180355673061;301.077198386944;303.3356948283259;309.7227980957045;5461.508464238218;5495.313085864267;5624.184493248476;5639.7180140993;5659.151127330892;5503.834884953458;5511.255980442639;5526.696031718254;5534.529564986971;5536.335639723239;4140.254754144253;4288.571142885702;4289.227938970984;4291.291936830435;4293.871183864473;4245.341971994346;4250.723702959313;4270.67969902257;4273.850415235467;4275.380069889864;4208.600182982627;4224;4225.049363893115;4225.661947044229;4230.555791641879;4202.726822756511;4213.747175169485;4228.365745138223;4230.428892099558;4241.703080784316;3677.1910179760675;3677.44838274261;3677.485152078711;3680.6687398134027;3692.40921452569;5115.18157094863;5264.078786212397;5273.709945952971;5287.9159772246985;5299.152135658314;4852.660313778037;4854.320395144648;4858.587020103296;4858.761015940912;4872.025594881038;5836.212111364996;5855.619384739978;5856.590038697293;5856.7071646417935;5860.970695146497;3991.381335892941;3991.7405368650943;3992.5208974923194;4006.939895901564;4014.6788256939667;5948.702564871739;5977.8804423911715;6123.846903827395;6127.87744245117;6135.263768347782;4084.4077608746566;4096.078382363944;4108.4453598764385;4112.013116851934;4114.115465174942;4175.415441838145;4175.937360939588;4181.435506206684;4183.5398106208295;4188.895277618023;4819.397575303087;4828.758562071883;4831.154547954094;4831.227003679394;4832.057748739033;5685.857853553612;5794.710264486843;5813.040848260074;5826;5827.5920685552455;1458.3728996531381;1469.80157678712;1471.2864260833487;1472.34480656107;1472.8232612086617;974.7319487140951;983.5328219096016;986.9457179855033;999.2655398282257;1005.1707341443339;5088.77100530477;5115.514026167508;5121.28302037715;5122;5131.281620573048;5933.2880054393745;6001.969990150109;6061.969690151521;6106.114613381035;6107.267127944675;5107.080725469377;5119.180931051014;5144.871378215575;5147.073526765218;5152.896942061137;3229.531717900938;3261.641219465857;3276.6559511251453;3277.147941535218;3294.950575741366;5667.744951477193;5741.770329186869;5757.337906140764;5776.220210271559;5783.103618939072;6231.4391704746795;6248.9062664060075;6249.843753906098;6261.7182226799905;6281.057841323746;5740.799072032459;5778.219940308089;5782.884342313214;5796.362400135981;5803.3616302207565;6045.455908968214;6046.879062418815;6075.696215189135;6082.482988945812;6085.6348619083;5803.506701930383;5926.970365148147;5966.970165149147;5974.970125149346;5981.491573216152;5789.855253618524;5798.768049277982;5802.796902108406;5809.2738407699035;5821.854453638693;4043.2924238257597;4079.061815782446;4080;4081.1225586499045;4090.611391917763;5914.4381283777975;6060.848478788065;6093.390660933871;6102.816915492543;6107.961646520013;5835.708214589338;5847.327557330791;5852.4147585241135;5854.385289544707;5866.853328666817;5838.854028649318;5840.474357307693;5851;5859.736311865891;5870.970645146917;5563.888722225452;5674.687892165971;5704.68624225655;5710.114932185518;5713.400092990176;5867.266591676041;5870.207521984648;5876.529877609695;5906.645601263938;5909.23179986599;5718.285214348207;5718.656880587178;5720.628159169641;5722.62802917809;5727.570432217683 01:47:01 INFO - 2015-12-03 01:47:01,969 DEBUG : BROWSER_OUTPUT: |5;yui.html;649.6102338596841;667.2193533565728;667.5093806052554;774.303127185533;796.2356138107417;11057.11543076554;11314.717132071703;11320.094392448606;11332.660020199386;11347.375894325809;11597.536098556047;12103.757924841499;12135.817962730544;12144.635660930164;12185.57350492733;623;631.0250662726099;787.3386355461425;790.4782843323408;805.7461899501639;799.188823344306;801.2908575910333;803.5580430763086;807.9474834135792;808.1191501263621;786.9763907082797;829.1749709039514;841.8821365008904;842.9199226073544;844.9915500844975;827.5696637748367;828.362161135925;830.3647709502266;830.8421399933993;831.8294749576322;615.230961298377;615.5321955313949;615.6521565315627;616.9907451388233;618.7030225491744;11673.1828771986;11714.589989350332;11800.586979455678;11800.763984720343;11856.644300670994;11363;11395.715107122389;11441.771164576745;11638.534458621645;11790.528378864836;9542.141207291308;9566;9654.517274136266;9673.129418352311;10211.591536338537;3247.512873069035;3277.459219228824;3294.5058241263764;3299.488579270217;3387.983060084684;40468.797656011535;40753.59246407528;40868.38697419541;41029.974250643674;41081;9600.279979001603;9666.806663866684;9757.90242097584;9915.553800079013;9988.05113514215;16226.594335141715;16347.836521634868;16425.6714865702;16425.917870410573;16459.177041147894;6397.96801015992;6501.349865013555;6542.509311801634;6599.47204223661;6756.527043106936;3299.9175020624198;3466.3067386522293;3471.2016236265295;3505.649435056525;3519.3665140274998;2785.749282564579;2848.7293707097792;2852.229897927548;2865.226388874992;2870.62681851358;509.22597651570146;514.6063261604876;516.1200153737868;517.4773478786453;521.3587287636228;555.9499645031966;560.7028275014248;584.272580637101;602.3344204653882;611.8286879673699;7698.2686644768655;7769;8009.078955920144;8620.094890036582;8765.693200737944;494.9356583644103;555.88604336111;589.908564172554;597.1818608506375;606.2179788073424;3673.669369756735;3688.6680198782237;3743.831527581265;3874.9418758718643;3901.2782635212575;50367;50445.24332135021;51259;51335;51623;45836.3124553132;46334;46630;47008.29487557621;48472.7576362123;41077.58922410797;41542.79228603898;41638.791806040776;41923;41971.43242824394;7954.363650908029;8154.633041513265;8349.707760228363;8359.247667709935;8370.330373570221;32203.194920127185;32221.35557288888;32298.19254518562;32453.51319730159;32729.836350818092;36674.81662591777;37341;39730;42487.362689559064;42695;9754.365966212174;9841.655542055994;9885.703428897144;10047.698569042941;10229.48852557384;10199.949000254952;10676.946615266874;11294.60468883585;11499.13756468285;11586;10422.270441069053;10891.78216435651;10901.56393744273;10914.126869850552;11124.499397527292;10197.286189966631;10374;10417;10684;10767.946160269148;10404;10775.6228532001;10948.124150068135;11191.216614836883;11201.103911687209;8657.696980605648;8891.955540222258;9051;9051.094890510896;9305.86041209396;8689.522076285864;8783.648654053766;9106.590203440994;9637.37357071788;9690.70927872165 01:47:01 INFO - 2015-12-03 01:47:01,969 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:47:01 INFO - 2015-12-03 01:47:01,969 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:47:01 INFO - 2015-12-03 01:47:01,969 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,332 01:47:01 INFO - 2015-12-03 01:47:01,969 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:47:01 INFO - 2015-12-03 01:47:01,969 DEBUG : BROWSER_OUTPUT: __startTimestamp1449136021957__endTimestamp 01:47:01 INFO - 2015-12-03 01:47:01,969 DEBUG : BROWSER_OUTPUT: 01:47:01 INFO - 2015-12-03 01:47:01,969 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:47:01 INFO - 2015-12-03 01:47:01,969 DEBUG : BROWSER_OUTPUT: Number of tests: 6 01:47:01 INFO - 2015-12-03 01:47:01,969 DEBUG : BROWSER_OUTPUT: 01:47:01 INFO - 2015-12-03 01:47:01,969 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4682.69 Median:4811.21 stddev:496.49 (10.3%) stddev-sans-first:471.85 01:47:01 INFO - 2015-12-03 01:47:01,971 DEBUG : BROWSER_OUTPUT: Values: 2655.1 2684.6 2709.8 2727.3 2735.8 4559.3 4740.4 4765.6 4789.9 4814.9 4700.7 4712.6 4730.6 4834.9 4846.1 4306.2 4389.4 4453.4 4453.9 4499.6 4323.4 4379.3 4440.4 4492.5 4500.7 4245.9 4286.8 4358.6 4360.8 4393.9 4323.9 4352.3 4367.1 4370.9 4392.8 4335.7 4339.8 4347.0 4348.0 4398.1 4411.8 4515.1 4563.5 4648.4 4675.8 5040.1 5043.7 5052.7 5093.7 5119.9 5092.3 5099.7 5111.0 5112.7 5127.4 4551.1 4638.4 4657.8 4713.9 4738.8 5164.0 5194.8 5195.6 5204.4 5242.9 4777.4 4936.0 4978.6 4995.8 5008.4 4933.4 4988.2 5060.8 5081.4 5137.9 5015.8 5066.1 5075.0 5081.0 5133.2 4830.0 4968.3 5009.6 5029.9 5031.1 4110.5 4116.8 4145.3 4185.5 4244.3 3689.0 3703.6 3711.6 3737.2 3746.6 4192.2 4418.4 4440.0 4445.7 4467.6 4999.5 5035.9 5129.1 5129.8 5163.1 4409.1 4420.9 4421.3 4432.1 4464.6 4271.8 4370.5 4532.4 4534.4 4560.4 4745.9 4822.7 4826.1 4839.0 4862.3 5116.9 5120.6 5140.6 5150.6 5187.9 4640.5 4774.6 4810.8 4903.8 4964.3 5085.3 5107.0 5110.1 5114.0 5124.7 5191.7 5214.8 5215.1 5215.3 5256.0 4739.7 4873.6 4931.4 5007.1 5075.2 4885.0 4894.6 4897.3 4908.5 4920.9 4803.2 4804.8 4807.0 4808.5 4819.6 4811.2 4886.7 4957.0 4964.6 4973.8 4854.8 4870.3 4900.3 4908.8 4955.1 01:47:01 INFO - 2015-12-03 01:47:01,971 DEBUG : BROWSER_OUTPUT: 01:47:01 INFO - 2015-12-03 01:47:01,971 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39024.43 Median:17988.34 stddev:61714.70 (343.1%) stddev-sans-first:61820.28 01:47:01 INFO - 2015-12-03 01:47:01,971 DEBUG : BROWSER_OUTPUT: Values: 571.6 573.5 580.1 593.4 601.5 35347.8 35822.8 35843.3 35929.8 36017.3 39922.6 40348.2 40373.6 40473.6 40491.2 7916.6 8006.4 8051.6 8062.3 8064.0 7909.1 7987.4 8002.0 8006.0 8012.6 7915.3 7934.8 7985.0 7995.4 8039.4 7917.0 7955.4 8007.4 8011.7 8017.5 7836.2 7971.0 7971.6 8004.8 8025.8 37140.6 37391.4 37411.3 37441.3 37502.6 2895.0 3019.3 3037.1 3223.5 3278.5 27485.3 27683.9 27885.7 28088.4 28447.4 2754.2 2786.3 2799.3 2801.8 2881.6 197205.0 198803.0 198841.0 199589.0 199840.0 48853.8 49923.8 51489.2 52601.7 53712.5 47245.5 47757.8 48076.3 48100.8 48183.3 13721.1 13764.8 13896.7 13927.2 13932.3 9902.1 9909.9 10003.4 10112.8 10134.2 18074.2 18281.8 18328.6 18465.3 18485.5 7294.6 7635.7 7669.7 7685.3 7700.8 887.3 920.8 940.8 946.8 1041.3 25613.2 25687.2 25751.5 25827.7 25998.7 927.9 956.6 979.7 1017.2 1017.4 13282.6 13442.9 13519.7 13544.7 13766.1 256317.0 257436.0 260763.0 261679.0 262305.0 43734.0 44010.8 44119.8 44166.0 44196.6 1187.2 1193.6 1212.6 1224.8 1231.0 24624.4 25301.4 25455.4 25677.6 25845.2 39190.6 39847.0 40142.6 40267.6 40273.8 246794.0 247678.0 249046.0 249411.0 249816.8 28838.0 29215.0 29289.3 29293.4 29648.0 32698.2 33258.2 33347.8 33389.3 35348.4 31266.5 31790.4 31960.8 32449.2 32629.0 31433.5 32111.5 32861.5 33315.7 33415.5 29983.9 30184.2 32567.3 32955.7 33036.2 25366.0 26837.5 26871.6 26937.5 27083.1 22905.3 23309.0 23315.9 23511.9 23554.8 01:47:01 INFO - 2015-12-03 01:47:01,971 DEBUG : BROWSER_OUTPUT: 01:47:01 INFO - 2015-12-03 01:47:01,971 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26694.52 Median:4216.45 stddev:82381.56 (1953.8%) stddev-sans-first:82588.88 01:47:01 INFO - 2015-12-03 01:47:01,971 DEBUG : BROWSER_OUTPUT: Values: 330.4 331.6 335.3 335.9 340.9 14963.1 15429.4 15597.8 15729.4 16297.4 9682.1 9844.0 12503.6 13960.6 14106.9 4492.5 4610.3 4617.5 4623.9 5044.3 5027.0 5074.3 5076.2 5078.0 5083.3 3336.8 3432.6 5002.3 5022.8 5075.9 5184.2 5185.7 5208.5 5215.5 5226.3 4961.6 5011.3 5025.7 5151.9 5189.9 17843.8 17860.2 18123.7 19350.3 19372.1 1893.6 1894.8 1905.0 1906.9 2002.9 8805.3 8855.4 8884.8 9686.8 12810.0 1791.7 1805.0 1806.8 1819.8 1847.9 55466.0 56890.0 57697.4 58687.0 59152.0 9567.7 9842.3 9951.0 10038.8 10068.9 12596.8 12646.1 12662.4 12680.2 12696.0 6921.2 6939.1 7077.3 7082.4 7161.7 6738.9 6753.8 6765.5 6780.1 6782.5 4185.5 4207.4 4213.0 4219.9 4223.3 1757.3 1784.7 1790.0 1793.1 1832.8 378.8 383.8 854.8 885.2 923.0 9567.6 14971.1 15516.4 15730.8 15901.3 832.9 878.5 880.7 891.2 944.6 8485.1 8705.7 8748.3 8805.1 8920.0 492794.0 494826.0 510273.0 510363.0 512787.0 71095.3 71431.6 71853.6 72229.0 73151.0 1049.7 1058.0 1069.0 1076.1 1077.2 13586.4 14280.6 14455.5 14579.7 14739.3 31784.0 32031.7 32576.5 33421.2 33737.0 42002.0 42470.4 42614.8 43186.8 44753.6 8639.2 8840.1 9231.6 9235.1 9262.0 9948.8 10036.0 10800.7 16458.2 16989.2 13235.2 13693.3 14045.4 14139.6 14153.9 10386.7 13376.1 13544.5 13964.0 14065.7 14172.6 14239.1 14554.3 14644.6 14655.1 8711.5 8785.6 8810.3 9011.8 9051.8 8867.2 13063.1 13210.6 13640.8 14327.3 01:47:01 INFO - 2015-12-03 01:47:01,971 DEBUG : BROWSER_OUTPUT: 01:47:01 INFO - 2015-12-03 01:47:01,971 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5020.03 Median:6309.11 stddev:2577.03 (40.8%) stddev-sans-first:2570.60 01:47:01 INFO - 2015-12-03 01:47:01,973 DEBUG : BROWSER_OUTPUT: Values: 1490.1 1634.8 1700.3 1710.9 1722.0 6330.3 6492.8 7090.4 7218.1 7257.6 6835.6 7028.8 7064.0 7084.3 7096.0 1998.4 2022.3 2025.1 2030.3 2031.4 2052.8 2055.2 2064.5 2122.1 2132.3 2053.2 2060.7 2088.4 2093.9 2097.3 2093.3 2101.4 2101.8 2114.0 2118.9 2056.3 2084.7 2086.5 2098.6 2101.3 7159.9 7224.6 7247.8 7260.5 7265.4 4057.5 4112.9 4123.7 4141.3 4157.0 2698.5 2727.1 2751.6 2758.6 2786.3 862.6 863.6 866.5 882.0 889.7 9421.7 9527.2 9532.9 9575.4 9627.6 3818.8 3837.6 3879.1 3896.7 3925.7 8242.7 8335.5 8342.0 8349.5 8362.0 4132.0 4147.2 4148.8 4151.9 4155.5 3312.7 3393.2 3683.6 3692.4 3800.9 3477.9 3490.9 3503.8 3521.0 3528.4 1098.5 1114.9 1115.5 1120.1 1120.5 1137.4 1142.9 1157.3 1162.3 1186.5 6851.0 6901.3 6925.3 6925.5 6964.3 1018.6 1040.8 1042.6 1084.7 1094.8 5545.8 5573.4 5581.4 5591.2 5622.5 8307.0 8452.6 8500.1 8623.1 8678.3 8296.1 8371.7 8372.5 8494.0 8522.5 6614.5 6667.7 6715.2 6863.6 6938.4 6823.4 6857.4 6877.2 6887.5 6919.3 7517.9 7603.6 7736.3 7741.1 7862.6 7586.8 7730.6 7744.2 7854.6 7865.5 5353.3 5455.8 6285.2 6377.3 6447.1 6894.9 6897.8 6908.9 6920.9 6950.9 6344.6 6515.7 6532.4 6670.7 6688.0 6254.6 6476.2 6502.3 6533.3 6675.8 6578.8 6617.1 6666.9 6669.2 6669.9 6028.1 6052.7 6112.1 6273.9 6281.6 6247.5 6306.8 6311.4 6332.7 6333.6 01:47:01 INFO - 2015-12-03 01:47:01,973 DEBUG : BROWSER_OUTPUT: 01:47:01 INFO - 2015-12-03 01:47:01,973 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4824.73 Median:5530.61 stddev:1437.59 (26.0%) stddev-sans-first:1400.72 01:47:01 INFO - 2015-12-03 01:47:01,973 DEBUG : BROWSER_OUTPUT: Values: 288.2 293.3 301.1 303.3 309.7 5461.5 5495.3 5624.2 5639.7 5659.2 5503.8 5511.3 5526.7 5534.5 5536.3 4140.3 4288.6 4289.2 4291.3 4293.9 4245.3 4250.7 4270.7 4273.9 4275.4 4208.6 4224.0 4225.0 4225.7 4230.6 4202.7 4213.7 4228.4 4230.4 4241.7 3677.2 3677.4 3677.5 3680.7 3692.4 5115.2 5264.1 5273.7 5287.9 5299.2 4852.7 4854.3 4858.6 4858.8 4872.0 5836.2 5855.6 5856.6 5856.7 5861.0 3991.4 3991.7 3992.5 4006.9 4014.7 5948.7 5977.9 6123.8 6127.9 6135.3 4084.4 4096.1 4108.4 4112.0 4114.1 4175.4 4175.9 4181.4 4183.5 4188.9 4819.4 4828.8 4831.2 4831.2 4832.1 5685.9 5794.7 5813.0 5826.0 5827.6 1458.4 1469.8 1471.3 1472.3 1472.8 974.7 983.5 986.9 999.3 1005.2 5088.8 5115.5 5121.3 5122.0 5131.3 5933.3 6002.0 6062.0 6106.1 6107.3 5107.1 5119.2 5144.9 5147.1 5152.9 3229.5 3261.6 3276.7 3277.1 3295.0 5667.7 5741.8 5757.3 5776.2 5783.1 6231.4 6248.9 6249.8 6261.7 6281.1 5740.8 5778.2 5782.9 5796.4 5803.4 6045.5 6046.9 6075.7 6082.5 6085.6 5803.5 5927.0 5967.0 5975.0 5981.5 5789.9 5798.8 5802.8 5809.3 5821.9 4043.3 4079.1 4080.0 4081.1 4090.6 5914.4 6060.8 6093.4 6102.8 6108.0 5835.7 5847.3 5852.4 5854.4 5866.9 5838.9 5840.5 5851.0 5859.7 5871.0 5563.9 5674.7 5704.7 5710.1 5713.4 5867.3 5870.2 5876.5 5906.6 5909.2 5718.3 5718.7 5720.6 5722.6 5727.6 01:47:01 INFO - 2015-12-03 01:47:01,973 DEBUG : BROWSER_OUTPUT: 01:47:01 INFO - 2015-12-03 01:47:01,973 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12470.68 Median:46819.15 stddev:14183.28 (30.3%) stddev-sans-first:14195.29 01:47:01 INFO - 2015-12-03 01:47:01,973 DEBUG : BROWSER_OUTPUT: Values: 649.6 667.2 667.5 774.3 796.2 11057.1 11314.7 11320.1 11332.7 11347.4 11597.5 12103.8 12135.8 12144.6 12185.6 623.0 631.0 787.3 790.5 805.7 799.2 801.3 803.6 807.9 808.1 787.0 829.2 841.9 842.9 845.0 827.6 828.4 830.4 830.8 831.8 615.2 615.5 615.7 617.0 618.7 11673.2 11714.6 11800.6 11800.8 11856.6 11363.0 11395.7 11441.8 11638.5 11790.5 9542.1 9566.0 9654.5 9673.1 10211.6 3247.5 3277.5 3294.5 3299.5 3388.0 40468.8 40753.6 40868.4 41030.0 41081.0 9600.3 9666.8 9757.9 9915.6 9988.1 16226.6 16347.8 16425.7 16425.9 16459.2 6398.0 6501.3 6542.5 6599.5 6756.5 3299.9 3466.3 3471.2 3505.6 3519.4 2785.7 2848.7 2852.2 2865.2 2870.6 509.2 514.6 516.1 517.5 521.4 555.9 560.7 584.3 602.3 611.8 7698.3 7769.0 8009.1 8620.1 8765.7 494.9 555.9 589.9 597.2 606.2 3673.7 3688.7 3743.8 3874.9 3901.3 50367.0 50445.2 51259.0 51335.0 51623.0 45836.3 46334.0 46630.0 47008.3 48472.8 41077.6 41542.8 41638.8 41923.0 41971.4 7954.4 8154.6 8349.7 8359.2 8370.3 32203.2 32221.4 32298.2 32453.5 32729.8 36674.8 37341.0 39730.0 42487.4 42695.0 9754.4 9841.7 9885.7 10047.7 10229.5 10199.9 10676.9 11294.6 11499.1 11586.0 10422.3 10891.8 10901.6 10914.1 11124.5 10197.3 10374.0 10417.0 10684.0 10767.9 10404.0 10775.6 10948.1 11191.2 11201.1 8657.7 8892.0 9051.0 9051.1 9305.9 8689.5 8783.6 9106.6 9637.4 9690.7 01:47:01 INFO - 2015-12-03 01:47:01,973 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:47:01 INFO - 2015-12-03 01:47:01,973 DEBUG : BROWSER_OUTPUT: 01:47:02 INFO - 2015-12-03 01:47:02,696 INFO : Browser exited with error code: 0 01:47:02 INFO - 2015-12-03 01:47:02,717 INFO : Completed test dromaeo_css (00:18:33) 01:47:02 INFO - 2015-12-03 01:47:02,717 INFO : Starting test kraken 01:47:02 INFO - 2015-12-03 01:47:02,717 DEBUG : operating with platform_type : linux_ 01:47:02 INFO - 2015-12-03 01:47:02,717 INFO : Initialising browser for kraken test... 01:47:02 INFO - 2015-12-03 01:47:02,723 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO7CUtE/profile http://localhost:57802/getInfo.html 01:47:07 INFO - 2015-12-03 01:47:07,105 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:47:07 INFO - 2015-12-03 01:47:07,105 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:47:07 INFO - 2015-12-03 01:47:07,105 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:47:07 INFO - 2015-12-03 01:47:07,105 DEBUG : BROWSER_OUTPUT: __metrics 01:47:07 INFO - 2015-12-03 01:47:07,242 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] 01:47:08 INFO - 2015-12-03 01:47:08,128 INFO : Browser initialized. 01:47:08 INFO - 2015-12-03 01:47:08,128 INFO : Running cycle 1/1 for kraken test... 01:47:08 INFO - 2015-12-03 01:47:08,128 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO7CUtE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:47:20 INFO - 2015-12-03 01:47:20,131 DEBUG : BROWSER_OUTPUT: RSS: Main: 143790080 01:47:20 INFO - 2015-12-03 01:47:20,132 DEBUG : BROWSER_OUTPUT: 01:47:22 INFO - 2015-12-03 01:47:22,687 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57802/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57802/tests/kraken/driver.html?testName=audio-beat-detection) 01:47:23 INFO - 2015-12-03 01:47:23,308 DEBUG : BROWSER_OUTPUT: RSS: Main: 144150528 01:47:23 INFO - 2015-12-03 01:47:23,308 DEBUG : BROWSER_OUTPUT: 01:47:26 INFO - 2015-12-03 01:47:26,058 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57802/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57802/tests/kraken/driver.html?testName=audio-dft) 01:47:26 INFO - 2015-12-03 01:47:26,659 DEBUG : BROWSER_OUTPUT: RSS: Main: 144486400 01:47:26 INFO - 2015-12-03 01:47:26,659 DEBUG : BROWSER_OUTPUT: 01:47:29 INFO - 2015-12-03 01:47:29,565 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57802/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57802/tests/kraken/driver.html?testName=audio-fft) 01:47:30 INFO - 2015-12-03 01:47:30,151 DEBUG : BROWSER_OUTPUT: RSS: Main: 138584064 01:47:30 INFO - 2015-12-03 01:47:30,151 DEBUG : BROWSER_OUTPUT: 01:47:32 INFO - 2015-12-03 01:47:32,263 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57802/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57802/tests/kraken/driver.html?testName=audio-oscillator) 01:47:32 INFO - 2015-12-03 01:47:32,897 DEBUG : BROWSER_OUTPUT: RSS: Main: 139038720 01:47:32 INFO - 2015-12-03 01:47:32,897 DEBUG : BROWSER_OUTPUT: 01:47:35 INFO - 2015-12-03 01:47:35,150 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57802/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57802/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:47:35 INFO - 2015-12-03 01:47:35,752 DEBUG : BROWSER_OUTPUT: RSS: Main: 140795904 01:47:35 INFO - 2015-12-03 01:47:35,752 DEBUG : BROWSER_OUTPUT: 01:47:38 INFO - 2015-12-03 01:47:38,770 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57802/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57802/tests/kraken/driver.html?testName=imaging-darkroom) 01:47:39 INFO - 2015-12-03 01:47:39,372 DEBUG : BROWSER_OUTPUT: RSS: Main: 141344768 01:47:39 INFO - 2015-12-03 01:47:39,372 DEBUG : BROWSER_OUTPUT: 01:47:42 INFO - 2015-12-03 01:47:42,819 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57802/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57802/tests/kraken/driver.html?testName=imaging-desaturate) 01:47:43 INFO - 2015-12-03 01:47:43,412 DEBUG : BROWSER_OUTPUT: RSS: Main: 141549568 01:47:43 INFO - 2015-12-03 01:47:43,412 DEBUG : BROWSER_OUTPUT: 01:47:46 INFO - 2015-12-03 01:47:46,303 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57802/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57802/tests/kraken/driver.html?testName=json-parse-financial) 01:47:46 INFO - 2015-12-03 01:47:46,897 DEBUG : BROWSER_OUTPUT: RSS: Main: 141524992 01:47:46 INFO - 2015-12-03 01:47:46,897 DEBUG : BROWSER_OUTPUT: 01:47:48 INFO - 2015-12-03 01:47:48,631 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57802/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57802/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:47:49 INFO - 2015-12-03 01:47:49,211 DEBUG : BROWSER_OUTPUT: RSS: Main: 140963840 01:47:49 INFO - 2015-12-03 01:47:49,212 DEBUG : BROWSER_OUTPUT: 01:47:51 INFO - 2015-12-03 01:47:51,129 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57802/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57802/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:47:51 INFO - 2015-12-03 01:47:51,744 DEBUG : BROWSER_OUTPUT: RSS: Main: 141172736 01:47:51 INFO - 2015-12-03 01:47:51,745 DEBUG : BROWSER_OUTPUT: 01:47:54 INFO - 2015-12-03 01:47:54,023 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57802/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57802/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:47:54 INFO - 2015-12-03 01:47:54,612 DEBUG : BROWSER_OUTPUT: RSS: Main: 141377536 01:47:54 INFO - 2015-12-03 01:47:54,613 DEBUG : BROWSER_OUTPUT: 01:47:57 INFO - 2015-12-03 01:47:57,192 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57802/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57802/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:47:57 INFO - 2015-12-03 01:47:57,798 DEBUG : BROWSER_OUTPUT: RSS: Main: 141479936 01:47:57 INFO - 2015-12-03 01:47:57,798 DEBUG : BROWSER_OUTPUT: 01:48:00 INFO - 2015-12-03 01:48:00,374 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57802/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57802/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:48:00 INFO - 2015-12-03 01:48:00,967 DEBUG : BROWSER_OUTPUT: RSS: Main: 142012416 01:48:00 INFO - 2015-12-03 01:48:00,967 DEBUG : BROWSER_OUTPUT: 01:48:02 INFO - 2015-12-03 01:48:02,742 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57802/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57802/tests/kraken/driver.html?testName=ai-astar) 01:48:03 INFO - 2015-12-03 01:48:03,001 DEBUG : BROWSER_OUTPUT: RSS: Main: 140726272 01:48:03 INFO - 2015-12-03 01:48:03,001 DEBUG : BROWSER_OUTPUT: 01:48:03 INFO - 2015-12-03 01:48:03,001 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:48:03 INFO - 2015-12-03 01:48:03,001 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:48:03 INFO - 2015-12-03 01:48:03,001 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:48:03 INFO - 2015-12-03 01:48:03,001 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:48:03 INFO - 2015-12-03 01:48:03,001 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;108;110;109;111;123;111;111;111;111 01:48:03 INFO - 2015-12-03 01:48:03,001 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;159;131;158;173;131;153;152;131;171;129 01:48:03 INFO - 2015-12-03 01:48:03,001 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;165;160;162;168;164;172;161;165;162 01:48:03 INFO - 2015-12-03 01:48:03,001 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;74;73;71;73;73;135;72;73;74 01:48:03 INFO - 2015-12-03 01:48:03,001 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;130;94;94;95;130;94;95;125 01:48:03 INFO - 2015-12-03 01:48:03,001 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;110;109;110;110;111;110 01:48:03 INFO - 2015-12-03 01:48:03,002 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;148;148;147;149;148;148;147;148 01:48:03 INFO - 2015-12-03 01:48:03,002 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;97;96;96;96;97;96;96;96 01:48:03 INFO - 2015-12-03 01:48:03,002 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;70;73;74;74;73;70;71;69;69 01:48:03 INFO - 2015-12-03 01:48:03,002 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;70;72;72;73;70;71;71;71;71 01:48:03 INFO - 2015-12-03 01:48:03,002 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;89;86;85;89;82;84;84;85;84;86 01:48:03 INFO - 2015-12-03 01:48:03,002 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;131;127;134;116;122;127;124;131;123;126 01:48:03 INFO - 2015-12-03 01:48:03,002 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;146;147;147;146;146;134;145;145;141;140 01:48:03 INFO - 2015-12-03 01:48:03,002 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;70;69;67;72;68;70;69;70;70 01:48:03 INFO - 2015-12-03 01:48:03,002 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:48:03 INFO - 2015-12-03 01:48:03,002 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:48:03 INFO - 2015-12-03 01:48:03,002 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,801 01:48:03 INFO - 2015-12-03 01:48:03,002 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:48:03 INFO - 2015-12-03 01:48:03,002 DEBUG : BROWSER_OUTPUT: __startTimestamp1449136082996__endTimestamp 01:48:03 INFO - 2015-12-03 01:48:03,002 DEBUG : BROWSER_OUTPUT: 01:48:03 INFO - 2015-12-03 01:48:03,003 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:48:03 INFO - 2015-12-03 01:48:03,003 DEBUG : BROWSER_OUTPUT: Number of tests: 14 01:48:03 INFO - 2015-12-03 01:48:03,003 DEBUG : BROWSER_OUTPUT: 01:48:03 INFO - 2015-12-03 01:48:03,003 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.60 Median:111.00 stddev:4.14 (3.7%) stddev-sans-first:4.39 01:48:03 INFO - 2015-12-03 01:48:03,003 DEBUG : BROWSER_OUTPUT: Values: 111.0 108.0 110.0 109.0 111.0 123.0 111.0 111.0 111.0 111.0 01:48:03 INFO - 2015-12-03 01:48:03,003 DEBUG : BROWSER_OUTPUT: 01:48:03 INFO - 2015-12-03 01:48:03,004 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.80 Median:155.50 stddev:17.12 (11.0%) stddev-sans-first:17.76 01:48:03 INFO - 2015-12-03 01:48:03,004 DEBUG : BROWSER_OUTPUT: Values: 159.0 131.0 158.0 173.0 131.0 153.0 152.0 131.0 171.0 129.0 01:48:03 INFO - 2015-12-03 01:48:03,005 DEBUG : BROWSER_OUTPUT: 01:48:03 INFO - 2015-12-03 01:48:03,005 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.30 Median:164.50 stddev:3.56 (2.2%) stddev-sans-first:3.77 01:48:03 INFO - 2015-12-03 01:48:03,005 DEBUG : BROWSER_OUTPUT: Values: 164.0 165.0 160.0 162.0 168.0 164.0 172.0 161.0 165.0 162.0 01:48:03 INFO - 2015-12-03 01:48:03,005 DEBUG : BROWSER_OUTPUT: 01:48:03 INFO - 2015-12-03 01:48:03,005 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.20 Median:73.00 stddev:19.63 (26.9%) stddev-sans-first:20.73 01:48:03 INFO - 2015-12-03 01:48:03,005 DEBUG : BROWSER_OUTPUT: Values: 74.0 74.0 73.0 71.0 73.0 73.0 135.0 72.0 73.0 74.0 01:48:03 INFO - 2015-12-03 01:48:03,005 DEBUG : BROWSER_OUTPUT: 01:48:03 INFO - 2015-12-03 01:48:03,005 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.70 Median:94.50 stddev:16.37 (17.3%) stddev-sans-first:16.98 01:48:03 INFO - 2015-12-03 01:48:03,005 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 130.0 94.0 94.0 95.0 130.0 94.0 95.0 125.0 01:48:03 INFO - 2015-12-03 01:48:03,005 DEBUG : BROWSER_OUTPUT: 01:48:03 INFO - 2015-12-03 01:48:03,006 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 01:48:03 INFO - 2015-12-03 01:48:03,006 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 110.0 109.0 110.0 110.0 111.0 110.0 01:48:03 INFO - 2015-12-03 01:48:03,006 DEBUG : BROWSER_OUTPUT: 01:48:03 INFO - 2015-12-03 01:48:03,006 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 01:48:03 INFO - 2015-12-03 01:48:03,006 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 148.0 148.0 147.0 149.0 148.0 148.0 147.0 148.0 01:48:03 INFO - 2015-12-03 01:48:03,006 DEBUG : BROWSER_OUTPUT: 01:48:03 INFO - 2015-12-03 01:48:03,006 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 01:48:03 INFO - 2015-12-03 01:48:03,006 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 97.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 01:48:03 INFO - 2015-12-03 01:48:03,006 DEBUG : BROWSER_OUTPUT: 01:48:03 INFO - 2015-12-03 01:48:03,006 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.40 Median:72.00 stddev:1.96 (2.7%) stddev-sans-first:2.07 01:48:03 INFO - 2015-12-03 01:48:03,007 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 73.0 74.0 74.0 73.0 70.0 71.0 69.0 69.0 01:48:03 INFO - 2015-12-03 01:48:03,007 DEBUG : BROWSER_OUTPUT: 01:48:03 INFO - 2015-12-03 01:48:03,007 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:71.10 Median:71.00 stddev:0.99 (1.4%) stddev-sans-first:0.97 01:48:03 INFO - 2015-12-03 01:48:03,007 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 72.0 72.0 73.0 70.0 71.0 71.0 71.0 71.0 01:48:03 INFO - 2015-12-03 01:48:03,007 DEBUG : BROWSER_OUTPUT: 01:48:03 INFO - 2015-12-03 01:48:03,007 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:85.50 stddev:2.22 (2.6%) stddev-sans-first:1.94 01:48:03 INFO - 2015-12-03 01:48:03,007 DEBUG : BROWSER_OUTPUT: Values: 89.0 86.0 85.0 89.0 82.0 84.0 84.0 85.0 84.0 86.0 01:48:03 INFO - 2015-12-03 01:48:03,007 DEBUG : BROWSER_OUTPUT: 01:48:03 INFO - 2015-12-03 01:48:03,007 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.10 Median:127.00 stddev:5.22 (4.1%) stddev-sans-first:5.22 01:48:03 INFO - 2015-12-03 01:48:03,007 DEBUG : BROWSER_OUTPUT: Values: 131.0 127.0 134.0 116.0 122.0 127.0 124.0 131.0 123.0 126.0 01:48:03 INFO - 2015-12-03 01:48:03,007 DEBUG : BROWSER_OUTPUT: 01:48:03 INFO - 2015-12-03 01:48:03,007 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.70 Median:146.00 stddev:4.16 (2.9%) stddev-sans-first:4.33 01:48:03 INFO - 2015-12-03 01:48:03,007 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 147.0 146.0 146.0 134.0 145.0 145.0 141.0 140.0 01:48:03 INFO - 2015-12-03 01:48:03,008 DEBUG : BROWSER_OUTPUT: 01:48:03 INFO - 2015-12-03 01:48:03,008 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:70.00 stddev:1.35 (1.9%) stddev-sans-first:1.42 01:48:03 INFO - 2015-12-03 01:48:03,008 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 69.0 67.0 72.0 68.0 70.0 69.0 70.0 70.0 01:48:03 INFO - 2015-12-03 01:48:03,008 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:48:03 INFO - 2015-12-03 01:48:03,008 DEBUG : BROWSER_OUTPUT: 01:48:03 INFO - 2015-12-03 01:48:03,936 INFO : Browser exited with error code: 0 01:48:03 INFO - 2015-12-03 01:48:03,987 INFO : Completed test kraken (00:01:01) 01:48:03 INFO - 2015-12-03 01:48:03,987 INFO : Starting test v8_7 01:48:03 INFO - 2015-12-03 01:48:03,988 DEBUG : operating with platform_type : linux_ 01:48:03 INFO - 2015-12-03 01:48:03,988 INFO : Initialising browser for v8_7 test... 01:48:03 INFO - 2015-12-03 01:48:03,994 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3uxFLs/profile http://localhost:57802/getInfo.html 01:48:08 INFO - 2015-12-03 01:48:08,209 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:48:08 INFO - 2015-12-03 01:48:08,209 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:48:08 INFO - 2015-12-03 01:48:08,209 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:48:08 INFO - 2015-12-03 01:48:08,209 DEBUG : BROWSER_OUTPUT: __metrics 01:48:08 INFO - 2015-12-03 01:48:08,346 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] 01:48:09 INFO - 2015-12-03 01:48:09,248 INFO : Browser initialized. 01:48:09 INFO - 2015-12-03 01:48:09,248 INFO : Running cycle 1/1 for v8_7 test... 01:48:09 INFO - 2015-12-03 01:48:09,248 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3uxFLs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:48:21 INFO - 2015-12-03 01:48:21,257 DEBUG : BROWSER_OUTPUT: RSS: Main: 143429632 01:48:21 INFO - 2015-12-03 01:48:21,258 DEBUG : BROWSER_OUTPUT: 01:48:42 INFO - 2015-12-03 01:48:42,613 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57802/tests/v8_7/run.html (next: http://localhost:57802/tests/v8_7/run.html) 01:48:42 INFO - 2015-12-03 01:48:42,862 DEBUG : BROWSER_OUTPUT: RSS: Main: 138850304 01:48:42 INFO - 2015-12-03 01:48:42,862 DEBUG : BROWSER_OUTPUT: 01:48:42 INFO - 2015-12-03 01:48:42,862 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:48:42 INFO - 2015-12-03 01:48:42,863 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:48:42 INFO - 2015-12-03 01:48:42,863 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:48:42 INFO - 2015-12-03 01:48:42,863 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:48:42 INFO - 2015-12-03 01:48:42,863 DEBUG : BROWSER_OUTPUT: |0;Richards;164.82610845557937 01:48:42 INFO - 2015-12-03 01:48:42,863 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;184.84288354898337 01:48:42 INFO - 2015-12-03 01:48:42,863 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.4694783573807 01:48:42 INFO - 2015-12-03 01:48:42,863 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5159.79381443299 01:48:42 INFO - 2015-12-03 01:48:42,863 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1068.3760683760684 01:48:42 INFO - 2015-12-03 01:48:42,863 DEBUG : BROWSER_OUTPUT: |5;Earley;721.5007215007215 01:48:42 INFO - 2015-12-03 01:48:42,863 DEBUG : BROWSER_OUTPUT: |6;Boyer;12256.09756097561 01:48:42 INFO - 2015-12-03 01:48:42,863 DEBUG : BROWSER_OUTPUT: |7;RegExp;25500 01:48:42 INFO - 2015-12-03 01:48:42,864 DEBUG : BROWSER_OUTPUT: |8;Splay;889.7777777777778 01:48:42 INFO - 2015-12-03 01:48:42,864 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 01:48:42 INFO - 2015-12-03 01:48:42,864 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:48:42 INFO - 2015-12-03 01:48:42,864 DEBUG : BROWSER_OUTPUT: __startTimestamp1449136122862__endTimestamp 01:48:42 INFO - 2015-12-03 01:48:42,865 DEBUG : BROWSER_OUTPUT: 01:48:42 INFO - 2015-12-03 01:48:42,865 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:48:42 INFO - 2015-12-03 01:48:42,865 DEBUG : BROWSER_OUTPUT: Number of tests: 10 01:48:42 INFO - 2015-12-03 01:48:42,865 DEBUG : BROWSER_OUTPUT: 01:48:42 INFO - 2015-12-03 01:48:42,865 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.83 Median:164.83 stddev:0.00 (0.0%) 01:48:42 INFO - 2015-12-03 01:48:42,866 DEBUG : BROWSER_OUTPUT: Values: 164.8 01:48:42 INFO - 2015-12-03 01:48:42,866 DEBUG : BROWSER_OUTPUT: 01:48:42 INFO - 2015-12-03 01:48:42,866 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:184.84 Median:184.84 stddev:0.00 (0.0%) 01:48:42 INFO - 2015-12-03 01:48:42,866 DEBUG : BROWSER_OUTPUT: Values: 184.8 01:48:42 INFO - 2015-12-03 01:48:42,866 DEBUG : BROWSER_OUTPUT: 01:48:42 INFO - 2015-12-03 01:48:42,866 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.47 Median:277.47 stddev:0.00 (0.0%) 01:48:42 INFO - 2015-12-03 01:48:42,867 DEBUG : BROWSER_OUTPUT: Values: 277.5 01:48:42 INFO - 2015-12-03 01:48:42,867 DEBUG : BROWSER_OUTPUT: 01:48:42 INFO - 2015-12-03 01:48:42,867 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5159.79 Median:5159.79 stddev:0.00 (0.0%) 01:48:42 INFO - 2015-12-03 01:48:42,867 DEBUG : BROWSER_OUTPUT: Values: 5159.8 01:48:42 INFO - 2015-12-03 01:48:42,868 DEBUG : BROWSER_OUTPUT: 01:48:42 INFO - 2015-12-03 01:48:42,868 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1068.38 Median:1068.38 stddev:0.00 (0.0%) 01:48:42 INFO - 2015-12-03 01:48:42,868 DEBUG : BROWSER_OUTPUT: Values: 1068.4 01:48:42 INFO - 2015-12-03 01:48:42,868 DEBUG : BROWSER_OUTPUT: 01:48:42 INFO - 2015-12-03 01:48:42,868 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:721.50 Median:721.50 stddev:0.00 (0.0%) 01:48:42 INFO - 2015-12-03 01:48:42,868 DEBUG : BROWSER_OUTPUT: Values: 721.5 01:48:42 INFO - 2015-12-03 01:48:42,869 DEBUG : BROWSER_OUTPUT: 01:48:42 INFO - 2015-12-03 01:48:42,869 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12256.10 Median:12256.10 stddev:0.00 (0.0%) 01:48:42 INFO - 2015-12-03 01:48:42,869 DEBUG : BROWSER_OUTPUT: Values: 12256.1 01:48:42 INFO - 2015-12-03 01:48:42,869 DEBUG : BROWSER_OUTPUT: 01:48:42 INFO - 2015-12-03 01:48:42,869 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25500.00 Median:25500.00 stddev:0.00 (0.0%) 01:48:42 INFO - 2015-12-03 01:48:42,869 DEBUG : BROWSER_OUTPUT: Values: 25500.0 01:48:42 INFO - 2015-12-03 01:48:42,870 DEBUG : BROWSER_OUTPUT: 01:48:42 INFO - 2015-12-03 01:48:42,870 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:889.78 Median:889.78 stddev:0.00 (0.0%) 01:48:42 INFO - 2015-12-03 01:48:42,870 DEBUG : BROWSER_OUTPUT: Values: 889.8 01:48:42 INFO - 2015-12-03 01:48:42,870 DEBUG : BROWSER_OUTPUT: 01:48:42 INFO - 2015-12-03 01:48:42,870 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 01:48:42 INFO - 2015-12-03 01:48:42,870 DEBUG : BROWSER_OUTPUT: Values: 4840.6 01:48:42 INFO - 2015-12-03 01:48:42,870 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:48:42 INFO - 2015-12-03 01:48:42,871 DEBUG : BROWSER_OUTPUT: 01:48:43 INFO - 2015-12-03 01:48:43,768 INFO : Browser exited with error code: 0 01:48:43 INFO - 2015-12-03 01:48:43,780 INFO : Completed test v8_7 (00:00:39) 01:48:43 INFO - 2015-12-03 01:48:43,928 INFO : Completed test suite (00:20:15) 01:48:43 INFO - 2015-12-03 01:48:43,928 DEBUG : Working with test: dromaeo_css 01:48:43 INFO - 2015-12-03 01:48:43,928 DEBUG : Generating results file: dromaeo_css 01:48:43 INFO - 2015-12-03 01:48:43,929 DEBUG : Working with test: kraken 01:48:43 INFO - 2015-12-03 01:48:43,929 DEBUG : Generating results file: kraken 01:48:43 INFO - 2015-12-03 01:48:43,930 INFO : javascript benchmark 01:48:43 INFO - 2015-12-03 01:48:43,930 DEBUG : Working with test: v8_7 01:48:43 INFO - 2015-12-03 01:48:43,930 DEBUG : Generating results file: v8_7 01:48:43 INFO - 2015-12-03 01:48:43,930 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:48:43 INFO - 2015-12-03 01:48:43,980 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 01:48:43 INFO - 2015-12-03 01:48:43,980 DEBUG : process_Request line: dromaeo_css 6335.78 graph.html#tests=[[72,132,43]] 01:48:43 INFO - 2015-12-03 01:48:43,980 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:48:44 INFO - 2015-12-03 01:48:44,007 DEBUG : process_Request line: kraken 1529.50 graph.html#tests=[[232,132,43]] 01:48:44 INFO - 2015-12-03 01:48:44,007 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:48:44 INFO - 2015-12-03 01:48:44,033 DEBUG : process_Request line: v8_7 20605.00 graph.html#tests=[[230,132,43]] 01:48:44 INFO - 2015-12-03 01:48:44,034 INFO : javascript benchmark 01:48:44 INFO - 2015-12-03 01:48:44,038 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2655.0574546036155, 2684.610731443942, 2709.756121949023, 2727.290904364865, 2735.8084934054623, 4559.293309537019, 4740.3600513930605, 4765.64257680674, 4789.90420191596, 4814.879628009301, 4700.741459219742, 4712.622990160788, 4730.621550275978, 4834.927476087862, 4846.055019271234, 4306.181825453162, 4389.429374181352, 4453.4433195850515, 4453.88865278369, 4499.595036446719, 4323.437953066113, 4379.255526560476, 4440.400545926307, 4492.505824359334, 4500.707454015478, 4245.8513952011845, 4286.828526858953, 4358.607725304706, 4360.803763830603, 4393.868183954486, 4323.913521729548, 4352.347147927804, 4367.10474352757, 4370.912581748379, 4392.802323895432, 4335.653147748204, 4339.826406943718, 4347.0, 4347.978260108711, 4398.054418300081, 4411.757353345564, 4515.14212299662, 4563.475200351935, 4648.3957085578995, 4675.836345727883, 5040.117979353635, 5043.722595257259, 5052.722100284483, 5093.694378337312, 5119.948800511985, 5092.28707980883, 5099.745012749385, 5110.97444512775, 5112.744362781846, 5127.410347810012, 4551.112533056055, 4638.443386793607, 4657.767111644438, 4713.858584242478, 4738.810447582127, 5164.04465173944, 5194.844154675366, 5195.636305458582, 5204.375474943031, 5242.868928276824, 4777.402824646919, 4936.0, 4978.601711863114, 4995.775190116454, 5008.398992120969, 4933.407991041026, 4988.176950803149, 5060.7722652480725, 5081.441041485434, 5137.922931156036, 5015.824446144367, 5066.088104141216, 5075.0, 5080.974595127001, 5133.204353325241, 4829.975850120797, 4968.30443737877, 5009.624278179152, 5029.924551131736, 5031.094403007493, 4110.506739191316, 4116.75299482032, 4145.2952997990415, 4185.497740271187, 4244.257254980366, 3688.963110368862, 3703.6481534254203, 3711.5917249102577, 3737.1965027519213, 3746.6253374662315, 4192.224438478891, 4418.447694038246, 4440.045390241049, 4445.73325600465, 4467.5755803198645, 4999.450060493343, 5035.924461133086, 5129.128048231735, 5129.79480820763, 5163.148080566664, 4409.096135292258, 4420.889477763018, 4421.29259318514, 4432.135733531994, 4464.55354464551, 4271.807768650418, 4370.497392799869, 4532.4334458192725, 4534.410526631516, 4560.4071470708595, 4745.881352966135, 4822.662413631012, 4826.131296366688, 4839.0, 4862.343583616166, 5116.8720781979255, 5120.564751996122, 5140.614453916046, 5150.639455238097, 5187.948120518747, 4640.489546149854, 4774.594159496482, 4810.783514741915, 4903.754812259302, 4964.255361695775, 5085.313482679939, 5106.974465127651, 5110.080185566485, 5113.974430127825, 5124.718140502308, 5191.714455704972, 5214.817481388285, 5215.087359712111, 5215.322008138917, 5256.027634887558, 4739.739314337745, 4873.561379475864, 4931.408231012158, 5007.073691367109, 5075.1625981712605, 4884.9511504884495, 4894.559489645949, 4897.2654101885, 4908.509149085063, 4920.876978075434, 4803.159447096814, 4804.8318308859025, 4807.038592281488, 4808.471068182567, 4819.59033482158, 4811.206150985048, 4886.65793394459, 4957.0, 4964.602831773522, 4973.751312434291, 4854.80580776765, 4870.293807397837, 4900.313956046085, 4908.828191013297, 4955.132851751001], "unit": "ms", "name": "dojo.html", "value": 4651.455743758711}, {"lowerIsBetter": false, "replicates": [571.5770329955833, 573.5354362965998, 580.0574067140899, 593.4362355762024, 601.4677010845401, 35347.82326088369, 35822.82088589557, 35843.28313433736, 35929.82035089828, 36017.2796544069, 39922.60077399225, 40348.19303613933, 40373.59626403743, 40473.59526404735, 40491.190176196535, 7916.6437510312035, 8006.359491240687, 8051.63767630458, 8062.274395304421, 8064.0, 7909.050913890313, 7987.400944929124, 8002.039755229352, 8006.039275286974, 8012.5593092379895, 7915.287624113828, 7934.801629959268, 7985.0, 7995.400344974121, 8039.35685145187, 7917.0, 7955.4033447491665, 8007.439479236485, 8011.67953281868, 8017.478863873888, 7836.177201393829, 7971.043474783063, 7971.6014199290385, 8004.8399032019615, 8025.759227223192, 37140.628593713984, 37391.4391284131, 37411.25177496462, 37441.25117497662, 37502.624973750186, 2895.0, 3019.3357461358687, 3037.0736925237793, 3223.5325877747596, 3278.49183376577, 27485.31286717828, 27683.861580691966, 27885.721142788516, 28088.43823123526, 28447.431051379062, 2754.1599812057316, 2786.3312804926873, 2799.300174956261, 2801.80387372884, 2881.6109825173544, 197205.0, 198803.0059849706, 198841.0, 199588.99999999854, 199840.00079999506, 48853.755731221114, 49923.75038124859, 51489.22766158511, 52601.7369913148, 53712.46287537153, 47245.5275447248, 47757.76121119442, 48076.27885581719, 48100.759496203, 48183.27725084127, 13721.108127971649, 13764.793528097087, 13896.722065558632, 13927.164370137622, 13932.303384830719, 9902.108810206972, 9909.851352229722, 10003.449810260505, 10112.848307275397, 10134.189264858793, 18074.18666160026, 18281.81718182828, 18328.633427331377, 18465.261389544266, 18485.5378615533, 7294.598797066213, 7635.656395462218, 7669.7315593953945, 7685.308322251024, 7700.807479813049, 887.3477993674644, 920.7652048727532, 940.7648087978006, 946.7727745341206, 1041.2815157541272, 25613.23160305194, 25687.229383118538, 25751.484970300487, 25827.741722582534, 25998.74001260001, 927.8840144981878, 956.6412595276771, 979.740368802268, 1017.1760873692333, 1017.4099022566893, 13282.601521954357, 13442.865571344357, 13519.729605407836, 13544.661383465493, 13766.105203161962, 256317.0, 257436.0, 260763.0, 261679.0, 262305.0, 43734.0, 44010.7799461007, 44119.77940110279, 44166.0, 44196.55803441989, 1187.2105050141558, 1193.6001439517859, 1212.6362091372378, 1224.761171571535, 1231.0151878497165, 24624.384390390383, 25301.367465813502, 25455.36361590975, 25677.61483577785, 25845.22464326073, 39190.60809391984, 39847.0, 40142.598574013886, 40267.597324027556, 40273.798631006655, 246794.0, 247678.0, 249046.0, 249411.0, 249816.76191047524, 28838.0, 29215.0, 29289.267768305963, 29293.41413171682, 29648.0, 32698.182545436553, 33258.168545786546, 33347.83326083354, 33389.33221335511, 35348.409321580075, 31266.53100203544, 31790.36419271648, 31960.840195799803, 32449.188770280933, 32629.0, 31433.528497072104, 32111.518327224643, 32861.50707739338, 33315.66684333126, 33415.498767518024, 29983.850080749457, 30184.24539386533, 32567.348653027282, 32955.67044329622, 33036.1740956478, 25366.0, 26837.463250735265, 26871.596926046517, 26937.461250774482, 27083.052093176644, 22905.31284061481, 23309.0, 23315.88342058347, 23511.882440587688, 23554.764452355943], "unit": "ms", "name": "ext.html", "value": 16393.564464576233}, {"lowerIsBetter": false, "replicates": [330.4465021089676, 331.61698238534495, 335.3109360264655, 335.8941933291013, 340.88409940620187, 14963.102213867161, 15429.382824687013, 15597.766033509506, 15729.449469268578, 16297.429589964353, 9682.12860842524, 9843.950780246107, 12503.624891253277, 13960.58118256454, 14106.858931410683, 4492.528284530118, 4610.331501932218, 4617.522392834295, 4623.8844028899375, 5044.319016932704, 5026.974865125688, 5074.340335756347, 5076.238564215379, 5078.0, 5083.313752643401, 3336.7664263501565, 3432.5709286339206, 5002.324686167375, 5022.799088036492, 5075.873103172432, 5184.222366644995, 5185.740712964337, 5208.505192006773, 5215.530602245797, 5226.346706661686, 4961.578265847407, 5011.348524691767, 5025.748712564357, 5151.922721159186, 5189.870253243699, 17843.821561784345, 17860.19629116693, 18123.72814407785, 19350.322738704217, 19372.128254228595, 1893.6118095790468, 1894.7915729269769, 1905.0093951145327, 1906.8855868647925, 2002.888396939698, 8805.29390723737, 8855.380123391365, 8884.777880552972, 9686.806263874683, 12810.0, 1791.6954117800005, 1804.9548761280942, 1806.7922188948307, 1819.818018198183, 1847.861410394226, 55466.0, 56890.0, 57697.423025769625, 58687.0, 59151.99999999957, 9567.712968610953, 9842.311038227255, 9950.978923932464, 10038.849417258747, 10068.899311006797, 12596.81104783429, 12646.051546134076, 12662.430190641444, 12680.23918564889, 12696.0, 6921.204061532888, 6939.097917270722, 7077.292270772985, 7082.362587367162, 7161.749338773222, 6738.898916516257, 6753.763618273337, 6765.492588055916, 6780.118584584071, 6782.457403407716, 4185.518665353523, 4207.410962465257, 4213.0, 4219.894502637459, 4223.303154979394, 1757.3322137587634, 1784.6698360803293, 1789.9821001790076, 1793.0944872839132, 1832.7525784018987, 378.78977167671655, 383.77932688704107, 854.7649396415911, 885.2121611765534, 922.9939366090993, 9567.61729530811, 14971.101733896001, 15516.379344826306, 15730.764038539432, 15901.284442200129, 832.9125441828642, 878.5212059427628, 880.6961598248594, 891.2468963725642, 944.5654998700675, 8485.109063548362, 8705.6517739291, 8748.343874209333, 8805.119488051272, 8919.955400222958, 492794.0, 494826.0, 510273.0, 510363.0, 512787.0, 71095.2890471099, 71431.64284178546, 71853.64073179601, 72229.0, 73151.0, 1049.7113293844254, 1057.9894201058198, 1068.9518971646294, 1076.1444651502075, 1077.1544337694872, 13586.38861251266, 14280.642983925485, 14455.49405770793, 14579.708405831612, 14739.26303684833, 31784.0, 32031.67968320287, 32576.51135232926, 33421.16447088842, 33737.0, 42002.0, 42470.362944555236, 42614.78692606641, 43186.78406607947, 44753.55246447624, 8639.179277968582, 8840.071792461698, 9231.630734770533, 9235.07649235071, 9262.0, 9948.751281218027, 10036.0, 10800.675979720621, 16458.177091145633, 16989.235484402983, 13235.205887646773, 13693.315334233448, 14045.36795844169, 14139.64650883736, 14153.929230353782, 10386.688399348031, 13376.130551514121, 13544.525941591997, 13964.0, 14065.718685626434, 14172.574822755334, 14239.074460160056, 14554.272286385427, 14644.560663180122, 14655.120692758468, 8711.47731136134, 8785.560721963748, 8810.251128654136, 9011.774705632411, 9051.773705657411, 8867.185371917587, 13063.085584009408, 13210.603681889559, 13640.795388069386, 14327.283635818376], "unit": "ms", "name": "jquery.html", "value": 8126.382760023166}, {"lowerIsBetter": false, "replicates": [1490.076152785272, 1634.7793047938526, 1700.2773821126018, 1710.8973461592304, 1721.9913900430504, 6330.272018717849, 6492.837679058026, 7090.4327653787705, 7218.097737782778, 7257.600831954241, 6835.589864608127, 7028.753993610225, 7064.046353742243, 7084.326988936055, 7096.0420343253645, 1998.390490900275, 2022.312413779322, 2025.0684685044896, 2030.2995466564087, 2031.431199264201, 2052.8152466278034, 2055.2498338106557, 2064.525159213382, 2122.1405330840958, 2132.275026490993, 2053.1992522916075, 2060.7115003899467, 2088.425682937197, 2093.8638988465777, 2097.286922446368, 2093.3196711068886, 2101.3800928726064, 2101.7582977957577, 2113.9894300528476, 2118.851680382374, 2056.341970569418, 2084.7289852319254, 2086.499240182345, 2098.6327392706216, 2101.2645574049116, 7159.89260161098, 7224.6026468544205, 7247.782566523013, 7260.45546584003, 7265.382442492394, 4057.5130984282073, 4112.91774164518, 4123.690723195772, 4141.337386018253, 4157.0, 2698.473797609467, 2727.0864260472767, 2751.6010178524202, 2758.600002999574, 2786.2755683522228, 862.5773371048141, 863.5725315968573, 866.5320726807516, 882.0253619750148, 889.7464222696565, 9421.717348479488, 9527.237820974375, 9532.857007144898, 9575.425474471554, 9627.566759495769, 3818.7517811342173, 3837.5586807517493, 3879.127196380848, 3896.7467114637457, 3925.7055720821054, 8242.670293188325, 8335.54154521495, 8342.040665323444, 8349.457285276438, 8362.0, 4132.028973191298, 4147.212029714345, 4148.771817550003, 4151.8962025949595, 4155.501339839238, 3312.685294896981, 3393.2195595013286, 3683.613220611851, 3692.4276737105793, 3800.9429858552144, 3477.94783078254, 3490.89527314181, 3503.789772613651, 3521.031716278044, 3528.3825330567047, 1098.4837126550508, 1114.8940850619178, 1115.5482029777952, 1120.1486869978876, 1120.5013768872773, 1137.4256000719583, 1142.9314241145557, 1157.3171828621155, 1162.2910024884814, 1186.489809381974, 6851.0, 6901.309869013058, 6925.307469253135, 6925.549839260432, 6964.338387853247, 1018.6282007067367, 1040.7606250562412, 1042.5829668132656, 1084.7233955341337, 1094.7974624694457, 5545.805896793673, 5573.442655734475, 5581.358143813432, 5591.161325801162, 5622.465865742748, 8306.958465207636, 8452.57737113142, 8500.10748871372, 8623.051464338918, 8678.349123815738, 8296.087430382653, 8371.748847534584, 8372.497650141011, 8494.023187333412, 8522.48865068098, 6614.503912206604, 6667.6666166691475, 6715.1941766988275, 6863.588184708933, 6938.444924406136, 6823.351781580742, 6857.382835544626, 6877.174739031148, 6887.483438742214, 6919.273476284918, 7517.924820751722, 7603.619819009138, 7736.303732664087, 7741.109772376023, 7862.646180921758, 7586.81032974158, 7730.574818385043, 7744.186860379579, 7854.646540905559, 7865.488743231672, 5353.304070470814, 5455.8363249102595, 6285.2457705075685, 6377.298497165215, 6447.065175549613, 6894.8621027580175, 6897.793066207821, 6908.861822763617, 6920.861582768417, 6950.930490695028, 6344.619322840645, 6515.6742162892615, 6532.444742196966, 6670.733170673313, 6687.996800479967, 6254.6247225166635, 6476.190476190476, 6502.317256687979, 6533.314002029719, 6675.766348177791, 6578.76974305897, 6617.106690596708, 6666.866662666623, 6669.233038200669, 6669.899951500828, 6028.09578563219, 6052.697365131814, 6112.083187521907, 6273.905891411724, 6281.59169653971, 6247.5001999839, 6306.842328941813, 6311.368863113836, 6332.715027823667, 6333.619982801047], "unit": "ms", "name": "mootools.html", "value": 4141.994350624237}, {"lowerIsBetter": false, "replicates": [288.22323837258585, 293.3180355673061, 301.077198386944, 303.3356948283259, 309.7227980957045, 5461.508464238218, 5495.313085864267, 5624.184493248476, 5639.7180140993, 5659.151127330892, 5503.834884953458, 5511.255980442639, 5526.696031718254, 5534.529564986971, 5536.335639723239, 4140.254754144253, 4288.571142885702, 4289.227938970984, 4291.291936830435, 4293.871183864473, 4245.341971994346, 4250.723702959313, 4270.67969902257, 4273.850415235467, 4275.380069889864, 4208.600182982627, 4224.0, 4225.049363893115, 4225.661947044229, 4230.555791641879, 4202.726822756511, 4213.747175169485, 4228.365745138223, 4230.428892099558, 4241.703080784316, 3677.1910179760675, 3677.44838274261, 3677.485152078711, 3680.6687398134027, 3692.40921452569, 5115.18157094863, 5264.078786212397, 5273.709945952971, 5287.9159772246985, 5299.152135658314, 4852.660313778037, 4854.320395144648, 4858.587020103296, 4858.761015940912, 4872.025594881038, 5836.212111364996, 5855.619384739978, 5856.590038697293, 5856.7071646417935, 5860.970695146497, 3991.381335892941, 3991.7405368650943, 3992.5208974923194, 4006.939895901564, 4014.6788256939667, 5948.702564871739, 5977.8804423911715, 6123.846903827395, 6127.87744245117, 6135.263768347782, 4084.4077608746566, 4096.078382363944, 4108.4453598764385, 4112.013116851934, 4114.115465174942, 4175.415441838145, 4175.937360939588, 4181.435506206684, 4183.5398106208295, 4188.895277618023, 4819.397575303087, 4828.758562071883, 4831.154547954094, 4831.227003679394, 4832.057748739033, 5685.857853553612, 5794.710264486843, 5813.040848260074, 5826.0, 5827.5920685552455, 1458.3728996531381, 1469.80157678712, 1471.2864260833487, 1472.34480656107, 1472.8232612086617, 974.7319487140951, 983.5328219096016, 986.9457179855033, 999.2655398282257, 1005.1707341443339, 5088.77100530477, 5115.514026167508, 5121.28302037715, 5122.0, 5131.281620573048, 5933.2880054393745, 6001.969990150109, 6061.969690151521, 6106.114613381035, 6107.267127944675, 5107.080725469377, 5119.180931051014, 5144.871378215575, 5147.073526765218, 5152.896942061137, 3229.531717900938, 3261.641219465857, 3276.6559511251453, 3277.147941535218, 3294.950575741366, 5667.744951477193, 5741.770329186869, 5757.337906140764, 5776.220210271559, 5783.103618939072, 6231.4391704746795, 6248.9062664060075, 6249.843753906098, 6261.7182226799905, 6281.057841323746, 5740.799072032459, 5778.219940308089, 5782.884342313214, 5796.362400135981, 5803.3616302207565, 6045.455908968214, 6046.879062418815, 6075.696215189135, 6082.482988945812, 6085.6348619083, 5803.506701930383, 5926.970365148147, 5966.970165149147, 5974.970125149346, 5981.491573216152, 5789.855253618524, 5798.768049277982, 5802.796902108406, 5809.2738407699035, 5821.854453638693, 4043.2924238257597, 4079.061815782446, 4080.0, 4081.1225586499045, 4090.611391917763, 5914.4381283777975, 6060.848478788065, 6093.390660933871, 6102.816915492543, 6107.961646520013, 5835.708214589338, 5847.327557330791, 5852.4147585241135, 5854.385289544707, 5866.853328666817, 5838.854028649318, 5840.474357307693, 5851.0, 5859.736311865891, 5870.970645146917, 5563.888722225452, 5674.687892165971, 5704.68624225655, 5710.114932185518, 5713.400092990176, 5867.266591676041, 5870.207521984648, 5876.529877609695, 5906.645601263938, 5909.23179986599, 5718.285214348207, 5718.656880587178, 5720.628159169641, 5722.62802917809, 5727.570432217683], "unit": "ms", "name": "prototype.html", "value": 4355.257787753749}, {"lowerIsBetter": false, "replicates": [649.6102338596841, 667.2193533565728, 667.5093806052554, 774.303127185533, 796.2356138107417, 11057.11543076554, 11314.717132071703, 11320.094392448606, 11332.660020199386, 11347.375894325809, 11597.536098556047, 12103.757924841499, 12135.817962730544, 12144.635660930164, 12185.57350492733, 623.0, 631.0250662726099, 787.3386355461425, 790.4782843323408, 805.7461899501639, 799.188823344306, 801.2908575910333, 803.5580430763086, 807.9474834135792, 808.1191501263621, 786.9763907082797, 829.1749709039514, 841.8821365008904, 842.9199226073544, 844.9915500844975, 827.5696637748367, 828.362161135925, 830.3647709502266, 830.8421399933993, 831.8294749576322, 615.230961298377, 615.5321955313949, 615.6521565315627, 616.9907451388233, 618.7030225491744, 11673.1828771986, 11714.589989350332, 11800.586979455678, 11800.763984720343, 11856.644300670994, 11363.0, 11395.715107122389, 11441.771164576745, 11638.534458621645, 11790.528378864836, 9542.141207291308, 9566.0, 9654.517274136266, 9673.129418352311, 10211.591536338537, 3247.512873069035, 3277.459219228824, 3294.5058241263764, 3299.488579270217, 3387.983060084684, 40468.797656011535, 40753.59246407528, 40868.38697419541, 41029.974250643674, 41081.0, 9600.279979001603, 9666.806663866684, 9757.90242097584, 9915.553800079013, 9988.05113514215, 16226.594335141715, 16347.836521634868, 16425.6714865702, 16425.917870410573, 16459.177041147894, 6397.96801015992, 6501.349865013555, 6542.509311801634, 6599.47204223661, 6756.527043106936, 3299.9175020624198, 3466.3067386522293, 3471.2016236265295, 3505.649435056525, 3519.3665140274998, 2785.749282564579, 2848.7293707097792, 2852.229897927548, 2865.226388874992, 2870.62681851358, 509.22597651570146, 514.6063261604876, 516.1200153737868, 517.4773478786453, 521.3587287636228, 555.9499645031966, 560.7028275014248, 584.272580637101, 602.3344204653882, 611.8286879673699, 7698.2686644768655, 7769.0, 8009.078955920144, 8620.094890036582, 8765.693200737944, 494.9356583644103, 555.88604336111, 589.908564172554, 597.1818608506375, 606.2179788073424, 3673.669369756735, 3688.6680198782237, 3743.831527581265, 3874.9418758718643, 3901.2782635212575, 50367.0, 50445.24332135021, 51259.0, 51335.0, 51623.0, 45836.3124553132, 46334.0, 46630.0, 47008.29487557621, 48472.7576362123, 41077.58922410797, 41542.79228603898, 41638.791806040776, 41923.0, 41971.43242824394, 7954.363650908029, 8154.633041513265, 8349.707760228363, 8359.247667709935, 8370.330373570221, 32203.194920127185, 32221.35557288888, 32298.19254518562, 32453.51319730159, 32729.836350818092, 36674.81662591777, 37341.0, 39730.0, 42487.362689559064, 42695.0, 9754.365966212174, 9841.655542055994, 9885.703428897144, 10047.698569042941, 10229.48852557384, 10199.949000254952, 10676.946615266874, 11294.60468883585, 11499.13756468285, 11586.0, 10422.270441069053, 10891.78216435651, 10901.56393744273, 10914.126869850552, 11124.499397527292, 10197.286189966631, 10374.0, 10417.0, 10684.0, 10767.946160269148, 10404.0, 10775.6228532001, 10948.124150068135, 11191.216614836883, 11201.103911687209, 8657.696980605648, 8891.955540222258, 9051.0, 9051.094890510896, 9305.86041209396, 8689.522076285864, 8783.648654053766, 9106.590203440994, 9637.37357071788, 9690.70927872165], "unit": "ms", "name": "yui.html", "value": 5785.968560578929}], "name": "dromaeo_css", "value": 6335.780258236881}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 108.0, 110.0, 109.0, 111.0, 123.0, 111.0, 111.0, 111.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 111.6}, {"lowerIsBetter": true, "replicates": [159.0, 131.0, 158.0, 173.0, 131.0, 153.0, 152.0, 131.0, 171.0, 129.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.8}, {"lowerIsBetter": true, "replicates": [164.0, 165.0, 160.0, 162.0, 168.0, 164.0, 172.0, 161.0, 165.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 164.3}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 73.0, 71.0, 73.0, 73.0, 135.0, 72.0, 73.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 79.2}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 130.0, 94.0, 94.0, 95.0, 130.0, 94.0, 95.0, 125.0], "unit": "ms", "name": "audio-oscillator", "value": 104.7}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 111.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 148.0, 148.0, 147.0, 149.0, 148.0, 148.0, 147.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.7}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 97.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 73.0, 74.0, 74.0, 73.0, 70.0, 71.0, 69.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 71.4}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 72.0, 72.0, 73.0, 70.0, 71.0, 71.0, 71.0, 71.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 71.1}, {"lowerIsBetter": true, "replicates": [89.0, 86.0, 85.0, 89.0, 82.0, 84.0, 84.0, 85.0, 84.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.4}, {"lowerIsBetter": true, "replicates": [131.0, 127.0, 134.0, 116.0, 122.0, 127.0, 124.0, 131.0, 123.0, 126.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.1}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 146.0, 146.0, 134.0, 145.0, 145.0, 141.0, 140.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.7}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 69.0, 67.0, 72.0, 68.0, 70.0, 69.0, 70.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.4}], "name": "kraken", "value": 1529.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.82610845557937], "unit": "score", "name": "Richards", "value": 214.177234}, {"lowerIsBetter": false, "replicates": [184.84288354898337], "unit": "score", "name": "DeltaBlue", "value": 357.6983799999999}, {"lowerIsBetter": false, "replicates": [277.4694783573807], "unit": "score", "name": "Encrypt", "value": 959.316324}, {"lowerIsBetter": false, "replicates": [5159.79381443299], "unit": "score", "name": "Decrypt", "value": 51.587526473526495}, {"lowerIsBetter": false, "replicates": [1068.3760683760684], "unit": "score", "name": "RayTrace", "value": 692.6297040000002}, {"lowerIsBetter": false, "replicates": [721.5007215007215], "unit": "score", "name": "Earley", "value": 923.7177179999996}, {"lowerIsBetter": false, "replicates": [12256.09756097561], "unit": "score", "name": "Boyer", "value": 54.378075621890574}, {"lowerIsBetter": false, "replicates": [25500.0], "unit": "score", "name": "RegExp", "value": 35.72490196078431}, {"lowerIsBetter": false, "replicates": [889.7777777777778], "unit": "score", "name": "Splay", "value": 91.58578921078922}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 20605.0045948795}]} 01:48:44 INFO - RETURN: dromaeo_css: 6335.78 01:48:44 INFO - RETURN: kraken: 1529.50 01:48:44 INFO - RETURN: v8_7: 20605.00 01:48:44 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "20605.00"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1529.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6335.78"}}} 01:48:44 INFO - Return code: 0 01:48:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:48:44 INFO - # TBPL SUCCESS # 01:48:44 INFO - Running post-action listener: _resource_record_post_action 01:48:44 INFO - Running post-run listener: _resource_record_post_run 01:48:45 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 4096; Write bytes: 513814528; Read time: 12; Write time: 546892 01:48:45 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 208023552; Read time: 0; Write time: 375472 01:48:45 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 4096; Write bytes: 275939328; Read time: 12; Write time: 156172 01:48:45 INFO - Running post-run listener: _upload_blobber_files 01:48:45 INFO - Blob upload gear active. 01:48:45 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 01:48:45 INFO - Copying logs to upload dir... 01:48:45 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1270.758952 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-12-03 01:48:45.147655) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 01:48:45.150855) ========= 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=21869f6c619b95355032545b000001da-1449134672.635411-155353781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009971 build_url: 'https://queue.taskcluster.net/v1/task/LyCNorK9SBueuTbFU1lNyA/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 01:48:45.202605) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 01:48:45.202989) ========= 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=21869f6c619b95355032545b000001da-1449134672.635411-155353781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004506 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 01:48:45.252907) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 01:48:45.253378) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 01:48:45.253716) ========= ========= Total master_lag: 0.25 =========