builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-003 starttime: 1449639573.39 results: success (0) buildid: 20151208205541 builduid: c991aa3486f34dd3a768f3d8fe70f11d revision: 4c661487b6f0e8c33cffc46cd0cc2f35d105a615 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-08 21:39:33.393463) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-08 21:39:33.393954) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-08 21:39:33.394274) ========= 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-1449630435.624719-1655294267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006440 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-08 21:39:33.433658) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-08 21:39:33.434205) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-08 21:39:33.673985) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 21:39:33.674383) ========= 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-1449630435.624719-1655294267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004381 ========= master_lag: 0.11 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 21:39:33.790091) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-08 21:39:33.793523) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-08 21:39:33.793956) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-08 21:39:33.794345) ========= 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-1449630435.624719-1655294267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-08 21:39:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 221M=0s 2015-12-08 21:39:34 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.187876 ========= master_lag: 1.49 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-08 21:39:35.473075) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 21:39:35.473420) ========= 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-1449630435.624719-1655294267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019453 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 21:39:35.549116) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 21:39:35.552515) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4c661487b6f0e8c33cffc46cd0cc2f35d105a615 --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 4c661487b6f0e8c33cffc46cd0cc2f35d105a615 --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-1449630435.624719-1655294267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-08 21:39:35,845 truncating revision to first 12 chars 2015-12-08 21:39:35,845 Setting DEBUG logging. 2015-12-08 21:39:35,845 attempt 1/10 2015-12-08 21:39:35,845 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4c661487b6f0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-08 21:39:36,262 unpacking tar archive at: fx-team-4c661487b6f0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.680585 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 21:39:36.247277) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-08 21:39:36.247632) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-08 21:39:36.257688) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-08 21:39:36.258398) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-08 21:39:36.259260) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-08 21:39:36.259902) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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-1449630435.624719-1655294267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:39:36 INFO - MultiFileLogger online at 20151208 21:39:36 in /builds/slave/test 21:39:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 21:39:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:39:36 INFO - {'append_to_log': False, 21:39:36 INFO - 'base_work_dir': '/builds/slave/test', 21:39:36 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 21:39:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:39:36 INFO - 'branch': 'Fx-Team-Non-PGO', 21:39:36 INFO - 'buildbot_json_path': 'buildprops.json', 21:39:36 INFO - 'config_files': ('talos/linux_config.py',), 21:39:36 INFO - 'default_actions': ('clobber', 21:39:36 INFO - 'read-buildbot-config', 21:39:36 INFO - 'download-and-extract', 21:39:36 INFO - 'populate-webroot', 21:39:36 INFO - 'create-virtualenv', 21:39:36 INFO - 'install', 21:39:36 INFO - 'run-tests'), 21:39:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:39:36 INFO - 'download_minidump_stackwalk': True, 21:39:36 INFO - 'download_symbols': 'ondemand', 21:39:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:39:36 INFO - 'tooltool.py': '/tools/tooltool.py', 21:39:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:39:36 INFO - '/tools/misc-python/virtualenv.py')}, 21:39:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:39:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:39:36 INFO - 'installer_path': 'installer.exe', 21:39:36 INFO - 'log_level': 'info', 21:39:36 INFO - 'log_name': 'talos', 21:39:36 INFO - 'log_to_console': True, 21:39:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:39:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:39:36 INFO - 'opt_config_files': (), 21:39:36 INFO - 'pip_index': False, 21:39:36 INFO - 'sps_profile': False, 21:39:36 INFO - 'sps_profile_interval': 0, 21:39:36 INFO - 'suite': 'dromaeojs', 21:39:36 INFO - 'system_bits': '64', 21:39:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:39:36 INFO - 'title': 'talos-linux64-ix-003', 21:39:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:39:36 INFO - 'use_talos_json': True, 21:39:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:39:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:39:36 INFO - 'work_dir': 'build'} 21:39:36 INFO - ##### 21:39:36 INFO - ##### Running clobber step. 21:39:36 INFO - ##### 21:39:36 INFO - Running pre-action listener: _resource_record_pre_action 21:39:36 INFO - Running main action method: clobber 21:39:36 INFO - rmtree: /builds/slave/test/build 21:39:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:39:37 INFO - Running post-action listener: _resource_record_post_action 21:39:37 INFO - ##### 21:39:37 INFO - ##### Running read-buildbot-config step. 21:39:37 INFO - ##### 21:39:37 INFO - Running pre-action listener: _resource_record_pre_action 21:39:37 INFO - Running main action method: read_buildbot_config 21:39:37 INFO - Using buildbot properties: 21:39:37 INFO - { 21:39:37 INFO - "properties": { 21:39:37 INFO - "buildnumber": 994, 21:39:37 INFO - "product": "firefox", 21:39:37 INFO - "script_repo_revision": "production", 21:39:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 21:39:37 INFO - "repository": "", 21:39:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 21:39:37 INFO - "buildid": "20151208205541", 21:39:37 INFO - "slavename": "talos-linux64-ix-003", 21:39:37 INFO - "pgo_build": "False", 21:39:37 INFO - "basedir": "/builds/slave/test", 21:39:37 INFO - "project": "", 21:39:37 INFO - "platform": "ubuntu64_hw", 21:39:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:39:37 INFO - "slavebuilddir": "test", 21:39:37 INFO - "scheduler": "tests-fx-team-linux64-talos", 21:39:37 INFO - "branch": "fx-team", 21:39:37 INFO - "repo_path": "integration/fx-team", 21:39:37 INFO - "stage_platform": "linux64", 21:39:37 INFO - "builduid": "c991aa3486f34dd3a768f3d8fe70f11d", 21:39:37 INFO - "revision": "4c661487b6f0e8c33cffc46cd0cc2f35d105a615" 21:39:37 INFO - }, 21:39:37 INFO - "sourcestamp": { 21:39:37 INFO - "repository": "", 21:39:37 INFO - "hasPatch": false, 21:39:37 INFO - "project": "", 21:39:37 INFO - "branch": "fx-team-linux64-talos", 21:39:37 INFO - "changes": [ 21:39:37 INFO - { 21:39:37 INFO - "category": null, 21:39:37 INFO - "files": [ 21:39:37 INFO - { 21:39:37 INFO - "url": null, 21:39:37 INFO - "name": "https://queue.taskcluster.net/v1/task/WrdCcC-cRi6N7fuFTVRdgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 21:39:37 INFO - } 21:39:37 INFO - ], 21:39:37 INFO - "repository": "", 21:39:37 INFO - "rev": "4c661487b6f0e8c33cffc46cd0cc2f35d105a615", 21:39:37 INFO - "who": "gijskruitbosch@gmail.com", 21:39:37 INFO - "when": 1449639554, 21:39:37 INFO - "number": 7119277, 21:39:37 INFO - "comments": "Bug 1229772 - improve wording on tab groups migration page, r=mconley,ui-review=verdi", 21:39:37 INFO - "project": "", 21:39:37 INFO - "at": "Tue 08 Dec 2015 21:39:14", 21:39:37 INFO - "branch": "fx-team-linux64-talos", 21:39:37 INFO - "revlink": "", 21:39:37 INFO - "properties": [ 21:39:37 INFO - [ 21:39:37 INFO - "buildid", 21:39:37 INFO - "20151208205541", 21:39:37 INFO - "Change" 21:39:37 INFO - ], 21:39:37 INFO - [ 21:39:37 INFO - "builduid", 21:39:37 INFO - "c991aa3486f34dd3a768f3d8fe70f11d", 21:39:37 INFO - "Change" 21:39:37 INFO - ], 21:39:37 INFO - [ 21:39:37 INFO - "pgo_build", 21:39:37 INFO - "False", 21:39:37 INFO - "Change" 21:39:37 INFO - ] 21:39:37 INFO - ], 21:39:37 INFO - "revision": "4c661487b6f0e8c33cffc46cd0cc2f35d105a615" 21:39:37 INFO - } 21:39:37 INFO - ], 21:39:37 INFO - "revision": "4c661487b6f0e8c33cffc46cd0cc2f35d105a615" 21:39:37 INFO - } 21:39:37 INFO - } 21:39:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/WrdCcC-cRi6N7fuFTVRdgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 21:39:37 INFO - Running post-action listener: _resource_record_post_action 21:39:37 INFO - ##### 21:39:37 INFO - ##### Running download-and-extract step. 21:39:37 INFO - ##### 21:39:37 INFO - Running pre-action listener: _resource_record_pre_action 21:39:37 INFO - Running main action method: download_and_extract 21:39:37 INFO - mkdir: /builds/slave/test/build/tests 21:39:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:39:37 INFO - https://queue.taskcluster.net/v1/task/WrdCcC-cRi6N7fuFTVRdgw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:39:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WrdCcC-cRi6N7fuFTVRdgw/artifacts/public/build/test_packages.json 21:39:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WrdCcC-cRi6N7fuFTVRdgw/artifacts/public/build/test_packages.json 21:39:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WrdCcC-cRi6N7fuFTVRdgw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 21:39:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WrdCcC-cRi6N7fuFTVRdgw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 21:39:38 INFO - Downloaded 1302 bytes. 21:39:38 INFO - Reading from file /builds/slave/test/build/test_packages.json 21:39:38 INFO - Using the following test package requirements: 21:39:38 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:39:38 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:39:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:39:38 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:39:38 INFO - u'jsshell-linux-x86_64.zip'], 21:39:38 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:39:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:39:38 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:39:38 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:39:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:39:38 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:39:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:39:38 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:39:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:39:38 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:39:38 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:39:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:39:38 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:39: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')]} 21:39:38 INFO - https://queue.taskcluster.net/v1/task/WrdCcC-cRi6N7fuFTVRdgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:39:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WrdCcC-cRi6N7fuFTVRdgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:39:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WrdCcC-cRi6N7fuFTVRdgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:39:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WrdCcC-cRi6N7fuFTVRdgw/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 21:39:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WrdCcC-cRi6N7fuFTVRdgw/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 21:39:39 INFO - Downloaded 21859668 bytes. 21:39:39 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 21:39:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:39:39 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 21:39:40 INFO - Return code: 0 21:39:40 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 21:39:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:39:40 INFO - https://queue.taskcluster.net/v1/task/WrdCcC-cRi6N7fuFTVRdgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:39:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WrdCcC-cRi6N7fuFTVRdgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:39:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WrdCcC-cRi6N7fuFTVRdgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:39:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WrdCcC-cRi6N7fuFTVRdgw/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 21:39:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WrdCcC-cRi6N7fuFTVRdgw/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 21:39:41 INFO - Downloaded 21859668 bytes. 21:39: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 21:39:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:39: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 21:39:42 INFO - Return code: 0 21:39: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')]} 21:39:42 INFO - https://queue.taskcluster.net/v1/task/WrdCcC-cRi6N7fuFTVRdgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:39:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WrdCcC-cRi6N7fuFTVRdgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:39:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WrdCcC-cRi6N7fuFTVRdgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:39:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WrdCcC-cRi6N7fuFTVRdgw/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 21:39:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WrdCcC-cRi6N7fuFTVRdgw/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 21:39:44 INFO - Downloaded 11132038 bytes. 21:39: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 21:39:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:39: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 21:39:44 INFO - Return code: 0 21:39:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:39:44 INFO - https://queue.taskcluster.net/v1/task/WrdCcC-cRi6N7fuFTVRdgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:39:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WrdCcC-cRi6N7fuFTVRdgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:39:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WrdCcC-cRi6N7fuFTVRdgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:39:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WrdCcC-cRi6N7fuFTVRdgw/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 21:39:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WrdCcC-cRi6N7fuFTVRdgw/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 21:39:46 INFO - Downloaded 57727076 bytes. 21:39:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WrdCcC-cRi6N7fuFTVRdgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:39:46 INFO - mkdir: /builds/slave/test/properties 21:39:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:39:46 INFO - Writing to file /builds/slave/test/properties/build_url 21:39:46 INFO - Contents: 21:39:46 INFO - build_url:https://queue.taskcluster.net/v1/task/WrdCcC-cRi6N7fuFTVRdgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:39:46 INFO - Running post-action listener: _resource_record_post_action 21:39:46 INFO - Running post-action listener: set_extra_try_arguments 21:39:46 INFO - ##### 21:39:46 INFO - ##### Running populate-webroot step. 21:39:46 INFO - ##### 21:39:46 INFO - Running pre-action listener: _resource_record_pre_action 21:39:46 INFO - Running main action method: populate_webroot 21:39:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:39:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:39:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:39:46 INFO - '--tppagecycles', 21:39:46 INFO - '7'], 21:39:46 INFO - 'tests': ['tsvgm']}}, 21:39:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:39:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:39:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:39:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:39:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:39:46 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:39:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:39:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:39:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:39:46 INFO - 'talos_options': ['--e10s'], 21:39:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:39:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:39:46 INFO - 'tests': ['damp', 'tps']}, 21:39:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:39:46 INFO - 'talos_options': ['--e10s'], 21:39:46 INFO - 'tests': ['damp', 'tps']}, 21:39:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:39:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:39:46 INFO - 'other': {'tests': ['a11yr', 21:39:46 INFO - 'ts_paint', 21:39:46 INFO - 'tpaint', 21:39:46 INFO - 'sessionrestore', 21:39:46 INFO - 'sessionrestore_no_auto_restore']}, 21:39:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:39:46 INFO - 'tests': ['a11yr', 21:39:46 INFO - 'ts_paint', 21:39:46 INFO - 'tpaint', 21:39:46 INFO - 'sessionrestore', 21:39:46 INFO - 'sessionrestore_no_auto_restore']}, 21:39:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:39:46 INFO - 'tests': ['a11yr', 21:39:46 INFO - 'ts_paint', 21:39:46 INFO - 'tpaint', 21:39:46 INFO - 'sessionrestore', 21:39:46 INFO - 'sessionrestore_no_auto_restore']}, 21:39:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:39:46 INFO - 'tests': ['a11yr', 21:39:46 INFO - 'ts_paint', 21:39:46 INFO - 'tpaint', 21:39:46 INFO - 'sessionrestore', 21:39:46 INFO - 'sessionrestore_no_auto_restore']}, 21:39:46 INFO - 'other_l64': {'tests': ['a11yr', 21:39:46 INFO - 'ts_paint', 21:39:46 INFO - 'tpaint', 21:39:46 INFO - 'sessionrestore', 21:39:46 INFO - 'sessionrestore_no_auto_restore']}, 21:39:46 INFO - 'other_nol64': {'tests': ['a11yr', 21:39:46 INFO - 'ts_paint', 21:39:46 INFO - 'tpaint', 21:39:46 INFO - 'sessionrestore', 21:39:46 INFO - 'sessionrestore_no_auto_restore']}, 21:39:46 INFO - 'svgr': {'tests': ['tsvgx', 21:39:46 INFO - 'tsvgr_opacity', 21:39:46 INFO - 'tart', 21:39:46 INFO - 'tscrollx', 21:39:46 INFO - 'cart']}, 21:39:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:39:46 INFO - 'tests': ['tsvgx', 21:39:46 INFO - 'tsvgr_opacity', 21:39:46 INFO - 'tart', 21:39:46 INFO - 'tscrollx', 21:39:46 INFO - 'cart']}, 21:39:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:39:46 INFO - 'tests': ['tp5o']}, 21:39:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:39:46 INFO - 'talos_options': ['--e10s'], 21:39:46 INFO - 'tests': ['tp5o']}, 21:39:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:39:46 INFO - 'talos_options': ['--xperf_path', 21:39:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:39:46 INFO - 'tests': ['tp5n']}, 21:39:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:39:46 INFO - 'talos_options': ['--e10s', 21:39:46 INFO - '--xperf_path', 21:39:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:39:46 INFO - 'tests': ['tp5n']}}, 21:39:46 INFO - 'talos.zip': {'path': '', 21:39:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:39:46 INFO - Running post-action listener: _resource_record_post_action 21:39:46 INFO - ##### 21:39:46 INFO - ##### Running create-virtualenv step. 21:39:46 INFO - ##### 21:39:46 INFO - Running pre-action listener: _resource_record_pre_action 21:39:46 INFO - Running main action method: create_virtualenv 21:39:46 INFO - Creating virtualenv /builds/slave/test/build/venv 21:39:46 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 21:39:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:39:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:39:46 INFO - Using real prefix '/usr' 21:39:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:39:47 INFO - Installing distribute.............................................................................................................................................................................................done. 21:39:49 INFO - Installing pip.................done. 21:39:49 INFO - Return code: 0 21:39:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:39:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:39:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:39:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f36e40d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c8240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24570b0>, '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 0x2457fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2458440>, '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-1449630435.624719-1655294267', '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 21:39:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:39:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:39:49 INFO - Using env: {'DISPLAY': ':0', 21:39:49 INFO - 'HOME': '/home/cltbld', 21:39:49 INFO - 'LANG': 'en_US.UTF-8', 21:39:49 INFO - 'LANGUAGE': 'en_US:en', 21:39:49 INFO - 'LOGNAME': 'cltbld', 21:39:49 INFO - 'MAIL': '/var/mail/cltbld', 21:39:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:49 INFO - 'MOZ_NO_REMOTE': '1', 21:39:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:49 INFO - 'NO_EM_RESTART': '1', 21:39:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:49 INFO - 'PWD': '/builds/slave/test', 21:39:49 INFO - 'SHELL': '/bin/bash', 21:39:49 INFO - 'SHLVL': '1', 21:39:49 INFO - 'TERM': 'linux', 21:39:49 INFO - 'TMOUT': '86400', 21:39:49 INFO - 'USER': 'cltbld', 21:39:49 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1449630435.624719-1655294267', 21:39:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:49 INFO - '_': '/tools/buildbot/bin/python'} 21:39:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:49 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 21:39:49 INFO - Cleaning up... 21:39:49 INFO - Return code: 0 21:39:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:39:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:39:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:39:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f36e40d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c8240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24570b0>, '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 0x2457fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2458440>, '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-1449630435.624719-1655294267', '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 21:39:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 21:39:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 21:39:49 INFO - Using env: {'DISPLAY': ':0', 21:39:49 INFO - 'HOME': '/home/cltbld', 21:39:49 INFO - 'LANG': 'en_US.UTF-8', 21:39:49 INFO - 'LANGUAGE': 'en_US:en', 21:39:49 INFO - 'LOGNAME': 'cltbld', 21:39:49 INFO - 'MAIL': '/var/mail/cltbld', 21:39:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:49 INFO - 'MOZ_NO_REMOTE': '1', 21:39:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:49 INFO - 'NO_EM_RESTART': '1', 21:39:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:49 INFO - 'PWD': '/builds/slave/test', 21:39:49 INFO - 'SHELL': '/bin/bash', 21:39:49 INFO - 'SHLVL': '1', 21:39:49 INFO - 'TERM': 'linux', 21:39:49 INFO - 'TMOUT': '86400', 21:39:49 INFO - 'USER': 'cltbld', 21:39:49 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1449630435.624719-1655294267', 21:39:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:49 INFO - '_': '/tools/buildbot/bin/python'} 21:39:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:49 INFO - Downloading/unpacking psutil>=0.7.1 21:39:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:39:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:39:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:39:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:39:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:39:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:39:51 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 21:39:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:39:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:39:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:39:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:39:51 INFO - Installing collected packages: psutil 21:39:51 INFO - Running setup.py install for psutil 21:39:51 INFO - building 'psutil._psutil_linux' extension 21:39:51 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 21:39:51 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 21:39:51 INFO - building 'psutil._psutil_posix' extension 21:39:51 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 21:39:52 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 21:39:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:39:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:39:52 INFO - Successfully installed psutil 21:39:52 INFO - Cleaning up... 21:39:52 INFO - Return code: 0 21:39:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:39: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')]} 21:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39: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')]} 21:39:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39: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', '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 0x7f36e40d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c8240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24570b0>, '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 0x2457fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2458440>, '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-1449630435.624719-1655294267', '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 21:39: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 21:39: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 mozsystemmonitor==0.0.0 21:39:52 INFO - Using env: {'DISPLAY': ':0', 21:39:52 INFO - 'HOME': '/home/cltbld', 21:39:52 INFO - 'LANG': 'en_US.UTF-8', 21:39:52 INFO - 'LANGUAGE': 'en_US:en', 21:39:52 INFO - 'LOGNAME': 'cltbld', 21:39:52 INFO - 'MAIL': '/var/mail/cltbld', 21:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:52 INFO - 'MOZ_NO_REMOTE': '1', 21:39:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:52 INFO - 'NO_EM_RESTART': '1', 21:39:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:52 INFO - 'PWD': '/builds/slave/test', 21:39:52 INFO - 'SHELL': '/bin/bash', 21:39:52 INFO - 'SHLVL': '1', 21:39:52 INFO - 'TERM': 'linux', 21:39:52 INFO - 'TMOUT': '86400', 21:39:52 INFO - 'USER': 'cltbld', 21:39:52 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1449630435.624719-1655294267', 21:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:52 INFO - '_': '/tools/buildbot/bin/python'} 21:39:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:39: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 21:39: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 21:39: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 21:39: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 21:39: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 21:39: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 21:39:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:39:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:39:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:39:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:39:54 INFO - Installing collected packages: mozsystemmonitor 21:39:54 INFO - Running setup.py install for mozsystemmonitor 21:39:54 INFO - Successfully installed mozsystemmonitor 21:39:54 INFO - Cleaning up... 21:39:54 INFO - Return code: 0 21:39:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:39:54 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')]} 21:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:54 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')]} 21:39:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:54 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 0x7f36e40d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c8240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24570b0>, '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 0x2457fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2458440>, '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-1449630435.624719-1655294267', '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 21:39:54 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 21:39:54 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 21:39:54 INFO - Using env: {'DISPLAY': ':0', 21:39:54 INFO - 'HOME': '/home/cltbld', 21:39:54 INFO - 'LANG': 'en_US.UTF-8', 21:39:54 INFO - 'LANGUAGE': 'en_US:en', 21:39:54 INFO - 'LOGNAME': 'cltbld', 21:39:54 INFO - 'MAIL': '/var/mail/cltbld', 21:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:54 INFO - 'MOZ_NO_REMOTE': '1', 21:39:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:54 INFO - 'NO_EM_RESTART': '1', 21:39:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:54 INFO - 'PWD': '/builds/slave/test', 21:39:54 INFO - 'SHELL': '/bin/bash', 21:39:54 INFO - 'SHLVL': '1', 21:39:54 INFO - 'TERM': 'linux', 21:39:54 INFO - 'TMOUT': '86400', 21:39:54 INFO - 'USER': 'cltbld', 21:39:54 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1449630435.624719-1655294267', 21:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:54 INFO - '_': '/tools/buildbot/bin/python'} 21:39:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:54 INFO - Downloading/unpacking blobuploader==1.2.4 21:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:39:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:39:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:39:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:39:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:39:56 INFO - Downloading blobuploader-1.2.4.tar.gz 21:39:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:39:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:39:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:39:56 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 21:39:56 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 21:39:56 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 21:39:56 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 21:39:56 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 21:39:56 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 21:39:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:39:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:39:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:39:56 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 21:39:56 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 21:39:56 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 21:39:56 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 21:39:56 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 21:39:56 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 21:39:56 INFO - Downloading docopt-0.6.1.tar.gz 21:39:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:39:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:39:57 INFO - Installing collected packages: blobuploader, requests, docopt 21:39:57 INFO - Running setup.py install for blobuploader 21:39:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:39:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:39:57 INFO - Running setup.py install for requests 21:39:57 INFO - Running setup.py install for docopt 21:39:57 INFO - Successfully installed blobuploader requests docopt 21:39:57 INFO - Cleaning up... 21:39:57 INFO - Return code: 0 21:39:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:39: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')]} 21:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39: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')]} 21:39:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:57 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 0x7f36e40d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c8240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24570b0>, '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 0x2457fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2458440>, '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-1449630435.624719-1655294267', '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 21:39:57 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 21:39:57 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 21:39:57 INFO - Using env: {'DISPLAY': ':0', 21:39:57 INFO - 'HOME': '/home/cltbld', 21:39:57 INFO - 'LANG': 'en_US.UTF-8', 21:39:57 INFO - 'LANGUAGE': 'en_US:en', 21:39:57 INFO - 'LOGNAME': 'cltbld', 21:39:57 INFO - 'MAIL': '/var/mail/cltbld', 21:39:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:57 INFO - 'MOZ_NO_REMOTE': '1', 21:39:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:57 INFO - 'NO_EM_RESTART': '1', 21:39:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:57 INFO - 'PWD': '/builds/slave/test', 21:39:57 INFO - 'SHELL': '/bin/bash', 21:39:57 INFO - 'SHLVL': '1', 21:39:57 INFO - 'TERM': 'linux', 21:39:57 INFO - 'TMOUT': '86400', 21:39:57 INFO - 'USER': 'cltbld', 21:39:57 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1449630435.624719-1655294267', 21:39:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:57 INFO - '_': '/tools/buildbot/bin/python'} 21:39:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:39:57 INFO - Running setup.py (path:/tmp/pip-_MXEYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:39:57 INFO - Running setup.py (path:/tmp/pip-nEbskS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:39:57 INFO - Running setup.py (path:/tmp/pip-t2I9zi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:39:58 INFO - Running setup.py (path:/tmp/pip-WLv5rh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:39:58 INFO - Running setup.py (path:/tmp/pip-Z7MHvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:39:58 INFO - Running setup.py (path:/tmp/pip-WPXrWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:39:58 INFO - Running setup.py (path:/tmp/pip-E1wRKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:39:58 INFO - Running setup.py (path:/tmp/pip-WpGCXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:39:58 INFO - Running setup.py (path:/tmp/pip-DDJqI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:39:58 INFO - Running setup.py (path:/tmp/pip-YsNvC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:39:58 INFO - Running setup.py (path:/tmp/pip-g_1Qmp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:39:58 INFO - Running setup.py (path:/tmp/pip-BIwsYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:39:58 INFO - Running setup.py (path:/tmp/pip-4ezz3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:39:58 INFO - Running setup.py (path:/tmp/pip-CE34dQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:39:58 INFO - Running setup.py (path:/tmp/pip-fPKLjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:39:58 INFO - Running setup.py (path:/tmp/pip-j2KLid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:39:58 INFO - Running setup.py (path:/tmp/pip-4ZXwAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:39:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:39:59 INFO - Running setup.py install for manifestparser 21:39:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:39:59 INFO - Running setup.py install for mozcrash 21:39:59 INFO - Running setup.py install for mozdebug 21:39:59 INFO - Running setup.py install for mozdevice 21:39:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:39:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:39:59 INFO - Running setup.py install for mozfile 21:39:59 INFO - Running setup.py install for mozhttpd 21:39:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:39:59 INFO - Running setup.py install for mozinfo 21:39:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:39:59 INFO - Running setup.py install for mozInstall 21:39:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:39:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:39:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:39:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:39:59 INFO - Running setup.py install for mozleak 21:39:59 INFO - Running setup.py install for mozlog 21:40:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:40:00 INFO - Running setup.py install for moznetwork 21:40:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:40:00 INFO - Running setup.py install for mozprocess 21:40:00 INFO - Running setup.py install for mozprofile 21:40:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:40:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:40:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:40:00 INFO - Running setup.py install for mozrunner 21:40:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:40:00 INFO - Running setup.py install for mozscreenshot 21:40:00 INFO - Running setup.py install for moztest 21:40:00 INFO - Running setup.py install for mozversion 21:40:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:40:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:40:00 INFO - Cleaning up... 21:40:00 INFO - Return code: 0 21:40:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:40: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')]} 21:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40: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')]} 21:40:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:00 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 0x7f36e40d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c8240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24570b0>, '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 0x2457fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2458440>, '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-1449630435.624719-1655294267', '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 21:40:00 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 21:40:00 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 21:40:00 INFO - Using env: {'DISPLAY': ':0', 21:40:00 INFO - 'HOME': '/home/cltbld', 21:40:00 INFO - 'LANG': 'en_US.UTF-8', 21:40:00 INFO - 'LANGUAGE': 'en_US:en', 21:40:00 INFO - 'LOGNAME': 'cltbld', 21:40:00 INFO - 'MAIL': '/var/mail/cltbld', 21:40:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:00 INFO - 'MOZ_NO_REMOTE': '1', 21:40:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:40:00 INFO - 'NO_EM_RESTART': '1', 21:40:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:40:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:00 INFO - 'PWD': '/builds/slave/test', 21:40:00 INFO - 'SHELL': '/bin/bash', 21:40:00 INFO - 'SHLVL': '1', 21:40:00 INFO - 'TERM': 'linux', 21:40:00 INFO - 'TMOUT': '86400', 21:40:00 INFO - 'USER': 'cltbld', 21:40:00 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1449630435.624719-1655294267', 21:40:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:00 INFO - '_': '/tools/buildbot/bin/python'} 21:40:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:40:01 INFO - Running setup.py (path:/tmp/pip-y7j7vb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:40:01 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)) 21:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:40:01 INFO - Running setup.py (path:/tmp/pip-UbDSna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:40:01 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)) 21:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:40:01 INFO - Running setup.py (path:/tmp/pip-OC5MXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:40:01 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)) 21:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:40:01 INFO - Running setup.py (path:/tmp/pip-yAfF_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:40:01 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)) 21:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:40:01 INFO - Running setup.py (path:/tmp/pip-JCEZz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:40:01 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)) 21:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:40:01 INFO - Running setup.py (path:/tmp/pip-piSSG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:40:01 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)) 21:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:40:01 INFO - Running setup.py (path:/tmp/pip-wRv8Ho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:40:01 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)) 21:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:40:01 INFO - Running setup.py (path:/tmp/pip-cadV0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:40:01 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)) 21:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:40:01 INFO - Running setup.py (path:/tmp/pip-eTomyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:40:01 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)) 21:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:40:01 INFO - Running setup.py (path:/tmp/pip-fmDvOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:40:01 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)) 21:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:40:01 INFO - Running setup.py (path:/tmp/pip-OGsAIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:40:01 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)) 21:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:40:01 INFO - Running setup.py (path:/tmp/pip-UgIqGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:40:01 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)) 21:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:40:01 INFO - Running setup.py (path:/tmp/pip-LsUZfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:40:01 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)) 21:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:40:02 INFO - Running setup.py (path:/tmp/pip-Ec2gxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:40:02 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)) 21:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:40:02 INFO - Running setup.py (path:/tmp/pip-DFuseg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:40:02 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)) 21:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:40:02 INFO - Running setup.py (path:/tmp/pip-8FLL9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:40:02 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)) 21:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:40:02 INFO - Running setup.py (path:/tmp/pip-mv0mk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:40:02 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)) 21:40:02 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)) 21:40:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:40:02 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)) 21:40:02 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)) 21:40:02 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)) 21:40:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:04 INFO - Downloading blessings-1.5.1.tar.gz 21:40:04 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 21:40:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:40:04 INFO - Installing collected packages: blessings 21:40:04 INFO - Running setup.py install for blessings 21:40:04 INFO - Successfully installed blessings 21:40:04 INFO - Cleaning up... 21:40:05 INFO - Return code: 0 21:40:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:40:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:40:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:40:05 INFO - Reading from file tmpfile_stdout 21:40:05 INFO - Current package versions: 21:40:05 INFO - argparse == 1.2.1 21:40:05 INFO - blessings == 1.5.1 21:40:05 INFO - blobuploader == 1.2.4 21:40:05 INFO - docopt == 0.6.1 21:40:05 INFO - manifestparser == 1.1 21:40:05 INFO - mozInstall == 1.12 21:40:05 INFO - mozcrash == 0.16 21:40:05 INFO - mozdebug == 0.1 21:40:05 INFO - mozdevice == 0.47 21:40:05 INFO - mozfile == 1.2 21:40:05 INFO - mozhttpd == 0.7 21:40:05 INFO - mozinfo == 0.9 21:40:05 INFO - mozleak == 0.1 21:40:05 INFO - mozlog == 3.1 21:40:05 INFO - moznetwork == 0.27 21:40:05 INFO - mozprocess == 0.22 21:40:05 INFO - mozprofile == 0.27 21:40:05 INFO - mozrunner == 6.11 21:40:05 INFO - mozscreenshot == 0.1 21:40:05 INFO - mozsystemmonitor == 0.0 21:40:05 INFO - moztest == 0.7 21:40:05 INFO - mozversion == 1.4 21:40:05 INFO - psutil == 3.1.1 21:40:05 INFO - requests == 1.2.3 21:40:05 INFO - wsgiref == 0.1.2 21:40:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:40:05 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')]} 21:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:05 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')]} 21:40:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:05 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 0x7f36e40d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c8240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24570b0>, '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 0x2457fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2458440>, '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-1449630435.624719-1655294267', '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 21:40:05 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 21:40:05 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 21:40:05 INFO - Using env: {'DISPLAY': ':0', 21:40:05 INFO - 'HOME': '/home/cltbld', 21:40:05 INFO - 'LANG': 'en_US.UTF-8', 21:40:05 INFO - 'LANGUAGE': 'en_US:en', 21:40:05 INFO - 'LOGNAME': 'cltbld', 21:40:05 INFO - 'MAIL': '/var/mail/cltbld', 21:40:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:05 INFO - 'MOZ_NO_REMOTE': '1', 21:40:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:40:05 INFO - 'NO_EM_RESTART': '1', 21:40:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:40:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:05 INFO - 'PWD': '/builds/slave/test', 21:40:05 INFO - 'SHELL': '/bin/bash', 21:40:05 INFO - 'SHLVL': '1', 21:40:05 INFO - 'TERM': 'linux', 21:40:05 INFO - 'TMOUT': '86400', 21:40:05 INFO - 'USER': 'cltbld', 21:40:05 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1449630435.624719-1655294267', 21:40:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:05 INFO - '_': '/tools/buildbot/bin/python'} 21:40:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:05 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)) 21:40:05 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)) 21:40:05 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)) 21:40:05 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)) 21:40:05 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)) 21:40:05 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)) 21:40:05 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)) 21:40:05 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)) 21:40: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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:40:05 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)) 21:40:05 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)) 21:40:05 INFO - Cleaning up... 21:40:05 INFO - Return code: 0 21:40:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:40:05 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')]} 21:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:05 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')]} 21:40:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:05 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 0x7f36e40d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c8240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24570b0>, '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 0x2457fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2458440>, '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-1449630435.624719-1655294267', '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 21:40:05 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 21:40:05 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 21:40:05 INFO - Using env: {'DISPLAY': ':0', 21:40:05 INFO - 'HOME': '/home/cltbld', 21:40:05 INFO - 'LANG': 'en_US.UTF-8', 21:40:05 INFO - 'LANGUAGE': 'en_US:en', 21:40:05 INFO - 'LOGNAME': 'cltbld', 21:40:05 INFO - 'MAIL': '/var/mail/cltbld', 21:40:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:05 INFO - 'MOZ_NO_REMOTE': '1', 21:40:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:40:05 INFO - 'NO_EM_RESTART': '1', 21:40:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:40:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:05 INFO - 'PWD': '/builds/slave/test', 21:40:05 INFO - 'SHELL': '/bin/bash', 21:40:05 INFO - 'SHLVL': '1', 21:40:05 INFO - 'TERM': 'linux', 21:40:05 INFO - 'TMOUT': '86400', 21:40:05 INFO - 'USER': 'cltbld', 21:40:05 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1449630435.624719-1655294267', 21:40:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:05 INFO - '_': '/tools/buildbot/bin/python'} 21:40:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:05 INFO - Downloading/unpacking jsonschema 21:40: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 21:40: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 21:40: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 21:40: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 21:40: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 21:40: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 21:40:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:40:07 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 21:40:07 INFO - Downloading/unpacking functools32 (from jsonschema) 21:40: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 21:40: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 21:40: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 21:40: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 21:40: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 21:40: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 21:40:07 INFO - Downloading functools32-3.2.3-2.tar.gz 21:40:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 21:40:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:40:07 INFO - warning: no files found matching '*.txt' 21:40:07 INFO - no previously-included directories found matching 'build' 21:40:07 INFO - no previously-included directories found matching 'dist' 21:40:07 INFO - no previously-included directories found matching '.git*' 21:40:07 INFO - Installing collected packages: jsonschema, functools32 21:40:07 INFO - Running setup.py install for functools32 21:40:07 INFO - warning: no files found matching '*.txt' 21:40:07 INFO - no previously-included directories found matching 'build' 21:40:07 INFO - no previously-included directories found matching 'dist' 21:40:07 INFO - no previously-included directories found matching '.git*' 21:40:07 INFO - Successfully installed jsonschema functools32 21:40:07 INFO - Cleaning up... 21:40:07 INFO - Return code: 0 21:40:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:40: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')]} 21:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40: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')]} 21:40:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f36e40d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c8240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24570b0>, '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 0x2457fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2458440>, '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-1449630435.624719-1655294267', '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 21:40: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', 'flake8'] in /builds/slave/test/build 21:40: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 flake8 21:40:07 INFO - Using env: {'DISPLAY': ':0', 21:40:07 INFO - 'HOME': '/home/cltbld', 21:40:07 INFO - 'LANG': 'en_US.UTF-8', 21:40:07 INFO - 'LANGUAGE': 'en_US:en', 21:40:07 INFO - 'LOGNAME': 'cltbld', 21:40:07 INFO - 'MAIL': '/var/mail/cltbld', 21:40:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:07 INFO - 'MOZ_NO_REMOTE': '1', 21:40:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:40:07 INFO - 'NO_EM_RESTART': '1', 21:40:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:40:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:07 INFO - 'PWD': '/builds/slave/test', 21:40:07 INFO - 'SHELL': '/bin/bash', 21:40:07 INFO - 'SHLVL': '1', 21:40:07 INFO - 'TERM': 'linux', 21:40:07 INFO - 'TMOUT': '86400', 21:40:07 INFO - 'USER': 'cltbld', 21:40:07 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1449630435.624719-1655294267', 21:40:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:07 INFO - '_': '/tools/buildbot/bin/python'} 21:40:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:08 INFO - Downloading/unpacking flake8 21:40:08 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 21:40:08 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 21:40:08 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 21:40:08 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 21:40:08 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 21:40:08 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 21:40:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:40:09 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 21:40:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:40: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 21:40: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 21:40: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 21:40: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 21:40: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 21:40: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 21:40:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:40:10 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 21:40:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:40: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 21:40: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 21:40: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 21:40: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 21:40: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 21:40: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 21:40:10 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 21:40:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:40: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 21:40: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 21:40: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 21:40: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 21:40: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 21:40: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 21:40:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 21:40:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:40:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:40:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:40:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:40:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:40:10 INFO - no previously-included directories found matching 'docs/_build' 21:40:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:40:10 INFO - Running setup.py install for pep8 21:40:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:40:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:40:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:40:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:40:10 INFO - no previously-included directories found matching 'docs/_build' 21:40:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:40:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:40:10 INFO - Cleaning up... 21:40:10 INFO - Return code: 0 21:40:10 INFO - Running post-action listener: _resource_record_post_action 21:40:10 INFO - Running post-action listener: _start_resource_monitoring 21:40:10 INFO - Starting resource monitoring. 21:40:10 INFO - ##### 21:40:10 INFO - ##### Running install step. 21:40:10 INFO - ##### 21:40:10 INFO - Running pre-action listener: _resource_record_pre_action 21:40:10 INFO - Running main action method: install 21:40:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:40:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:40:10 INFO - Reading from file tmpfile_stdout 21:40:10 INFO - Detecting whether we're running mozinstall >=1.0... 21:40:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:40:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:40:11 INFO - Reading from file tmpfile_stdout 21:40:11 INFO - Output received: 21:40:11 INFO - Usage: mozinstall [options] installer 21:40:11 INFO - Options: 21:40:11 INFO - -h, --help show this help message and exit 21:40:11 INFO - -d DEST, --destination=DEST 21:40:11 INFO - Directory to install application into. [default: 21:40:11 INFO - "/builds/slave/test"] 21:40:11 INFO - --app=APP Application being installed. [default: firefox] 21:40:11 INFO - mkdir: /builds/slave/test/build/application 21:40:11 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'] 21:40:11 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 21:40:25 INFO - Reading from file tmpfile_stdout 21:40:25 INFO - Output received: 21:40:25 INFO - /builds/slave/test/build/application/firefox/firefox 21:40:25 INFO - Running post-action listener: _resource_record_post_action 21:40:25 INFO - ##### 21:40:25 INFO - ##### Running run-tests step. 21:40:25 INFO - ##### 21:40:25 INFO - Running pre-action listener: _resource_record_pre_action 21:40:25 INFO - Running main action method: run_tests 21:40:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:40:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:40:25 INFO - Python 2.7.3 21:40:25 INFO - Return code: 0 21:40:25 INFO - grabbing minidump binary from tooltool 21:40:25 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')]} 21:40:25 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 0x24570b0>, '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 0x2457fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2458440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:40:25 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 21:40:25 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 21:40:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:40:25 INFO - Return code: 0 21:40:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:40:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:40:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:40:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:40:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:40:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:40:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:40:26 INFO - Return code: 0 21:40:26 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WrdCcC-cRi6N7fuFTVRdgw/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 21:40:26 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WrdCcC-cRi6N7fuFTVRdgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --webServer localhost 21:40:26 INFO - Using env: {'DISPLAY': ':0', 21:40:26 INFO - 'HOME': '/home/cltbld', 21:40:26 INFO - 'LANG': 'en_US.UTF-8', 21:40:26 INFO - 'LANGUAGE': 'en_US:en', 21:40:26 INFO - 'LOGNAME': 'cltbld', 21:40:26 INFO - 'MAIL': '/var/mail/cltbld', 21:40:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:40:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:40:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:26 INFO - 'MOZ_NO_REMOTE': '1', 21:40:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:40:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:40:26 INFO - 'NO_EM_RESTART': '1', 21:40:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:40:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:26 INFO - 'PWD': '/builds/slave/test', 21:40:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:40:26 INFO - 'SHELL': '/bin/bash', 21:40:26 INFO - 'SHLVL': '1', 21:40:26 INFO - 'TERM': 'linux', 21:40:26 INFO - 'TMOUT': '86400', 21:40:26 INFO - 'USER': 'cltbld', 21:40:26 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1449630435.624719-1655294267', 21:40:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:26 INFO - '_': '/tools/buildbot/bin/python'} 21:40:26 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WrdCcC-cRi6N7fuFTVRdgw/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 21:40:26 INFO - mozversion INFO | application_buildid: 20151208205541 21:40:26 INFO - mozversion INFO | application_changeset: 4c661487b6f0e8c33cffc46cd0cc2f35d105a615 21:40:26 INFO - mozversion INFO | application_display_name: Nightly 21:40:26 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:40:26 INFO - mozversion INFO | application_name: Firefox 21:40:26 INFO - mozversion INFO | application_remotingname: firefox 21:40:26 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 21:40:26 INFO - mozversion INFO | application_vendor: Mozilla 21:40:26 INFO - mozversion INFO | application_version: 45.0a1 21:40:26 INFO - mozversion INFO | platform_buildid: 20151208205541 21:40:26 INFO - mozversion INFO | platform_changeset: 4c661487b6f0e8c33cffc46cd0cc2f35d105a615 21:40:26 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 21:40:26 INFO - mozversion INFO | platform_version: 45.0a1 21:40:26 INFO - 2015-12-08 21:40:26,781 DEBUG : using testdate: 1449639626 21:40:26 INFO - 2015-12-08 21:40:26,781 DEBUG : actual date: 1449639626 21:40:26 INFO - 2015-12-08 21:40:26,869 INFO : starting webserver on 'localhost:40141' 21:40:26 INFO - 2015-12-08 21:40:26,870 INFO : Starting test suite talos-linux64-ix-003 21:40:26 INFO - 2015-12-08 21:40:26,871 INFO : Starting test dromaeo_css 21:40:26 INFO - 2015-12-08 21:40:26,871 DEBUG : operating with platform_type : linux_ 21:40:26 INFO - 2015-12-08 21:40:26,871 INFO : Initialising browser for dromaeo_css test... 21:40:26 INFO - 2015-12-08 21:40:26,887 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp14hhJX/profile http://localhost:40141/getInfo.html 21:40:30 INFO - 2015-12-08 21:40:30,768 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:40:30 INFO - 2015-12-08 21:40:30,769 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:40:30 INFO - 2015-12-08 21:40:30,769 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:40:30 INFO - 2015-12-08 21:40:30,769 DEBUG : BROWSER_OUTPUT: __metrics 21:40:30 INFO - 2015-12-08 21:40:30,877 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 21:40:30 INFO - 2015-12-08 21:40:30,933 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:40:32 INFO - 2015-12-08 21:40:32,106 INFO : Browser initialized. 21:40:32 INFO - 2015-12-08 21:40:32,106 INFO : Running cycle 1/1 for dromaeo_css test... 21:40:32 INFO - 2015-12-08 21:40:32,106 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp14hhJX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:40:44 INFO - 2015-12-08 21:40:44,142 DEBUG : BROWSER_OUTPUT: RSS: Main: 143581184 21:40:44 INFO - 2015-12-08 21:40:44,143 DEBUG : BROWSER_OUTPUT: 21:41:35 INFO - 2015-12-08 21:41:35,388 DEBUG : BROWSER_OUTPUT: 1449639695383 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] 21:43:47 INFO - 2015-12-08 21:43:47,475 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40141/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40141/tests/dromaeo/cssquery-ext.html) 21:43:48 INFO - 2015-12-08 21:43:48,519 DEBUG : BROWSER_OUTPUT: RSS: Main: 239058944 21:43:48 INFO - 2015-12-08 21:43:48,519 DEBUG : BROWSER_OUTPUT: 21:46:51 INFO - 2015-12-08 21:46:51,126 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40141/tests/dromaeo/cssquery-ext.html (next: http://localhost:40141/tests/dromaeo/cssquery-jquery.html) 21:46:51 INFO - 2015-12-08 21:46:51,708 DEBUG : BROWSER_OUTPUT: RSS: Main: 228126720 21:46:51 INFO - 2015-12-08 21:46:51,708 DEBUG : BROWSER_OUTPUT: 21:49:53 INFO - 2015-12-08 21:49:53,650 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40141/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40141/tests/dromaeo/cssquery-mootools.html) 21:49:54 INFO - 2015-12-08 21:49:54,223 DEBUG : BROWSER_OUTPUT: RSS: Main: 229056512 21:49:54 INFO - 2015-12-08 21:49:54,224 DEBUG : BROWSER_OUTPUT: 21:52:56 INFO - 2015-12-08 21:52:56,121 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40141/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40141/tests/dromaeo/cssquery-prototype.html) 21:52:56 INFO - 2015-12-08 21:52:56,726 DEBUG : BROWSER_OUTPUT: RSS: Main: 203886592 21:52:56 INFO - 2015-12-08 21:52:56,727 DEBUG : BROWSER_OUTPUT: 21:55:59 INFO - 2015-12-08 21:55:59,507 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40141/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40141/tests/dromaeo/cssquery-yui.html) 21:56:00 INFO - 2015-12-08 21:56:00,110 DEBUG : BROWSER_OUTPUT: RSS: Main: 208642048 21:56:00 INFO - 2015-12-08 21:56:00,111 DEBUG : BROWSER_OUTPUT: 21:59:02 INFO - 2015-12-08 21:59:02,624 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40141/tests/dromaeo/cssquery-yui.html (next: http://localhost:40141/tests/dromaeo/cssquery-dojo.html) 21:59:02 INFO - 2015-12-08 21:59:02,874 DEBUG : BROWSER_OUTPUT: RSS: Main: 297103360 21:59:02 INFO - 2015-12-08 21:59:02,874 DEBUG : BROWSER_OUTPUT: 21:59:02 INFO - 2015-12-08 21:59:02,875 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:59:02 INFO - 2015-12-08 21:59:02,875 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:59:02 INFO - 2015-12-08 21:59:02,875 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:59:02 INFO - 2015-12-08 21:59:02,875 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:59:02 INFO - 2015-12-08 21:59:02,876 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2651.1118775210302;2725.332293588071;2728.1951824211856;2741.9862900685494;2757.1315035763732;4460.130274596455;4578.267477203648;4692.366530518379;4728.078024785168;4728.40894888139;4508.54914508549;4583.564561366665;4647.395838540985;4652.32541281514;4656.208444564424;4323.956760432403;4336.544662810406;4338.327559228309;4359.3025115981445;4376.518582955872;4186.6022727840955;4399.42807435033;4403.823847046115;4444.777761111947;4453.064856380164;4240.342746874239;4301.483821941356;4321.308590625485;4323.848665296699;4345.804438800262;4292.871213863589;4293.334533147367;4318.52496225415;4324.610785029363;4333.804978775963;4291.6566674665955;4294.4202532658;4294.935575966363;4314.482262128533;4340.587644173798;4424.977875110636;4502.347159661831;4521.502634710179;4521.570450807168;4694.788734506921;5078.847634570969;5093.643444958854;5122.948770512322;5122.974385128051;5137.61467889906;5117.641765076446;5124.92312615311;5143.768530416103;5150.48495150482;5150.587952963754;4455.754933478657;4545.272756359;4547.863564093016;4670.136024835417;4815.085133824562;5197.298364720715;5254.448282930313;5257.447967963385;5259.421463638997;5264.052470555337;5026.246063090565;5046.949530504648;5051.646384753106;5055.241713742968;5094.847154585368;4863.051704917507;4966.180580204298;4967.3294105296045;4968.527989840959;5044.0920634286185;5008.474110218374;5009.624278179152;5011.047900898818;5021.447640759514;5024.221245706848;4981.775820088104;4990.0269447457395;4995.050940321327;4999.725015124131;5038.1183292924325;4020.638142567183;4054.8986275343354;4104.692148088905;4203.47456567929;4243.766592837424;3620.945685814715;3667.4865518827387;3697.6117507661306;3714.7771133732062;3729.179580492287;4332.631726303236;4341.3487976803735;4344.45694288214;4345.174416860849;4381.84663536781;4862.270659401118;5077.314562534085;5082.771275292621;5087.720175390315;5092.490750924952;4224.028473451123;4274.7435153890865;4281.400603915455;4285.014446677282;4296.677749168824;4454.10917816438;4488.753118578509;4505.166544189336;4508.639308855284;4527.818887244539;4764.213904705684;4793.304970779148;4801.7118972861745;4804.8798780030775;4836.202026665561;4842.951570484391;4956.851294461172;4963.03220871941;4982.975085124696;5051.4695956924;4796.088743138793;4798.640101992295;4806.951930480651;4823.445303790109;4847.345608342828;4994.200927851526;5005.274235235943;5006.799728010985;5012.248162775612;5016.272640467038;4783.856484305476;4843.564079232745;4892.241702536113;4916.803327866845;5101.056304583664;4898.4121905371585;4899.608031357411;4904.166291730486;4912;4937.308776771327;4897.755112244445;4899.118158731462;4904.705717656952;4907.043126590281;4933.703977761345;4538.523455037305;4715.6227501799085;4726.385569875894;4738.455077666113;4854.68444551103;4956.628252880976;4974.7512624369365;4976.776045078052;4978.502149784992;4998.950010499994;4859.416869975626;4859.805607775791;4861.95138048615;4867.342908707279;4903.583195428429 21:59:02 INFO - 2015-12-08 21:59:02,876 DEBUG : BROWSER_OUTPUT: |1;ext.html;536.1582315764249;542.8816637726284;544.8991936491749;546.5627498001597;548.7996881138383;26252;27477.862610686967;35335;35556.2888742225;35676.286474270564;39394.21211575767;39562.8021859891;39658.60341396585;39802.203955920864;39852.601473985254;6876.346747059021;6953.304669533057;7632.542047477155;7800.258975397356;7853.2539408756365;9921.15670168033;10194.9490252549;10208.285420020602;10210.387376757419;10210.795784084314;9883;9970.302078854484;9991.500424978758;10000.2499812514;10002.299839011272;7093.751718689847;7297.781066567958;9852.80294394108;9875.851862222073;10252.436116013616;9774.120329170337;9911.702648920473;9914.90085099147;9916.553755081039;9918.851217231748;36234.094147646254;36585.45121823175;36647.267054658754;36657.26685466302;36724;2812.9296767580768;2832.985835070832;2879.6688380836263;2944.4994350960387;3429.7599168058246;27723.861380693168;27735.445291094064;28147.859260703564;28247.717522824918;28295.575566366522;3390.6609339066144;3434.9656503434894;3439.79361238324;3500.824958752052;3552.0231936217488;213197;213722;213941.93029034912;214231;215259;47841;49365.50634493681;51731.48268517342;51976.740116299174;52078;61542.38457615456;62330;62348.688256558424;62352;62607;12630.052746044083;12805.359732013549;12862.935685321514;12867.54963576289;12886.097973141977;9034.503102329303;9085.682001129928;9130.360874738837;9140.6800761973;9149.359544831797;17556.209970551357;17896.46310610684;17966.550836228937;17994.280228790703;18005.549861253574;7191.820204494929;7381.11426628808;7440.85118297631;7460.85078298431;7562.584057876869;812.9268365846984;829.4318391901567;838.4591938199827;869.2007544383192;972.2902281334524;24319.756802432104;24489.877550612488;24701.135460258804;24758.25725228246;25591.360215994748;848.117957324388;966.2752935298527;967.1730670276953;990.5592011554933;1018.0582960761266;11377.715557110972;11687.517707230603;11940.521631668651;11942.24675661131;11970.849587668523;252812;254419;257905;258147;258427;43750.12499749987;44120;44120;44181.337279940184;44266.33600495995;1045.0646671229208;1076.0907033556632;1083.5557421457165;1212.8180772883961;1239.3741160713782;23128.6530702043;23939.401514962265;24293.392665183514;25871.48257034811;27932.44135117327;36834.26331473302;39892.401613975235;40271;40280.1943961125;40333.798331008154;140649;340385;343568;346351;347706;27455.45089098247;28098.719012810427;28099.71900281053;28143.718562814927;28167;38321.80839095786;38693;39445.80277098596;39447.60552394554;39550.80224598858;28527.42945141044;29340.266493337836;29560.260993475335;29564.852175738983;31078.067657970296;30934.845325773225;32605;32634;32790.34419311648;32846;31877.36245275128;33146.50280245847;33519.83240083784;33540.1614959628;33668.49497257592;24847.378815529035;26919.461610767285;26939.461210775284;26965.595516066882;27368.315792105357;22680.319590412313;23026;23208.071677132724;23551.29346119619;23590.764092359543 21:59:02 INFO - 2015-12-08 21:59:02,878 DEBUG : BROWSER_OUTPUT: |2;jquery.html;280.988760449582;281.48628752526645;283.3497124100191;283.7616402222133;283.981541199822;11137.610183643574;15154.696906061887;15573.14347710874;15593.688126237483;16402.917985410088;9329.953350233256;9490.952545237264;9560.42637441754;15675.60810979726;16006.83993160068;4350.608445239928;4477.708948918326;4480.215962206617;4486.685931984763;4508.842190523333;4482.798274077658;4510.323451482271;4513.571210734991;4518.344839998198;4520.706154099973;3373.1735724747473;3484.1463841358905;3488.337215928978;4489.393931819195;4497.685162038642;3473.253250551131;3482.0424383294544;4886.535779100962;5046.621503387224;5071.036503064406;4811.446683631392;4838.443578988391;4887.486813884527;4898.044881248158;4995.675281106716;17702;17811.910940445345;17869.553261168443;19789.208431662715;19801.207951681914;1791.9820801791946;1853.5180852978187;1876.024467277022;1888.5278680329918;1916.2335065973582;8677.522736249504;8895.243904268145;8899.243564297043;10045.347052441568;12823.166494177942;1727.0587529796292;1740.651869626067;1790.7224380221087;1795.6139430022477;1803.161529888595;56571.43428565703;58879.116813247834;59122;59472;59518.702406488126;9380;9578.952105239568;9591.9040809591;9695.127438530566;9775.217982561378;12342;12372.690682733004;12403.13178077544;12430.192037517714;12430.316332601793;6319;6374.936250637527;6415.13395691585;6418.711157997901;6554.967225163844;6025.216721826135;6079.939200607937;6093;6139.938600614026;6145.293291271561;4046.5548789633117;4071.694622903294;4145.523264824524;4168.916621667549;4176.644985176294;1659.402615058578;1672.7323628219426;1689.1723055702616;1697.3380381651166;1703.1058694185651;718.7268837841586;724.6557885004686;765.8698021336386;802.4783890471241;899.5142622983647;12898.290594017231;14884.181370024537;16022.599435014217;16202.270897809627;16367.181640917906;814.8981377327834;840.7393707950555;858.9012263589767;887.4719541872704;914.9222316103072;7673.34776544;8006.519608823489;8018.358531317481;8829.64681412749;9378.390404623678;481633;481962;482528;485687;486323;71260.64369678119;74296;74425.62787186138;74434.6278268616;74689.62655186799;1079.4063265204106;1079.681493959284;1083.9403832789271;1085.8425528298353;1090.6128324444867;14573.489927852474;14577;14689.943407922685;14793.11241325524;14989.77515337249;34360.31279374449;34545.82727086348;34551.13622159365;34670.65329346674;35197;45465;45697.77151114356;45833;47523;49695.751521242164;8472.322214222972;8479.668091274949;8624.310055195694;8875.378723489552;9055.683051093443;14412.351444184827;14501.347439365465;15615.687686245985;16536.338546458006;16591;12642.620721378373;12693.238405695687;12774.744505110031;12821.807672885101;13084.149530280501;4579.977100114611;7800.453968222397;9620.326577139533;12237.510499579917;13163.670908226988;12193.756124877631;12323.815142773044;12510.562130325396;13866.514671986431;13874.445022199;8593.785155371166;8730.432521886058;8755.649774009224;8825.470471771714;8850.20348168668;12482.375881206084;12805.743885122432;12970.092093553738;13092.410841511964;13395.12931659439 21:59:02 INFO - 2015-12-08 21:59:02,878 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1420.3395421129173;1630.6983208106499;1687.5696697342175;1711.4608898197066;1724.4050802473143;6012.699365031747;7036.612986285752;7113.324234197749;7124.643767811602;7125.180604230515;6987.720491180359;7172.390346820526;7185.532940358873;7188.353048225658;7205.279472052805;1707.7011522983491;1717.3731587970426;1733.514615907548;2047.3653167518044;2084.7289852319177;1769.5222289981698;1774.7071733164012;2034.7354843870276;2082.802133797287;2086.1238279922395;1998.2406685459505;2052.7844576319494;2061.2991582861823;2062.8762274263518;2063.1850419084453;1999.5800881814837;2016.747906511686;2019.4648418169197;2019.5556977464935;2020.9898950505226;2032.7357443532246;2067.6174907642135;2083.427057559168;2083.802038806311;2084.4997200671883;7073.328033836778;7125;7149.928500714978;7158.713651453935;7161.427085833121;4069.267531844267;4121.505419349697;4127.153933443667;4133.524644665872;4133.7106402551835;2664.267326485213;2677.089789471589;2726.672799264101;2739.849308288043;2741.7121202273674;849.6346570974479;857.5069335132324;857.9871301930476;858.5063588436611;875.7504111328241;9727.173190278834;9739.074787895139;9739.464329461876;9745.707628771148;9767.316287859852;3785.2618739346112;3802.866899658554;3869.613038696164;3886.203328317688;3892.3772196449;8169.060558035783;8216.794580135544;8222.301104406073;8227.259546640831;8230.21812927771;4228.1966426378885;4240.088380998101;4240.38514415408;4241.151769646083;4248.362745588125;3835.7314987950576;3860.1700634363747;3861.2084522672785;3861.7103717220757;3870.1098747288283;2910.89811856584;3344.364570731602;3365.9326813463595;3396.541466901986;3406.8126253055825;939.8637197606308;952.9190018848337;954.1126752120595;954.2366107114419;1058.4599407861542;787.047672316492;795.4034474144391;798.0861913109458;882.2280504558511;923.8660394242931;6596.274409814917;6657.300983396771;6664.96667516669;6666.866662666816;6670.232923213893;995.6664517386612;995.7759504111517;1003.3578509753618;1020.2908978260186;1026.6765968719978;5077.568406685473;5204.609654275944;5210.322658054429;5216.817411390583;5236.24074509194;7878.803029924183;7941.086775020831;8167.959160204161;8182.877256841152;8191.221833925768;8088.797780055428;8111.878321825177;8139.186081391932;8151.062627797761;8153.551554664432;6556.918108512137;6570.310117437601;6583.736650534021;6598.439132673777;6605.372489613479;6098.11577321277;6227.813165605039;6235.46998505114;6244.469220116341;6249.437550620466;7228.385587225145;7262.745803896838;7384.778456646309;7402.814929626587;7429.925700742923;7508.2867127622785;7542.773716788505;7549.245075492407;7570.205128461653;7741.109772376023;6033.698315084316;6094.75620975156;6094.969525152346;6097.512199023979;6097.573169878244;6414.775482858077;6456.354364563506;6488.772892948724;6497.577657452251;6505.512086593619;6074.483668888194;6162.845928851814;6192.225971753531;6226.688665566794;6275.592086514362;5563.693996830213;5752.942470575241;6230.345813689497;6258.812235632939;6262.248530176408;6310.05349197624;6342.270638876588;6358.268799088164;6361.904571431525;6365.14070600463;5630.0428927081675;5640.802571909963;5659.236003139688;5665.631733937281;5675.7445914933105;5806.042003069446;5828.417158284137;5860.619059761102;5869.383714709894;5883.352831188651 21:59:02 INFO - 2015-12-08 21:59:02,880 DEBUG : BROWSER_OUTPUT: |4;prototype.html;257.4362146898293;261.07188943306545;261.808879517952;263.43624643263405;266.8265627342227;5351.501579557726;5411.161270003151;5425.565954723617;5433.673979561229;5446.15584584389;5086.313347698059;5276.472352764722;5279.683219006853;5281.128613778731;5296.92054619181;3812.8474861005525;3913.4716813230275;3919.7060220483436;3926.725129240954;3958.8812335629905;4008.759474431529;4028.4964379452567;4031.173609410064;4033.2336855997414;4039.555648878621;3967.841286348543;3972.0268534209013;3975.1056012397266;3978.641922226999;3983.4821473208444;3723.590405055442;3844.596317386662;3876.4379165021196;3967.0875698589343;3991.1618560102415;3400.523926650271;3412.7611067225303;3417.6753208445157;3420.4185288500767;3425.6231814500384;5109.335786347751;5110.3356563646485;5123.077845987721;5129.6409251352425;5137.357830271216;4524.660650451229;4566.13243483737;4569.748663823489;4572.634189264851;4574.4968053514085;5417.945820541783;5537.252470916455;5544.944550554484;5550.5282051025715;5565;3689.3912504436735;3694.07648087978;3710.7216958728204;3710.7588006779474;3717.3494638438165;5794.797182098649;5872.354041055481;5880.882382352329;5881.5882888198275;5884.911726324109;3812.942805857914;3815.8664446744233;3821.3503704370323;3823.3882578787816;3827.9090459218987;3576.5171701819922;3623.6376362363553;3870.9806450967567;3875.6511913927884;3882.5535063467496;4339.479262488521;4392.890177745582;4407;4530.161920044802;4536.523665015192;5603.355614104348;5603.411641777636;5604.663720176803;5611.298587676541;5612.635178713453;1343.770450038204;1358.4769863602585;1359;1359.232033900843;1360.4626172661742;867.1588559097665;878.5914549734404;893.4371346051946;893.5487578772678;896.6010125494092;4918.139325618003;4924.901501969941;4927.310176575283;4928.67963582366;4937.456879743226;5832.650040997553;5840.269966254218;5840.678762668094;5841.2990441146485;5843.094320380348;4897.755112244374;4905.092557876804;4906.656534042654;4910.508949105061;4916.852494425173;3058.1131471873355;3103.332783451569;3111.471049921519;3117.766167537444;3152.1489197916435;5489.615726899158;5518.227448157181;5520.171974203821;5566.332040155207;5570.053090974544;6018.668973206516;6026.186464827279;6031.788887388921;6033.3966603340195;6043.244594425697;5556.99974004683;5558.9715902558155;5560.249366335493;5565.193047008162;5574.358948720868;5705.144228365778;5874.206982057368;5882.617629854046;5887.646741195371;5894.440028197314;5741.971290143522;5747.252857128547;5750.913736293875;5752.856178595569;5754.05058165398;5544.556435485232;5550;5552.194931734956;5555;5555.972220138873;3731.9067023324633;3779.981100094592;3821.5605205401735;3826.7512611680154;3832.4251362295877;5646.153077038312;5773.711314434346;5857.384974577608;5863.501602363847;5881.647101173943;5528.585356098389;5560.6107572471155;5563.304586926634;5566.387697353207;5576.442355764391;5643.858903527444;5658.85852853682;5670.801521946877;5674.319081710056;5674.943250567607;5395.514403703685;5537.446255374592;5537.750801214036;5540.63985840919;5543;5702.971485142548;5707.5433965281845;5708.086706127;5710.229119068873;5721.342045664802;5561.082421400423;5582.0231459495235;5586.832395028156;5594.1608758686525;5595.300587426572 21:59:02 INFO - 2015-12-08 21:59:02,881 DEBUG : BROWSER_OUTPUT: |5;yui.html;649.7043845050503;678.2945736434109;777.9883301750475;791.216695471483;801.8207806049014;12007.75984480311;12021.15851890368;12046.939765301184;12049.277043377404;12086.879131208685;11695.532178712841;11779.116566257522;13079.084464087518;13379.665508362295;13389.66525836852;621.8321053315602;788.7121200761709;802.4423025996934;804.1596531624466;804.3565147881701;627.0500192208807;799.3245707377257;813.8290958898639;814.7433558429076;815.4088285992638;824.1305422778996;839.1985653700701;840.3109450250766;840.9369297302696;842.7050532313702;643.3952085040047;649.3084864619166;824.4270232188632;833.7748807821885;835.7283882738104;610.322541978408;615.8337248942761;615.8368032471399;615.9076138579204;617.1267656266377;12494.187877787916;12541.686457838536;12544.623661290085;12587.307698076602;12602.558910438182;10562.630307939262;10836.133109351233;10849.620263290746;10939.781204375868;11985.400729963554;8648.827023459495;9152.267818574499;9194.35639505235;9346.439213647134;9354.017828128084;3104.9534256986162;3112.37752449511;3140.262038420969;3157.842107894596;3164.889228877001;38905;39426.605733942866;39830.60169398298;39848.20303593912;40079.39880901789;9179.357444978921;9255.074492550826;9262.53687315645;9571;9586.712398628053;15908.363665453253;15937.681246375008;16095.919520402324;16123.677526449404;16151.273192706356;6491.805245842632;6507.934920650828;6589.275179730226;6603.867922641521;6608.603483790988;3631.9818400907825;3668.523091998023;3692.963070369262;3695.8706445274825;3709.6104908984166;2597.5584150694426;2624.527585034712;2628.7896968242494;2629.198094581133;2632.526145293827;460.8502236773062;467.38538821449686;471.4554689333825;471.9805220723221;490.0101794375342;571.2573654249459;596.5257620191958;601.9819405417844;619.9628022318675;621.1521273461692;7123.323284287984;7218.6390680465765;7409.629518524052;7651.3496352810635;8798.164174403422;487.2082865343816;543.9129739241781;550.5265471694339;598.317917573966;605.5155875299743;3467.6532346765625;3530.1704099536587;3886.2810380079777;4024.854399968038;4073.429719839225;46043;46937.29594056092;46946;47182.29226561535;47191.76404117957;43388.56611433908;43849.34225986613;44166;44253.55746442559;44332.77833610876;38644.227115457536;38702.80648596739;38759.61240387616;39104;39440;8004.83990320202;8040.557769322743;8060.15368386311;8234.300084492646;8324.125966773401;30332.84833575818;30533.694663053084;30555;30943.381132377675;31048.84475577698;34884.82557587196;35145.29709405747;35488.645113549566;38790.41814372843;38936.80531597324;9541.141297283279;9745.561449734922;9904.950475247577;9986.500674966368;10242.078212960869;10445.9477702611;10460.738481538023;10472.162227021972;10573.471326433493;10692.839607406051;10145.391276523433;10504.789904202025;10526.368119630828;10679;10832.945835270773;10507.084042733304;10747.516361763895;10753.13974881992;10790.514426850968;10878.292910960763;7428.517146385468;9728.221742260745;9870.259730520096;10012.148967337567;10132.544035518273;8883.73348799537;9337.953310233677;9386.624535018524;9607.711768646952;9889.109980101824;7694.269044440769;8838.734837954615;9167.816643667224;9215.86176207344;9318.767030824283 21:59:02 INFO - 2015-12-08 21:59:02,881 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:59:02 INFO - 2015-12-08 21:59:02,881 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:59:02 INFO - 2015-12-08 21:59:02,881 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,891 21:59:02 INFO - 2015-12-08 21:59:02,881 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:59:02 INFO - 2015-12-08 21:59:02,881 DEBUG : BROWSER_OUTPUT: __startTimestamp1449640742874__endTimestamp 21:59:02 INFO - 2015-12-08 21:59:02,882 DEBUG : BROWSER_OUTPUT: 21:59:02 INFO - 2015-12-08 21:59:02,882 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:59:02 INFO - 2015-12-08 21:59:02,882 DEBUG : BROWSER_OUTPUT: Number of tests: 6 21:59:02 INFO - 2015-12-08 21:59:02,882 DEBUG : BROWSER_OUTPUT: 21:59:02 INFO - 2015-12-08 21:59:02,882 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4640.19 Median:4798.64 stddev:491.53 (10.2%) stddev-sans-first:467.62 21:59:02 INFO - 2015-12-08 21:59:02,882 DEBUG : BROWSER_OUTPUT: Values: 2651.1 2725.3 2728.2 2742.0 2757.1 4460.1 4578.3 4692.4 4728.1 4728.4 4508.5 4583.6 4647.4 4652.3 4656.2 4324.0 4336.5 4338.3 4359.3 4376.5 4186.6 4399.4 4403.8 4444.8 4453.1 4240.3 4301.5 4321.3 4323.8 4345.8 4292.9 4293.3 4318.5 4324.6 4333.8 4291.7 4294.4 4294.9 4314.5 4340.6 4425.0 4502.3 4521.5 4521.6 4694.8 5078.8 5093.6 5122.9 5123.0 5137.6 5117.6 5124.9 5143.8 5150.5 5150.6 4455.8 4545.3 4547.9 4670.1 4815.1 5197.3 5254.4 5257.4 5259.4 5264.1 5026.2 5046.9 5051.6 5055.2 5094.8 4863.1 4966.2 4967.3 4968.5 5044.1 5008.5 5009.6 5011.0 5021.4 5024.2 4981.8 4990.0 4995.1 4999.7 5038.1 4020.6 4054.9 4104.7 4203.5 4243.8 3620.9 3667.5 3697.6 3714.8 3729.2 4332.6 4341.3 4344.5 4345.2 4381.8 4862.3 5077.3 5082.8 5087.7 5092.5 4224.0 4274.7 4281.4 4285.0 4296.7 4454.1 4488.8 4505.2 4508.6 4527.8 4764.2 4793.3 4801.7 4804.9 4836.2 4843.0 4956.9 4963.0 4983.0 5051.5 4796.1 4798.6 4807.0 4823.4 4847.3 4994.2 5005.3 5006.8 5012.2 5016.3 4783.9 4843.6 4892.2 4916.8 5101.1 4898.4 4899.6 4904.2 4912.0 4937.3 4897.8 4899.1 4904.7 4907.0 4933.7 4538.5 4715.6 4726.4 4738.5 4854.7 4956.6 4974.8 4976.8 4978.5 4999.0 4859.4 4859.8 4862.0 4867.3 4903.6 21:59:02 INFO - 2015-12-08 21:59:02,882 DEBUG : BROWSER_OUTPUT: 21:59:02 INFO - 2015-12-08 21:59:02,882 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41221.56 Median:171887.83 stddev:69518.35 (40.4%) stddev-sans-first:69646.25 21:59:02 INFO - 2015-12-08 21:59:02,883 DEBUG : BROWSER_OUTPUT: Values: 536.2 542.9 544.9 546.6 548.8 26252.0 27477.9 35335.0 35556.3 35676.3 39394.2 39562.8 39658.6 39802.2 39852.6 6876.3 6953.3 7632.5 7800.3 7853.3 9921.2 10194.9 10208.3 10210.4 10210.8 9883.0 9970.3 9991.5 10000.2 10002.3 7093.8 7297.8 9852.8 9875.9 10252.4 9774.1 9911.7 9914.9 9916.6 9918.9 36234.1 36585.5 36647.3 36657.3 36724.0 2812.9 2833.0 2879.7 2944.5 3429.8 27723.9 27735.4 28147.9 28247.7 28295.6 3390.7 3435.0 3439.8 3500.8 3552.0 213197.0 213722.0 213941.9 214231.0 215259.0 47841.0 49365.5 51731.5 51976.7 52078.0 61542.4 62330.0 62348.7 62352.0 62607.0 12630.1 12805.4 12862.9 12867.5 12886.1 9034.5 9085.7 9130.4 9140.7 9149.4 17556.2 17896.5 17966.6 17994.3 18005.5 7191.8 7381.1 7440.9 7460.9 7562.6 812.9 829.4 838.5 869.2 972.3 24319.8 24489.9 24701.1 24758.3 25591.4 848.1 966.3 967.2 990.6 1018.1 11377.7 11687.5 11940.5 11942.2 11970.8 252812.0 254419.0 257905.0 258147.0 258427.0 43750.1 44120.0 44120.0 44181.3 44266.3 1045.1 1076.1 1083.6 1212.8 1239.4 23128.7 23939.4 24293.4 25871.5 27932.4 36834.3 39892.4 40271.0 40280.2 40333.8 140649.0 340385.0 343568.0 346351.0 347706.0 27455.5 28098.7 28099.7 28143.7 28167.0 38321.8 38693.0 39445.8 39447.6 39550.8 28527.4 29340.3 29560.3 29564.9 31078.1 30934.8 32605.0 32634.0 32790.3 32846.0 31877.4 33146.5 33519.8 33540.2 33668.5 24847.4 26919.5 26939.5 26965.6 27368.3 22680.3 23026.0 23208.1 23551.3 23590.8 21:59:02 INFO - 2015-12-08 21:59:02,883 DEBUG : BROWSER_OUTPUT: 21:59:02 INFO - 2015-12-08 21:59:02,883 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26154.19 Median:4263.63 stddev:79165.09 (1856.8%) stddev-sans-first:79363.33 21:59:02 INFO - 2015-12-08 21:59:02,884 DEBUG : BROWSER_OUTPUT: Values: 281.0 281.5 283.3 283.8 284.0 11137.6 15154.7 15573.1 15593.7 16402.9 9330.0 9491.0 9560.4 15675.6 16006.8 4350.6 4477.7 4480.2 4486.7 4508.8 4482.8 4510.3 4513.6 4518.3 4520.7 3373.2 3484.1 3488.3 4489.4 4497.7 3473.3 3482.0 4886.5 5046.6 5071.0 4811.4 4838.4 4887.5 4898.0 4995.7 17702.0 17811.9 17869.6 19789.2 19801.2 1792.0 1853.5 1876.0 1888.5 1916.2 8677.5 8895.2 8899.2 10045.3 12823.2 1727.1 1740.7 1790.7 1795.6 1803.2 56571.4 58879.1 59122.0 59472.0 59518.7 9380.0 9579.0 9591.9 9695.1 9775.2 12342.0 12372.7 12403.1 12430.2 12430.3 6319.0 6374.9 6415.1 6418.7 6555.0 6025.2 6079.9 6093.0 6139.9 6145.3 4046.6 4071.7 4145.5 4168.9 4176.6 1659.4 1672.7 1689.2 1697.3 1703.1 718.7 724.7 765.9 802.5 899.5 12898.3 14884.2 16022.6 16202.3 16367.2 814.9 840.7 858.9 887.5 914.9 7673.3 8006.5 8018.4 8829.6 9378.4 481633.0 481962.0 482528.0 485687.0 486323.0 71260.6 74296.0 74425.6 74434.6 74689.6 1079.4 1079.7 1083.9 1085.8 1090.6 14573.5 14577.0 14689.9 14793.1 14989.8 34360.3 34545.8 34551.1 34670.7 35197.0 45465.0 45697.8 45833.0 47523.0 49695.8 8472.3 8479.7 8624.3 8875.4 9055.7 14412.4 14501.3 15615.7 16536.3 16591.0 12642.6 12693.2 12774.7 12821.8 13084.1 4580.0 7800.5 9620.3 12237.5 13163.7 12193.8 12323.8 12510.6 13866.5 13874.4 8593.8 8730.4 8755.6 8825.5 8850.2 12482.4 12805.7 12970.1 13092.4 13395.1 21:59:02 INFO - 2015-12-08 21:59:02,884 DEBUG : BROWSER_OUTPUT: 21:59:02 INFO - 2015-12-08 21:59:02,884 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4855.50 Median:6209.46 stddev:2521.41 (40.6%) stddev-sans-first:2515.27 21:59:02 INFO - 2015-12-08 21:59:02,884 DEBUG : BROWSER_OUTPUT: Values: 1420.3 1630.7 1687.6 1711.5 1724.4 6012.7 7036.6 7113.3 7124.6 7125.2 6987.7 7172.4 7185.5 7188.4 7205.3 1707.7 1717.4 1733.5 2047.4 2084.7 1769.5 1774.7 2034.7 2082.8 2086.1 1998.2 2052.8 2061.3 2062.9 2063.2 1999.6 2016.7 2019.5 2019.6 2021.0 2032.7 2067.6 2083.4 2083.8 2084.5 7073.3 7125.0 7149.9 7158.7 7161.4 4069.3 4121.5 4127.2 4133.5 4133.7 2664.3 2677.1 2726.7 2739.8 2741.7 849.6 857.5 858.0 858.5 875.8 9727.2 9739.1 9739.5 9745.7 9767.3 3785.3 3802.9 3869.6 3886.2 3892.4 8169.1 8216.8 8222.3 8227.3 8230.2 4228.2 4240.1 4240.4 4241.2 4248.4 3835.7 3860.2 3861.2 3861.7 3870.1 2910.9 3344.4 3365.9 3396.5 3406.8 939.9 952.9 954.1 954.2 1058.5 787.0 795.4 798.1 882.2 923.9 6596.3 6657.3 6665.0 6666.9 6670.2 995.7 995.8 1003.4 1020.3 1026.7 5077.6 5204.6 5210.3 5216.8 5236.2 7878.8 7941.1 8168.0 8182.9 8191.2 8088.8 8111.9 8139.2 8151.1 8153.6 6556.9 6570.3 6583.7 6598.4 6605.4 6098.1 6227.8 6235.5 6244.5 6249.4 7228.4 7262.7 7384.8 7402.8 7429.9 7508.3 7542.8 7549.2 7570.2 7741.1 6033.7 6094.8 6095.0 6097.5 6097.6 6414.8 6456.4 6488.8 6497.6 6505.5 6074.5 6162.8 6192.2 6226.7 6275.6 5563.7 5752.9 6230.3 6258.8 6262.2 6310.1 6342.3 6358.3 6361.9 6365.1 5630.0 5640.8 5659.2 5665.6 5675.7 5806.0 5828.4 5860.6 5869.4 5883.4 21:59:02 INFO - 2015-12-08 21:59:02,885 DEBUG : BROWSER_OUTPUT: 21:59:02 INFO - 2015-12-08 21:59:02,885 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4596.31 Median:5373.51 stddev:1418.50 (26.4%) stddev-sans-first:1384.59 21:59:02 INFO - 2015-12-08 21:59:02,885 DEBUG : BROWSER_OUTPUT: Values: 257.4 261.1 261.8 263.4 266.8 5351.5 5411.2 5425.6 5433.7 5446.2 5086.3 5276.5 5279.7 5281.1 5296.9 3812.8 3913.5 3919.7 3926.7 3958.9 4008.8 4028.5 4031.2 4033.2 4039.6 3967.8 3972.0 3975.1 3978.6 3983.5 3723.6 3844.6 3876.4 3967.1 3991.2 3400.5 3412.8 3417.7 3420.4 3425.6 5109.3 5110.3 5123.1 5129.6 5137.4 4524.7 4566.1 4569.7 4572.6 4574.5 5417.9 5537.3 5544.9 5550.5 5565.0 3689.4 3694.1 3710.7 3710.8 3717.3 5794.8 5872.4 5880.9 5881.6 5884.9 3812.9 3815.9 3821.4 3823.4 3827.9 3576.5 3623.6 3871.0 3875.7 3882.6 4339.5 4392.9 4407.0 4530.2 4536.5 5603.4 5603.4 5604.7 5611.3 5612.6 1343.8 1358.5 1359.0 1359.2 1360.5 867.2 878.6 893.4 893.5 896.6 4918.1 4924.9 4927.3 4928.7 4937.5 5832.7 5840.3 5840.7 5841.3 5843.1 4897.8 4905.1 4906.7 4910.5 4916.9 3058.1 3103.3 3111.5 3117.8 3152.1 5489.6 5518.2 5520.2 5566.3 5570.1 6018.7 6026.2 6031.8 6033.4 6043.2 5557.0 5559.0 5560.2 5565.2 5574.4 5705.1 5874.2 5882.6 5887.6 5894.4 5742.0 5747.3 5750.9 5752.9 5754.1 5544.6 5550.0 5552.2 5555.0 5556.0 3731.9 3780.0 3821.6 3826.8 3832.4 5646.2 5773.7 5857.4 5863.5 5881.6 5528.6 5560.6 5563.3 5566.4 5576.4 5643.9 5658.9 5670.8 5674.3 5674.9 5395.5 5537.4 5537.8 5540.6 5543.0 5703.0 5707.5 5708.1 5710.2 5721.3 5561.1 5582.0 5586.8 5594.2 5595.3 21:59:02 INFO - 2015-12-08 21:59:02,885 DEBUG : BROWSER_OUTPUT: 21:59:02 INFO - 2015-12-08 21:59:02,885 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11962.88 Median:23702.34 stddev:13241.75 (55.9%) stddev-sans-first:13251.64 21:59:02 INFO - 2015-12-08 21:59:02,886 DEBUG : BROWSER_OUTPUT: Values: 649.7 678.3 778.0 791.2 801.8 12007.8 12021.2 12046.9 12049.3 12086.9 11695.5 11779.1 13079.1 13379.7 13389.7 621.8 788.7 802.4 804.2 804.4 627.1 799.3 813.8 814.7 815.4 824.1 839.2 840.3 840.9 842.7 643.4 649.3 824.4 833.8 835.7 610.3 615.8 615.8 615.9 617.1 12494.2 12541.7 12544.6 12587.3 12602.6 10562.6 10836.1 10849.6 10939.8 11985.4 8648.8 9152.3 9194.4 9346.4 9354.0 3105.0 3112.4 3140.3 3157.8 3164.9 38905.0 39426.6 39830.6 39848.2 40079.4 9179.4 9255.1 9262.5 9571.0 9586.7 15908.4 15937.7 16095.9 16123.7 16151.3 6491.8 6507.9 6589.3 6603.9 6608.6 3632.0 3668.5 3693.0 3695.9 3709.6 2597.6 2624.5 2628.8 2629.2 2632.5 460.9 467.4 471.5 472.0 490.0 571.3 596.5 602.0 620.0 621.2 7123.3 7218.6 7409.6 7651.3 8798.2 487.2 543.9 550.5 598.3 605.5 3467.7 3530.2 3886.3 4024.9 4073.4 46043.0 46937.3 46946.0 47182.3 47191.8 43388.6 43849.3 44166.0 44253.6 44332.8 38644.2 38702.8 38759.6 39104.0 39440.0 8004.8 8040.6 8060.2 8234.3 8324.1 30332.8 30533.7 30555.0 30943.4 31048.8 34884.8 35145.3 35488.6 38790.4 38936.8 9541.1 9745.6 9905.0 9986.5 10242.1 10445.9 10460.7 10472.2 10573.5 10692.8 10145.4 10504.8 10526.4 10679.0 10832.9 10507.1 10747.5 10753.1 10790.5 10878.3 7428.5 9728.2 9870.3 10012.1 10132.5 8883.7 9338.0 9386.6 9607.7 9889.1 7694.3 8838.7 9167.8 9215.9 9318.8 21:59:02 INFO - 2015-12-08 21:59:02,886 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:59:02 INFO - 2015-12-08 21:59:02,886 DEBUG : BROWSER_OUTPUT: 21:59:03 INFO - 2015-12-08 21:59:03,695 INFO : Browser exited with error code: 0 21:59:03 INFO - 2015-12-08 21:59:03,716 INFO : Completed test dromaeo_css (00:18:36) 21:59:03 INFO - 2015-12-08 21:59:03,716 INFO : Starting test kraken 21:59:03 INFO - 2015-12-08 21:59:03,716 DEBUG : operating with platform_type : linux_ 21:59:03 INFO - 2015-12-08 21:59:03,717 INFO : Initialising browser for kraken test... 21:59:03 INFO - 2015-12-08 21:59:03,722 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsVJ2rQ/profile http://localhost:40141/getInfo.html 21:59:07 INFO - 2015-12-08 21:59:07,924 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:59:07 INFO - 2015-12-08 21:59:07,924 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:59:07 INFO - 2015-12-08 21:59:07,924 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:59:07 INFO - 2015-12-08 21:59:07,924 DEBUG : BROWSER_OUTPUT: __metrics 21:59:07 INFO - 2015-12-08 21:59:07,985 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 21:59:08 INFO - 2015-12-08 21:59:08,053 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:59:08 INFO - 2015-12-08 21:59:08,991 INFO : Browser initialized. 21:59:08 INFO - 2015-12-08 21:59:08,992 INFO : Running cycle 1/1 for kraken test... 21:59:08 INFO - 2015-12-08 21:59:08,992 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsVJ2rQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:59:20 INFO - 2015-12-08 21:59:20,946 DEBUG : BROWSER_OUTPUT: RSS: Main: 142929920 21:59:20 INFO - 2015-12-08 21:59:20,946 DEBUG : BROWSER_OUTPUT: 21:59:23 INFO - 2015-12-08 21:59:23,560 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40141/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40141/tests/kraken/driver.html?testName=audio-beat-detection) 21:59:24 INFO - 2015-12-08 21:59:24,149 DEBUG : BROWSER_OUTPUT: RSS: Main: 178016256 21:59:24 INFO - 2015-12-08 21:59:24,149 DEBUG : BROWSER_OUTPUT: 21:59:26 INFO - 2015-12-08 21:59:26,914 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40141/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40141/tests/kraken/driver.html?testName=audio-dft) 21:59:27 INFO - 2015-12-08 21:59:27,487 DEBUG : BROWSER_OUTPUT: RSS: Main: 170020864 21:59:27 INFO - 2015-12-08 21:59:27,487 DEBUG : BROWSER_OUTPUT: 21:59:30 INFO - 2015-12-08 21:59:30,490 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40141/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40141/tests/kraken/driver.html?testName=audio-fft) 21:59:31 INFO - 2015-12-08 21:59:31,056 DEBUG : BROWSER_OUTPUT: RSS: Main: 154611712 21:59:31 INFO - 2015-12-08 21:59:31,056 DEBUG : BROWSER_OUTPUT: 21:59:33 INFO - 2015-12-08 21:59:33,088 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40141/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40141/tests/kraken/driver.html?testName=audio-oscillator) 21:59:33 INFO - 2015-12-08 21:59:33,661 DEBUG : BROWSER_OUTPUT: RSS: Main: 155353088 21:59:33 INFO - 2015-12-08 21:59:33,661 DEBUG : BROWSER_OUTPUT: 21:59:35 INFO - 2015-12-08 21:59:35,934 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40141/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40141/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:59:36 INFO - 2015-12-08 21:59:36,495 DEBUG : BROWSER_OUTPUT: RSS: Main: 158863360 21:59:36 INFO - 2015-12-08 21:59:36,495 DEBUG : BROWSER_OUTPUT: 21:59:39 INFO - 2015-12-08 21:59:39,505 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40141/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40141/tests/kraken/driver.html?testName=imaging-darkroom) 21:59:40 INFO - 2015-12-08 21:59:40,086 DEBUG : BROWSER_OUTPUT: RSS: Main: 158339072 21:59:40 INFO - 2015-12-08 21:59:40,086 DEBUG : BROWSER_OUTPUT: 21:59:43 INFO - 2015-12-08 21:59:43,528 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40141/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40141/tests/kraken/driver.html?testName=imaging-desaturate) 21:59:44 INFO - 2015-12-08 21:59:44,101 DEBUG : BROWSER_OUTPUT: RSS: Main: 157110272 21:59:44 INFO - 2015-12-08 21:59:44,101 DEBUG : BROWSER_OUTPUT: 21:59:46 INFO - 2015-12-08 21:59:46,998 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40141/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40141/tests/kraken/driver.html?testName=json-parse-financial) 21:59:47 INFO - 2015-12-08 21:59:47,579 DEBUG : BROWSER_OUTPUT: RSS: Main: 157802496 21:59:47 INFO - 2015-12-08 21:59:47,579 DEBUG : BROWSER_OUTPUT: 21:59:49 INFO - 2015-12-08 21:59:49,368 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40141/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40141/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:59:49 INFO - 2015-12-08 21:59:49,929 DEBUG : BROWSER_OUTPUT: RSS: Main: 170942464 21:59:49 INFO - 2015-12-08 21:59:49,929 DEBUG : BROWSER_OUTPUT: 21:59:51 INFO - 2015-12-08 21:59:51,844 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40141/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40141/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:59:52 INFO - 2015-12-08 21:59:52,450 DEBUG : BROWSER_OUTPUT: RSS: Main: 169472000 21:59:52 INFO - 2015-12-08 21:59:52,450 DEBUG : BROWSER_OUTPUT: 21:59:54 INFO - 2015-12-08 21:59:54,561 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40141/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40141/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:59:55 INFO - 2015-12-08 21:59:55,146 DEBUG : BROWSER_OUTPUT: RSS: Main: 180965376 21:59:55 INFO - 2015-12-08 21:59:55,146 DEBUG : BROWSER_OUTPUT: 21:59:57 INFO - 2015-12-08 21:59:57,663 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40141/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40141/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:59:58 INFO - 2015-12-08 21:59:58,247 DEBUG : BROWSER_OUTPUT: RSS: Main: 186994688 21:59:58 INFO - 2015-12-08 21:59:58,247 DEBUG : BROWSER_OUTPUT: 22:00:00 INFO - 2015-12-08 22:00:00,826 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40141/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40141/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:00:01 INFO - 2015-12-08 22:00:01,413 DEBUG : BROWSER_OUTPUT: RSS: Main: 184119296 22:00:01 INFO - 2015-12-08 22:00:01,413 DEBUG : BROWSER_OUTPUT: 22:00:03 INFO - 2015-12-08 22:00:03,168 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40141/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40141/tests/kraken/driver.html?testName=ai-astar) 22:00:03 INFO - 2015-12-08 22:00:03,418 DEBUG : BROWSER_OUTPUT: RSS: Main: 243781632 22:00:03 INFO - 2015-12-08 22:00:03,419 DEBUG : BROWSER_OUTPUT: 22:00:03 INFO - 2015-12-08 22:00:03,420 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:00:03 INFO - 2015-12-08 22:00:03,420 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:00:03 INFO - 2015-12-08 22:00:03,421 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:00:03 INFO - 2015-12-08 22:00:03,421 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:00:03 INFO - 2015-12-08 22:00:03,421 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;112;106;112;112;114;107;114;115;119 22:00:03 INFO - 2015-12-08 22:00:03,421 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;137;155;167;129;151;151;132;174;134 22:00:03 INFO - 2015-12-08 22:00:03,422 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;159;158;160;160;159;160;161;161;161 22:00:03 INFO - 2015-12-08 22:00:03,422 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;71;82;92;71;79;71;111;93;71 22:00:03 INFO - 2015-12-08 22:00:03,422 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;136;94;94;95;132;94;94;131 22:00:03 INFO - 2015-12-08 22:00:03,422 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;109;110;109;111;109;109;109 22:00:03 INFO - 2015-12-08 22:00:03,423 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;146;146;146;146;150;145;146 22:00:03 INFO - 2015-12-08 22:00:03,423 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;96;95;95;95;95;95;95 22:00:03 INFO - 2015-12-08 22:00:03,423 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;72;72;73;72;72;73;71;73;72 22:00:03 INFO - 2015-12-08 22:00:03,423 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;67;69;67;69;68;68;68;69;68 22:00:03 INFO - 2015-12-08 22:00:03,423 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;81;83;83;84;83;84;84;83;83 22:00:03 INFO - 2015-12-08 22:00:03,423 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;118;115;124;119;116;120;136;124;129 22:00:03 INFO - 2015-12-08 22:00:03,423 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;137;147;146;143;138;150;149;150;140 22:00:03 INFO - 2015-12-08 22:00:03,424 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;69;68;69;70;69;68;67;69;68 22:00:03 INFO - 2015-12-08 22:00:03,424 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:00:03 INFO - 2015-12-08 22:00:03,424 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:00:03 INFO - 2015-12-08 22:00:03,424 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,994 22:00:03 INFO - 2015-12-08 22:00:03,424 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:00:03 INFO - 2015-12-08 22:00:03,424 DEBUG : BROWSER_OUTPUT: __startTimestamp1449640803419__endTimestamp 22:00:03 INFO - 2015-12-08 22:00:03,424 DEBUG : BROWSER_OUTPUT: 22:00:03 INFO - 2015-12-08 22:00:03,425 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:00:03 INFO - 2015-12-08 22:00:03,425 DEBUG : BROWSER_OUTPUT: Number of tests: 14 22:00:03 INFO - 2015-12-08 22:00:03,426 DEBUG : BROWSER_OUTPUT: 22:00:03 INFO - 2015-12-08 22:00:03,426 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.20 Median:113.00 stddev:3.77 (3.3%) stddev-sans-first:3.97 22:00:03 INFO - 2015-12-08 22:00:03,426 DEBUG : BROWSER_OUTPUT: Values: 111.0 112.0 106.0 112.0 112.0 114.0 107.0 114.0 115.0 119.0 22:00:03 INFO - 2015-12-08 22:00:03,426 DEBUG : BROWSER_OUTPUT: 22:00:03 INFO - 2015-12-08 22:00:03,426 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.10 Median:151.00 stddev:15.08 (10.0%) stddev-sans-first:15.96 22:00:03 INFO - 2015-12-08 22:00:03,426 DEBUG : BROWSER_OUTPUT: Values: 151.0 137.0 155.0 167.0 129.0 151.0 151.0 132.0 174.0 134.0 22:00:03 INFO - 2015-12-08 22:00:03,426 DEBUG : BROWSER_OUTPUT: 22:00:03 INFO - 2015-12-08 22:00:03,427 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:159.90 Median:160.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 22:00:03 INFO - 2015-12-08 22:00:03,428 DEBUG : BROWSER_OUTPUT: Values: 160.0 159.0 158.0 160.0 160.0 159.0 160.0 161.0 161.0 161.0 22:00:03 INFO - 2015-12-08 22:00:03,428 DEBUG : BROWSER_OUTPUT: 22:00:03 INFO - 2015-12-08 22:00:03,428 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.20 Median:75.00 stddev:13.62 (18.2%) stddev-sans-first:13.94 22:00:03 INFO - 2015-12-08 22:00:03,428 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 82.0 92.0 71.0 79.0 71.0 111.0 93.0 71.0 22:00:03 INFO - 2015-12-08 22:00:03,428 DEBUG : BROWSER_OUTPUT: 22:00:03 INFO - 2015-12-08 22:00:03,428 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.80 Median:94.00 stddev:18.81 (20.0%) stddev-sans-first:19.46 22:00:03 INFO - 2015-12-08 22:00:03,428 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 136.0 94.0 94.0 95.0 132.0 94.0 94.0 131.0 22:00:03 INFO - 2015-12-08 22:00:03,428 DEBUG : BROWSER_OUTPUT: 22:00:03 INFO - 2015-12-08 22:00:03,428 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:109.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 22:00:03 INFO - 2015-12-08 22:00:03,428 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 109.0 110.0 109.0 111.0 109.0 109.0 109.0 22:00:03 INFO - 2015-12-08 22:00:03,428 DEBUG : BROWSER_OUTPUT: 22:00:03 INFO - 2015-12-08 22:00:03,429 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:1.34 (0.9%) stddev-sans-first:1.41 22:00:03 INFO - 2015-12-08 22:00:03,429 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 150.0 145.0 146.0 22:00:03 INFO - 2015-12-08 22:00:03,429 DEBUG : BROWSER_OUTPUT: 22:00:03 INFO - 2015-12-08 22:00:03,429 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 22:00:03 INFO - 2015-12-08 22:00:03,429 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 22:00:03 INFO - 2015-12-08 22:00:03,429 DEBUG : BROWSER_OUTPUT: 22:00:03 INFO - 2015-12-08 22:00:03,430 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.10 Median:72.00 stddev:0.74 (1.0%) stddev-sans-first:0.67 22:00:03 INFO - 2015-12-08 22:00:03,430 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 72.0 73.0 72.0 72.0 73.0 71.0 73.0 72.0 22:00:03 INFO - 2015-12-08 22:00:03,430 DEBUG : BROWSER_OUTPUT: 22:00:03 INFO - 2015-12-08 22:00:03,430 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.78 22:00:03 INFO - 2015-12-08 22:00:03,430 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 69.0 67.0 69.0 68.0 68.0 68.0 69.0 68.0 22:00:03 INFO - 2015-12-08 22:00:03,430 DEBUG : BROWSER_OUTPUT: 22:00:03 INFO - 2015-12-08 22:00:03,430 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:1.10 (1.3%) stddev-sans-first:0.93 22:00:03 INFO - 2015-12-08 22:00:03,430 DEBUG : BROWSER_OUTPUT: Values: 81.0 81.0 83.0 83.0 84.0 83.0 84.0 84.0 83.0 83.0 22:00:03 INFO - 2015-12-08 22:00:03,431 DEBUG : BROWSER_OUTPUT: 22:00:03 INFO - 2015-12-08 22:00:03,431 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.00 Median:122.00 stddev:6.46 (5.3%) stddev-sans-first:6.76 22:00:03 INFO - 2015-12-08 22:00:03,431 DEBUG : BROWSER_OUTPUT: Values: 119.0 118.0 115.0 124.0 119.0 116.0 120.0 136.0 124.0 129.0 22:00:03 INFO - 2015-12-08 22:00:03,431 DEBUG : BROWSER_OUTPUT: 22:00:03 INFO - 2015-12-08 22:00:03,431 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.10 Median:146.50 stddev:4.95 (3.4%) stddev-sans-first:5.13 22:00:03 INFO - 2015-12-08 22:00:03,431 DEBUG : BROWSER_OUTPUT: Values: 141.0 137.0 147.0 146.0 143.0 138.0 150.0 149.0 150.0 140.0 22:00:03 INFO - 2015-12-08 22:00:03,431 DEBUG : BROWSER_OUTPUT: 22:00:03 INFO - 2015-12-08 22:00:03,431 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:0.95 (1.4%) stddev-sans-first:0.88 22:00:03 INFO - 2015-12-08 22:00:03,431 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 68.0 69.0 70.0 69.0 68.0 67.0 69.0 68.0 22:00:03 INFO - 2015-12-08 22:00:03,431 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:00:03 INFO - 2015-12-08 22:00:03,432 DEBUG : BROWSER_OUTPUT: 22:00:04 INFO - 2015-12-08 22:00:04,319 INFO : Browser exited with error code: 0 22:00:04 INFO - 2015-12-08 22:00:04,372 INFO : Completed test kraken (00:01:00) 22:00:04 INFO - 2015-12-08 22:00:04,372 INFO : Starting test v8_7 22:00:04 INFO - 2015-12-08 22:00:04,372 DEBUG : operating with platform_type : linux_ 22:00:04 INFO - 2015-12-08 22:00:04,373 INFO : Initialising browser for v8_7 test... 22:00:04 INFO - 2015-12-08 22:00:04,379 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiunnUz/profile http://localhost:40141/getInfo.html 22:00:08 INFO - 2015-12-08 22:00:08,321 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:00:08 INFO - 2015-12-08 22:00:08,322 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:00:08 INFO - 2015-12-08 22:00:08,322 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:00:08 INFO - 2015-12-08 22:00:08,322 DEBUG : BROWSER_OUTPUT: __metrics 22:00:08 INFO - 2015-12-08 22:00:08,491 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] 22:00:08 INFO - 2015-12-08 22:00:08,547 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:00:09 INFO - 2015-12-08 22:00:09,698 INFO : Browser initialized. 22:00:09 INFO - 2015-12-08 22:00:09,698 INFO : Running cycle 1/1 for v8_7 test... 22:00:09 INFO - 2015-12-08 22:00:09,699 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiunnUz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:00:21 INFO - 2015-12-08 22:00:21,711 DEBUG : BROWSER_OUTPUT: RSS: Main: 143532032 22:00:21 INFO - 2015-12-08 22:00:21,712 DEBUG : BROWSER_OUTPUT: 22:00:43 INFO - 2015-12-08 22:00:43,136 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40141/tests/v8_7/run.html (next: http://localhost:40141/tests/v8_7/run.html) 22:00:43 INFO - 2015-12-08 22:00:43,387 DEBUG : BROWSER_OUTPUT: RSS: Main: 449155072 22:00:43 INFO - 2015-12-08 22:00:43,387 DEBUG : BROWSER_OUTPUT: 22:00:43 INFO - 2015-12-08 22:00:43,389 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:00:43 INFO - 2015-12-08 22:00:43,389 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:00:43 INFO - 2015-12-08 22:00:43,389 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:00:43 INFO - 2015-12-08 22:00:43,389 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:00:43 INFO - 2015-12-08 22:00:43,389 DEBUG : BROWSER_OUTPUT: |0;Richards;165.7000828500414 22:00:43 INFO - 2015-12-08 22:00:43,389 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.83601473153712 22:00:43 INFO - 2015-12-08 22:00:43,390 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.8199943836001 22:00:43 INFO - 2015-12-08 22:00:43,390 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5181.347150259067 22:00:43 INFO - 2015-12-08 22:00:43,390 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2026.3157894736842 22:00:43 INFO - 2015-12-08 22:00:43,390 DEBUG : BROWSER_OUTPUT: |5;Earley;796.1783439490446 22:00:43 INFO - 2015-12-08 22:00:43,390 DEBUG : BROWSER_OUTPUT: |6;Boyer;12108.43373493976 22:00:43 INFO - 2015-12-08 22:00:43,390 DEBUG : BROWSER_OUTPUT: |7;RegExp;26868.42105263158 22:00:43 INFO - 2015-12-08 22:00:43,390 DEBUG : BROWSER_OUTPUT: |8;Splay;600.9615384615385 22:00:43 INFO - 2015-12-08 22:00:43,391 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 22:00:43 INFO - 2015-12-08 22:00:43,391 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:00:43 INFO - 2015-12-08 22:00:43,391 DEBUG : BROWSER_OUTPUT: __startTimestamp1449640843388__endTimestamp 22:00:43 INFO - 2015-12-08 22:00:43,391 DEBUG : BROWSER_OUTPUT: 22:00:43 INFO - 2015-12-08 22:00:43,392 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:00:43 INFO - 2015-12-08 22:00:43,392 DEBUG : BROWSER_OUTPUT: Number of tests: 10 22:00:43 INFO - 2015-12-08 22:00:43,392 DEBUG : BROWSER_OUTPUT: 22:00:43 INFO - 2015-12-08 22:00:43,393 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.70 Median:165.70 stddev:0.00 (0.0%) 22:00:43 INFO - 2015-12-08 22:00:43,394 DEBUG : BROWSER_OUTPUT: Values: 165.7 22:00:43 INFO - 2015-12-08 22:00:43,394 DEBUG : BROWSER_OUTPUT: 22:00:43 INFO - 2015-12-08 22:00:43,394 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.84 Median:193.84 stddev:0.00 (0.0%) 22:00:43 INFO - 2015-12-08 22:00:43,394 DEBUG : BROWSER_OUTPUT: Values: 193.8 22:00:43 INFO - 2015-12-08 22:00:43,394 DEBUG : BROWSER_OUTPUT: 22:00:43 INFO - 2015-12-08 22:00:43,394 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.82 Median:280.82 stddev:0.00 (0.0%) 22:00:43 INFO - 2015-12-08 22:00:43,394 DEBUG : BROWSER_OUTPUT: Values: 280.8 22:00:43 INFO - 2015-12-08 22:00:43,394 DEBUG : BROWSER_OUTPUT: 22:00:43 INFO - 2015-12-08 22:00:43,395 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 22:00:43 INFO - 2015-12-08 22:00:43,395 DEBUG : BROWSER_OUTPUT: Values: 5181.3 22:00:43 INFO - 2015-12-08 22:00:43,395 DEBUG : BROWSER_OUTPUT: 22:00:43 INFO - 2015-12-08 22:00:43,395 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2026.32 Median:2026.32 stddev:0.00 (0.0%) 22:00:43 INFO - 2015-12-08 22:00:43,395 DEBUG : BROWSER_OUTPUT: Values: 2026.3 22:00:43 INFO - 2015-12-08 22:00:43,395 DEBUG : BROWSER_OUTPUT: 22:00:43 INFO - 2015-12-08 22:00:43,395 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:796.18 Median:796.18 stddev:0.00 (0.0%) 22:00:43 INFO - 2015-12-08 22:00:43,395 DEBUG : BROWSER_OUTPUT: Values: 796.2 22:00:43 INFO - 2015-12-08 22:00:43,395 DEBUG : BROWSER_OUTPUT: 22:00:43 INFO - 2015-12-08 22:00:43,395 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12108.43 Median:12108.43 stddev:0.00 (0.0%) 22:00:43 INFO - 2015-12-08 22:00:43,395 DEBUG : BROWSER_OUTPUT: Values: 12108.4 22:00:43 INFO - 2015-12-08 22:00:43,396 DEBUG : BROWSER_OUTPUT: 22:00:43 INFO - 2015-12-08 22:00:43,396 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26868.42 Median:26868.42 stddev:0.00 (0.0%) 22:00:43 INFO - 2015-12-08 22:00:43,396 DEBUG : BROWSER_OUTPUT: Values: 26868.4 22:00:43 INFO - 2015-12-08 22:00:43,396 DEBUG : BROWSER_OUTPUT: 22:00:43 INFO - 2015-12-08 22:00:43,396 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:600.96 Median:600.96 stddev:0.00 (0.0%) 22:00:43 INFO - 2015-12-08 22:00:43,396 DEBUG : BROWSER_OUTPUT: Values: 601.0 22:00:43 INFO - 2015-12-08 22:00:43,396 DEBUG : BROWSER_OUTPUT: 22:00:43 INFO - 2015-12-08 22:00:43,396 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 22:00:43 INFO - 2015-12-08 22:00:43,396 DEBUG : BROWSER_OUTPUT: Values: 4826.9 22:00:43 INFO - 2015-12-08 22:00:43,396 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:00:43 INFO - 2015-12-08 22:00:43,396 DEBUG : BROWSER_OUTPUT: 22:00:44 INFO - 2015-12-08 22:00:44,247 INFO : Browser exited with error code: 0 22:00:44 INFO - 2015-12-08 22:00:44,262 INFO : Completed test v8_7 (00:00:39) 22:00:44 INFO - 2015-12-08 22:00:44,413 INFO : Completed test suite (00:20:17) 22:00:44 INFO - 2015-12-08 22:00:44,413 DEBUG : Working with test: dromaeo_css 22:00:44 INFO - 2015-12-08 22:00:44,413 DEBUG : Generating results file: dromaeo_css 22:00:44 INFO - 2015-12-08 22:00:44,415 DEBUG : Working with test: kraken 22:00:44 INFO - 2015-12-08 22:00:44,415 DEBUG : Generating results file: kraken 22:00:44 INFO - 2015-12-08 22:00:44,415 INFO : javascript benchmark 22:00:44 INFO - 2015-12-08 22:00:44,415 DEBUG : Working with test: v8_7 22:00:44 INFO - 2015-12-08 22:00:44,415 DEBUG : Generating results file: v8_7 22:00:44 INFO - 2015-12-08 22:00:44,416 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:00:44 INFO - 2015-12-08 22:00:44,570 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 22:00:44 INFO - 2015-12-08 22:00:44,571 DEBUG : process_Request line: dromaeo_css 6187.40 graph.html#tests=[[72,132,35]] 22:00:44 INFO - 2015-12-08 22:00:44,571 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:00:44 INFO - 2015-12-08 22:00:44,743 DEBUG : process_Request line: kraken 1516.00 graph.html#tests=[[232,132,35]] 22:00:44 INFO - 2015-12-08 22:00:44,743 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:00:44 INFO - 2015-12-08 22:00:44,868 DEBUG : process_Request line: v8_7 19687.91 graph.html#tests=[[230,132,35]] 22:00:44 INFO - 2015-12-08 22:00:44,869 INFO : javascript benchmark 22:00:44 INFO - 2015-12-08 22:00:44,872 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2651.1118775210302, 2725.332293588071, 2728.1951824211856, 2741.9862900685494, 2757.1315035763732, 4460.130274596455, 4578.267477203648, 4692.366530518379, 4728.078024785168, 4728.40894888139, 4508.54914508549, 4583.564561366665, 4647.395838540985, 4652.32541281514, 4656.208444564424, 4323.956760432403, 4336.544662810406, 4338.327559228309, 4359.3025115981445, 4376.518582955872, 4186.6022727840955, 4399.42807435033, 4403.823847046115, 4444.777761111947, 4453.064856380164, 4240.342746874239, 4301.483821941356, 4321.308590625485, 4323.848665296699, 4345.804438800262, 4292.871213863589, 4293.334533147367, 4318.52496225415, 4324.610785029363, 4333.804978775963, 4291.6566674665955, 4294.4202532658, 4294.935575966363, 4314.482262128533, 4340.587644173798, 4424.977875110636, 4502.347159661831, 4521.502634710179, 4521.570450807168, 4694.788734506921, 5078.847634570969, 5093.643444958854, 5122.948770512322, 5122.974385128051, 5137.61467889906, 5117.641765076446, 5124.92312615311, 5143.768530416103, 5150.48495150482, 5150.587952963754, 4455.754933478657, 4545.272756359, 4547.863564093016, 4670.136024835417, 4815.085133824562, 5197.298364720715, 5254.448282930313, 5257.447967963385, 5259.421463638997, 5264.052470555337, 5026.246063090565, 5046.949530504648, 5051.646384753106, 5055.241713742968, 5094.847154585368, 4863.051704917507, 4966.180580204298, 4967.3294105296045, 4968.527989840959, 5044.0920634286185, 5008.474110218374, 5009.624278179152, 5011.047900898818, 5021.447640759514, 5024.221245706848, 4981.775820088104, 4990.0269447457395, 4995.050940321327, 4999.725015124131, 5038.1183292924325, 4020.638142567183, 4054.8986275343354, 4104.692148088905, 4203.47456567929, 4243.766592837424, 3620.945685814715, 3667.4865518827387, 3697.6117507661306, 3714.7771133732062, 3729.179580492287, 4332.631726303236, 4341.3487976803735, 4344.45694288214, 4345.174416860849, 4381.84663536781, 4862.270659401118, 5077.314562534085, 5082.771275292621, 5087.720175390315, 5092.490750924952, 4224.028473451123, 4274.7435153890865, 4281.400603915455, 4285.014446677282, 4296.677749168824, 4454.10917816438, 4488.753118578509, 4505.166544189336, 4508.639308855284, 4527.818887244539, 4764.213904705684, 4793.304970779148, 4801.7118972861745, 4804.8798780030775, 4836.202026665561, 4842.951570484391, 4956.851294461172, 4963.03220871941, 4982.975085124696, 5051.4695956924, 4796.088743138793, 4798.640101992295, 4806.951930480651, 4823.445303790109, 4847.345608342828, 4994.200927851526, 5005.274235235943, 5006.799728010985, 5012.248162775612, 5016.272640467038, 4783.856484305476, 4843.564079232745, 4892.241702536113, 4916.803327866845, 5101.056304583664, 4898.4121905371585, 4899.608031357411, 4904.166291730486, 4912.0, 4937.308776771327, 4897.755112244445, 4899.118158731462, 4904.705717656952, 4907.043126590281, 4933.703977761345, 4538.523455037305, 4715.6227501799085, 4726.385569875894, 4738.455077666113, 4854.68444551103, 4956.628252880976, 4974.7512624369365, 4976.776045078052, 4978.502149784992, 4998.950010499994, 4859.416869975626, 4859.805607775791, 4861.95138048615, 4867.342908707279, 4903.583195428429], "unit": "ms", "name": "dojo.html", "value": 4609.625650314442}, {"lowerIsBetter": false, "replicates": [536.1582315764249, 542.8816637726284, 544.8991936491749, 546.5627498001597, 548.7996881138383, 26252.0, 27477.862610686967, 35335.0, 35556.2888742225, 35676.286474270564, 39394.21211575767, 39562.8021859891, 39658.60341396585, 39802.203955920864, 39852.601473985254, 6876.346747059021, 6953.304669533057, 7632.542047477155, 7800.258975397356, 7853.2539408756365, 9921.15670168033, 10194.9490252549, 10208.285420020602, 10210.387376757419, 10210.795784084314, 9883.0, 9970.302078854484, 9991.500424978758, 10000.2499812514, 10002.299839011272, 7093.751718689847, 7297.781066567958, 9852.80294394108, 9875.851862222073, 10252.436116013616, 9774.120329170337, 9911.702648920473, 9914.90085099147, 9916.553755081039, 9918.851217231748, 36234.094147646254, 36585.45121823175, 36647.267054658754, 36657.26685466302, 36724.0, 2812.9296767580768, 2832.985835070832, 2879.6688380836263, 2944.4994350960387, 3429.7599168058246, 27723.861380693168, 27735.445291094064, 28147.859260703564, 28247.717522824918, 28295.575566366522, 3390.6609339066144, 3434.9656503434894, 3439.79361238324, 3500.824958752052, 3552.0231936217488, 213197.0, 213722.0, 213941.93029034912, 214231.0, 215259.0, 47841.0, 49365.50634493681, 51731.48268517342, 51976.740116299174, 52078.0, 61542.38457615456, 62330.0, 62348.688256558424, 62352.0, 62607.0, 12630.052746044083, 12805.359732013549, 12862.935685321514, 12867.54963576289, 12886.097973141977, 9034.503102329303, 9085.682001129928, 9130.360874738837, 9140.6800761973, 9149.359544831797, 17556.209970551357, 17896.46310610684, 17966.550836228937, 17994.280228790703, 18005.549861253574, 7191.820204494929, 7381.11426628808, 7440.85118297631, 7460.85078298431, 7562.584057876869, 812.9268365846984, 829.4318391901567, 838.4591938199827, 869.2007544383192, 972.2902281334524, 24319.756802432104, 24489.877550612488, 24701.135460258804, 24758.25725228246, 25591.360215994748, 848.117957324388, 966.2752935298527, 967.1730670276953, 990.5592011554933, 1018.0582960761266, 11377.715557110972, 11687.517707230603, 11940.521631668651, 11942.24675661131, 11970.849587668523, 252812.0, 254419.0, 257905.0, 258147.0, 258427.0, 43750.12499749987, 44120.0, 44120.0, 44181.337279940184, 44266.33600495995, 1045.0646671229208, 1076.0907033556632, 1083.5557421457165, 1212.8180772883961, 1239.3741160713782, 23128.6530702043, 23939.401514962265, 24293.392665183514, 25871.48257034811, 27932.44135117327, 36834.26331473302, 39892.401613975235, 40271.0, 40280.1943961125, 40333.798331008154, 140649.0, 340385.0, 343568.0, 346351.0, 347706.0, 27455.45089098247, 28098.719012810427, 28099.71900281053, 28143.718562814927, 28167.0, 38321.80839095786, 38693.0, 39445.80277098596, 39447.60552394554, 39550.80224598858, 28527.42945141044, 29340.266493337836, 29560.260993475335, 29564.852175738983, 31078.067657970296, 30934.845325773225, 32605.0, 32634.0, 32790.34419311648, 32846.0, 31877.36245275128, 33146.50280245847, 33519.83240083784, 33540.1614959628, 33668.49497257592, 24847.378815529035, 26919.461610767285, 26939.461210775284, 26965.595516066882, 27368.315792105357, 22680.319590412313, 23026.0, 23208.071677132724, 23551.29346119619, 23590.764092359543], "unit": "ms", "name": "ext.html", "value": 16684.168784375746}, {"lowerIsBetter": false, "replicates": [280.988760449582, 281.48628752526645, 283.3497124100191, 283.7616402222133, 283.981541199822, 11137.610183643574, 15154.696906061887, 15573.14347710874, 15593.688126237483, 16402.917985410088, 9329.953350233256, 9490.952545237264, 9560.42637441754, 15675.60810979726, 16006.83993160068, 4350.608445239928, 4477.708948918326, 4480.215962206617, 4486.685931984763, 4508.842190523333, 4482.798274077658, 4510.323451482271, 4513.571210734991, 4518.344839998198, 4520.706154099973, 3373.1735724747473, 3484.1463841358905, 3488.337215928978, 4489.393931819195, 4497.685162038642, 3473.253250551131, 3482.0424383294544, 4886.535779100962, 5046.621503387224, 5071.036503064406, 4811.446683631392, 4838.443578988391, 4887.486813884527, 4898.044881248158, 4995.675281106716, 17702.0, 17811.910940445345, 17869.553261168443, 19789.208431662715, 19801.207951681914, 1791.9820801791946, 1853.5180852978187, 1876.024467277022, 1888.5278680329918, 1916.2335065973582, 8677.522736249504, 8895.243904268145, 8899.243564297043, 10045.347052441568, 12823.166494177942, 1727.0587529796292, 1740.651869626067, 1790.7224380221087, 1795.6139430022477, 1803.161529888595, 56571.43428565703, 58879.116813247834, 59122.0, 59472.0, 59518.702406488126, 9380.0, 9578.952105239568, 9591.9040809591, 9695.127438530566, 9775.217982561378, 12342.0, 12372.690682733004, 12403.13178077544, 12430.192037517714, 12430.316332601793, 6319.0, 6374.936250637527, 6415.13395691585, 6418.711157997901, 6554.967225163844, 6025.216721826135, 6079.939200607937, 6093.0, 6139.938600614026, 6145.293291271561, 4046.5548789633117, 4071.694622903294, 4145.523264824524, 4168.916621667549, 4176.644985176294, 1659.402615058578, 1672.7323628219426, 1689.1723055702616, 1697.3380381651166, 1703.1058694185651, 718.7268837841586, 724.6557885004686, 765.8698021336386, 802.4783890471241, 899.5142622983647, 12898.290594017231, 14884.181370024537, 16022.599435014217, 16202.270897809627, 16367.181640917906, 814.8981377327834, 840.7393707950555, 858.9012263589767, 887.4719541872704, 914.9222316103072, 7673.34776544, 8006.519608823489, 8018.358531317481, 8829.64681412749, 9378.390404623678, 481633.0, 481962.0, 482528.0, 485687.0, 486323.0, 71260.64369678119, 74296.0, 74425.62787186138, 74434.6278268616, 74689.62655186799, 1079.4063265204106, 1079.681493959284, 1083.9403832789271, 1085.8425528298353, 1090.6128324444867, 14573.489927852474, 14577.0, 14689.943407922685, 14793.11241325524, 14989.77515337249, 34360.31279374449, 34545.82727086348, 34551.13622159365, 34670.65329346674, 35197.0, 45465.0, 45697.77151114356, 45833.0, 47523.0, 49695.751521242164, 8472.322214222972, 8479.668091274949, 8624.310055195694, 8875.378723489552, 9055.683051093443, 14412.351444184827, 14501.347439365465, 15615.687686245985, 16536.338546458006, 16591.0, 12642.620721378373, 12693.238405695687, 12774.744505110031, 12821.807672885101, 13084.149530280501, 4579.977100114611, 7800.453968222397, 9620.326577139533, 12237.510499579917, 13163.670908226988, 12193.756124877631, 12323.815142773044, 12510.562130325396, 13866.514671986431, 13874.445022199, 8593.785155371166, 8730.432521886058, 8755.649774009224, 8825.470471771714, 8850.20348168668, 12482.375881206084, 12805.743885122432, 12970.092093553738, 13092.410841511964, 13395.12931659439], "unit": "ms", "name": "jquery.html", "value": 7878.434741377506}, {"lowerIsBetter": false, "replicates": [1420.3395421129173, 1630.6983208106499, 1687.5696697342175, 1711.4608898197066, 1724.4050802473143, 6012.699365031747, 7036.612986285752, 7113.324234197749, 7124.643767811602, 7125.180604230515, 6987.720491180359, 7172.390346820526, 7185.532940358873, 7188.353048225658, 7205.279472052805, 1707.7011522983491, 1717.3731587970426, 1733.514615907548, 2047.3653167518044, 2084.7289852319177, 1769.5222289981698, 1774.7071733164012, 2034.7354843870276, 2082.802133797287, 2086.1238279922395, 1998.2406685459505, 2052.7844576319494, 2061.2991582861823, 2062.8762274263518, 2063.1850419084453, 1999.5800881814837, 2016.747906511686, 2019.4648418169197, 2019.5556977464935, 2020.9898950505226, 2032.7357443532246, 2067.6174907642135, 2083.427057559168, 2083.802038806311, 2084.4997200671883, 7073.328033836778, 7125.0, 7149.928500714978, 7158.713651453935, 7161.427085833121, 4069.267531844267, 4121.505419349697, 4127.153933443667, 4133.524644665872, 4133.7106402551835, 2664.267326485213, 2677.089789471589, 2726.672799264101, 2739.849308288043, 2741.7121202273674, 849.6346570974479, 857.5069335132324, 857.9871301930476, 858.5063588436611, 875.7504111328241, 9727.173190278834, 9739.074787895139, 9739.464329461876, 9745.707628771148, 9767.316287859852, 3785.2618739346112, 3802.866899658554, 3869.613038696164, 3886.203328317688, 3892.3772196449, 8169.060558035783, 8216.794580135544, 8222.301104406073, 8227.259546640831, 8230.21812927771, 4228.1966426378885, 4240.088380998101, 4240.38514415408, 4241.151769646083, 4248.362745588125, 3835.7314987950576, 3860.1700634363747, 3861.2084522672785, 3861.7103717220757, 3870.1098747288283, 2910.89811856584, 3344.364570731602, 3365.9326813463595, 3396.541466901986, 3406.8126253055825, 939.8637197606308, 952.9190018848337, 954.1126752120595, 954.2366107114419, 1058.4599407861542, 787.047672316492, 795.4034474144391, 798.0861913109458, 882.2280504558511, 923.8660394242931, 6596.274409814917, 6657.300983396771, 6664.96667516669, 6666.866662666816, 6670.232923213893, 995.6664517386612, 995.7759504111517, 1003.3578509753618, 1020.2908978260186, 1026.6765968719978, 5077.568406685473, 5204.609654275944, 5210.322658054429, 5216.817411390583, 5236.24074509194, 7878.803029924183, 7941.086775020831, 8167.959160204161, 8182.877256841152, 8191.221833925768, 8088.797780055428, 8111.878321825177, 8139.186081391932, 8151.062627797761, 8153.551554664432, 6556.918108512137, 6570.310117437601, 6583.736650534021, 6598.439132673777, 6605.372489613479, 6098.11577321277, 6227.813165605039, 6235.46998505114, 6244.469220116341, 6249.437550620466, 7228.385587225145, 7262.745803896838, 7384.778456646309, 7402.814929626587, 7429.925700742923, 7508.2867127622785, 7542.773716788505, 7549.245075492407, 7570.205128461653, 7741.109772376023, 6033.698315084316, 6094.75620975156, 6094.969525152346, 6097.512199023979, 6097.573169878244, 6414.775482858077, 6456.354364563506, 6488.772892948724, 6497.577657452251, 6505.512086593619, 6074.483668888194, 6162.845928851814, 6192.225971753531, 6226.688665566794, 6275.592086514362, 5563.693996830213, 5752.942470575241, 6230.345813689497, 6258.812235632939, 6262.248530176408, 6310.05349197624, 6342.270638876588, 6358.268799088164, 6361.904571431525, 6365.14070600463, 5630.0428927081675, 5640.802571909963, 5659.236003139688, 5665.631733937281, 5675.7445914933105, 5806.042003069446, 5828.417158284137, 5860.619059761102, 5869.383714709894, 5883.352831188651], "unit": "ms", "name": "mootools.html", "value": 3972.311823032388}, {"lowerIsBetter": false, "replicates": [257.4362146898293, 261.07188943306545, 261.808879517952, 263.43624643263405, 266.8265627342227, 5351.501579557726, 5411.161270003151, 5425.565954723617, 5433.673979561229, 5446.15584584389, 5086.313347698059, 5276.472352764722, 5279.683219006853, 5281.128613778731, 5296.92054619181, 3812.8474861005525, 3913.4716813230275, 3919.7060220483436, 3926.725129240954, 3958.8812335629905, 4008.759474431529, 4028.4964379452567, 4031.173609410064, 4033.2336855997414, 4039.555648878621, 3967.841286348543, 3972.0268534209013, 3975.1056012397266, 3978.641922226999, 3983.4821473208444, 3723.590405055442, 3844.596317386662, 3876.4379165021196, 3967.0875698589343, 3991.1618560102415, 3400.523926650271, 3412.7611067225303, 3417.6753208445157, 3420.4185288500767, 3425.6231814500384, 5109.335786347751, 5110.3356563646485, 5123.077845987721, 5129.6409251352425, 5137.357830271216, 4524.660650451229, 4566.13243483737, 4569.748663823489, 4572.634189264851, 4574.4968053514085, 5417.945820541783, 5537.252470916455, 5544.944550554484, 5550.5282051025715, 5565.0, 3689.3912504436735, 3694.07648087978, 3710.7216958728204, 3710.7588006779474, 3717.3494638438165, 5794.797182098649, 5872.354041055481, 5880.882382352329, 5881.5882888198275, 5884.911726324109, 3812.942805857914, 3815.8664446744233, 3821.3503704370323, 3823.3882578787816, 3827.9090459218987, 3576.5171701819922, 3623.6376362363553, 3870.9806450967567, 3875.6511913927884, 3882.5535063467496, 4339.479262488521, 4392.890177745582, 4407.0, 4530.161920044802, 4536.523665015192, 5603.355614104348, 5603.411641777636, 5604.663720176803, 5611.298587676541, 5612.635178713453, 1343.770450038204, 1358.4769863602585, 1359.0, 1359.232033900843, 1360.4626172661742, 867.1588559097665, 878.5914549734404, 893.4371346051946, 893.5487578772678, 896.6010125494092, 4918.139325618003, 4924.901501969941, 4927.310176575283, 4928.67963582366, 4937.456879743226, 5832.650040997553, 5840.269966254218, 5840.678762668094, 5841.2990441146485, 5843.094320380348, 4897.755112244374, 4905.092557876804, 4906.656534042654, 4910.508949105061, 4916.852494425173, 3058.1131471873355, 3103.332783451569, 3111.471049921519, 3117.766167537444, 3152.1489197916435, 5489.615726899158, 5518.227448157181, 5520.171974203821, 5566.332040155207, 5570.053090974544, 6018.668973206516, 6026.186464827279, 6031.788887388921, 6033.3966603340195, 6043.244594425697, 5556.99974004683, 5558.9715902558155, 5560.249366335493, 5565.193047008162, 5574.358948720868, 5705.144228365778, 5874.206982057368, 5882.617629854046, 5887.646741195371, 5894.440028197314, 5741.971290143522, 5747.252857128547, 5750.913736293875, 5752.856178595569, 5754.05058165398, 5544.556435485232, 5550.0, 5552.194931734956, 5555.0, 5555.972220138873, 3731.9067023324633, 3779.981100094592, 3821.5605205401735, 3826.7512611680154, 3832.4251362295877, 5646.153077038312, 5773.711314434346, 5857.384974577608, 5863.501602363847, 5881.647101173943, 5528.585356098389, 5560.6107572471155, 5563.304586926634, 5566.387697353207, 5576.442355764391, 5643.858903527444, 5658.85852853682, 5670.801521946877, 5674.319081710056, 5674.943250567607, 5395.514403703685, 5537.446255374592, 5537.750801214036, 5540.63985840919, 5543.0, 5702.971485142548, 5707.5433965281845, 5708.086706127, 5710.229119068873, 5721.342045664802, 5561.082421400423, 5582.0231459495235, 5586.832395028156, 5594.1608758686525, 5595.300587426572], "unit": "ms", "name": "prototype.html", "value": 4121.469963227875}, {"lowerIsBetter": false, "replicates": [649.7043845050503, 678.2945736434109, 777.9883301750475, 791.216695471483, 801.8207806049014, 12007.75984480311, 12021.15851890368, 12046.939765301184, 12049.277043377404, 12086.879131208685, 11695.532178712841, 11779.116566257522, 13079.084464087518, 13379.665508362295, 13389.66525836852, 621.8321053315602, 788.7121200761709, 802.4423025996934, 804.1596531624466, 804.3565147881701, 627.0500192208807, 799.3245707377257, 813.8290958898639, 814.7433558429076, 815.4088285992638, 824.1305422778996, 839.1985653700701, 840.3109450250766, 840.9369297302696, 842.7050532313702, 643.3952085040047, 649.3084864619166, 824.4270232188632, 833.7748807821885, 835.7283882738104, 610.322541978408, 615.8337248942761, 615.8368032471399, 615.9076138579204, 617.1267656266377, 12494.187877787916, 12541.686457838536, 12544.623661290085, 12587.307698076602, 12602.558910438182, 10562.630307939262, 10836.133109351233, 10849.620263290746, 10939.781204375868, 11985.400729963554, 8648.827023459495, 9152.267818574499, 9194.35639505235, 9346.439213647134, 9354.017828128084, 3104.9534256986162, 3112.37752449511, 3140.262038420969, 3157.842107894596, 3164.889228877001, 38905.0, 39426.605733942866, 39830.60169398298, 39848.20303593912, 40079.39880901789, 9179.357444978921, 9255.074492550826, 9262.53687315645, 9571.0, 9586.712398628053, 15908.363665453253, 15937.681246375008, 16095.919520402324, 16123.677526449404, 16151.273192706356, 6491.805245842632, 6507.934920650828, 6589.275179730226, 6603.867922641521, 6608.603483790988, 3631.9818400907825, 3668.523091998023, 3692.963070369262, 3695.8706445274825, 3709.6104908984166, 2597.5584150694426, 2624.527585034712, 2628.7896968242494, 2629.198094581133, 2632.526145293827, 460.8502236773062, 467.38538821449686, 471.4554689333825, 471.9805220723221, 490.0101794375342, 571.2573654249459, 596.5257620191958, 601.9819405417844, 619.9628022318675, 621.1521273461692, 7123.323284287984, 7218.6390680465765, 7409.629518524052, 7651.3496352810635, 8798.164174403422, 487.2082865343816, 543.9129739241781, 550.5265471694339, 598.317917573966, 605.5155875299743, 3467.6532346765625, 3530.1704099536587, 3886.2810380079777, 4024.854399968038, 4073.429719839225, 46043.0, 46937.29594056092, 46946.0, 47182.29226561535, 47191.76404117957, 43388.56611433908, 43849.34225986613, 44166.0, 44253.55746442559, 44332.77833610876, 38644.227115457536, 38702.80648596739, 38759.61240387616, 39104.0, 39440.0, 8004.83990320202, 8040.557769322743, 8060.15368386311, 8234.300084492646, 8324.125966773401, 30332.84833575818, 30533.694663053084, 30555.0, 30943.381132377675, 31048.84475577698, 34884.82557587196, 35145.29709405747, 35488.645113549566, 38790.41814372843, 38936.80531597324, 9541.141297283279, 9745.561449734922, 9904.950475247577, 9986.500674966368, 10242.078212960869, 10445.9477702611, 10460.738481538023, 10472.162227021972, 10573.471326433493, 10692.839607406051, 10145.391276523433, 10504.789904202025, 10526.368119630828, 10679.0, 10832.945835270773, 10507.084042733304, 10747.516361763895, 10753.13974881992, 10790.514426850968, 10878.292910960763, 7428.517146385468, 9728.221742260745, 9870.259730520096, 10012.148967337567, 10132.544035518273, 8883.73348799537, 9337.953310233677, 9386.624535018524, 9607.711768646952, 9889.109980101824, 7694.269044440769, 8838.734837954615, 9167.816643667224, 9215.86176207344, 9318.767030824283], "unit": "ms", "name": "yui.html", "value": 5655.8747424303265}], "name": "dromaeo_css", "value": 6187.404694218548}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 106.0, 112.0, 112.0, 114.0, 107.0, 114.0, 115.0, 119.0], "unit": "ms", "name": "ai-astar", "value": 112.2}, {"lowerIsBetter": true, "replicates": [151.0, 137.0, 155.0, 167.0, 129.0, 151.0, 151.0, 132.0, 174.0, 134.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.1}, {"lowerIsBetter": true, "replicates": [160.0, 159.0, 158.0, 160.0, 160.0, 159.0, 160.0, 161.0, 161.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 159.9}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 82.0, 92.0, 71.0, 79.0, 71.0, 111.0, 93.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 81.2}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 136.0, 94.0, 94.0, 95.0, 132.0, 94.0, 94.0, 131.0], "unit": "ms", "name": "audio-oscillator", "value": 105.8}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 109.0, 110.0, 109.0, 111.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 150.0, 145.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 72.0, 73.0, 72.0, 72.0, 73.0, 71.0, 73.0, 72.0], "unit": "ms", "name": "json-parse-financial", "value": 72.1}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 69.0, 67.0, 69.0, 68.0, 68.0, 68.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 83.0, 83.0, 84.0, 83.0, 84.0, 84.0, 83.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.9}, {"lowerIsBetter": true, "replicates": [119.0, 118.0, 115.0, 124.0, 119.0, 116.0, 120.0, 136.0, 124.0, 129.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.0}, {"lowerIsBetter": true, "replicates": [141.0, 137.0, 147.0, 146.0, 143.0, 138.0, 150.0, 149.0, 150.0, 140.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.1}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 68.0, 69.0, 70.0, 69.0, 68.0, 67.0, 69.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1516.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.7000828500414], "unit": "score", "name": "Richards", "value": 213.04756999999998}, {"lowerIsBetter": false, "replicates": [193.83601473153712], "unit": "score", "name": "DeltaBlue", "value": 341.1027619999999}, {"lowerIsBetter": false, "replicates": [280.8199943836001], "unit": "score", "name": "Encrypt", "value": 947.8705409999999}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [2026.3157894736842], "unit": "score", "name": "RayTrace", "value": 365.18937662337675}, {"lowerIsBetter": false, "replicates": [796.1783439490446], "unit": "score", "name": "Earley", "value": 837.077528}, {"lowerIsBetter": false, "replicates": [12108.43373493976], "unit": "score", "name": "Boyer", "value": 55.0412228855721}, {"lowerIsBetter": false, "replicates": [26868.42105263158], "unit": "score", "name": "RegExp", "value": 33.90541625857002}, {"lowerIsBetter": false, "replicates": [600.9615384615385], "unit": "score", "name": "Splay", "value": 135.60102399999994}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 19687.908315456407}]} 22:00:44 INFO - RETURN: dromaeo_css: 6187.40 22:00:44 INFO - RETURN: kraken: 1516.00 22:00:44 INFO - RETURN: v8_7: 19687.91 22:00:44 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19687.91"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1516.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6187.40"}}} 22:00:44 INFO - Return code: 0 22:00:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:00:44 INFO - # TBPL SUCCESS # 22:00:44 INFO - Running post-action listener: _resource_record_post_action 22:00:44 INFO - Running post-run listener: _resource_record_post_run 22:00:46 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 28672; Write bytes: 520646656; Read time: 48; Write time: 532456 22:00:46 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 243216384; Read time: 0; Write time: 390532 22:00:46 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 28672; Write bytes: 276267008; Read time: 48; Write time: 141896 22:00:46 INFO - Running post-run listener: _upload_blobber_files 22:00:46 INFO - Blob upload gear active. 22:00:46 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 22:00:46 INFO - Copying logs to upload dir... 22:00:46 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1269.598494 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-08 22:00:45.876933) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-08 22:00:45.880810) ========= 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-1449630435.624719-1655294267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/WrdCcC-cRi6N7fuFTVRdgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009409 build_url: 'https://queue.taskcluster.net/v1/task/WrdCcC-cRi6N7fuFTVRdgw/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-08 22:00:45.929184) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 22:00:45.929529) ========= 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-1449630435.624719-1655294267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004565 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 22:00:45.979756) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-08 22:00:45.980246) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-08 22:00:45.980735) ========= ========= Total master_lag: 1.81 =========