builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-027 starttime: 1449166859.28 results: success (0) buildid: 20151203092422 builduid: bb4c80b8574941058091bda4c91e1ae6 revision: 4c9ca7614d701d28549ef734d41dcce5ac37cba2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 10:20:59.283591) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 10:20:59.284133) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 10:20:59.284436) ========= 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=447a3abc0420b6a47dd38cba000001bf-1449166858.627147-1782568763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004355 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 10:20:59.302060) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 10:20:59.302383) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 10:20:59.314538) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 10:20:59.314945) ========= 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=447a3abc0420b6a47dd38cba000001bf-1449166858.627147-1782568763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004525 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 10:20:59.364202) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 10:20:59.364584) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 10:20:59.365013) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 10:20:59.365325) ========= 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=447a3abc0420b6a47dd38cba000001bf-1449166858.627147-1782568763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-03 10:20:59-- 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% 224M=0s 2015-12-03 10:20:59 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.186562 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 10:20:59.564445) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 10:20:59.564783) ========= 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=447a3abc0420b6a47dd38cba000001bf-1449166858.627147-1782568763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018185 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 10:20:59.615115) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 10:20:59.615472) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4c9ca7614d701d28549ef734d41dcce5ac37cba2 --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 4c9ca7614d701d28549ef734d41dcce5ac37cba2 --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=447a3abc0420b6a47dd38cba000001bf-1449166858.627147-1782568763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-03 10:20:59,737 truncating revision to first 12 chars 2015-12-03 10:20:59,737 Setting DEBUG logging. 2015-12-03 10:20:59,737 attempt 1/10 2015-12-03 10:20:59,738 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4c9ca7614d70?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-03 10:21:00,068 unpacking tar archive at: fx-team-4c9ca7614d70/testing/mozharness/ program finished with exit code 0 elapsedTime=0.617464 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 10:21:00.247026) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 10:21:00.247584) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 10:21:00.256736) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 10:21:00.257239) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 10:21:00.257726) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-12-03 10:21:00.258041) ========= /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=447a3abc0420b6a47dd38cba000001bf-1449166858.627147-1782568763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:21:00 INFO - MultiFileLogger online at 20151203 10:21:00 in /builds/slave/test 10:21:00 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 10:21:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:21:00 INFO - {'append_to_log': False, 10:21:00 INFO - 'base_work_dir': '/builds/slave/test', 10:21:00 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:21:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:21:00 INFO - 'branch': 'Fx-Team-Non-PGO', 10:21:00 INFO - 'buildbot_json_path': 'buildprops.json', 10:21:00 INFO - 'config_files': ('talos/linux_config.py',), 10:21:00 INFO - 'default_actions': ('clobber', 10:21:00 INFO - 'read-buildbot-config', 10:21:00 INFO - 'download-and-extract', 10:21:00 INFO - 'populate-webroot', 10:21:00 INFO - 'create-virtualenv', 10:21:00 INFO - 'install', 10:21:00 INFO - 'run-tests'), 10:21:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:21:00 INFO - 'download_minidump_stackwalk': True, 10:21:00 INFO - 'download_symbols': 'ondemand', 10:21:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:21:00 INFO - 'tooltool.py': '/tools/tooltool.py', 10:21:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:21:00 INFO - '/tools/misc-python/virtualenv.py')}, 10:21:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:21:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:21:00 INFO - 'installer_path': 'installer.exe', 10:21:00 INFO - 'log_level': 'info', 10:21:00 INFO - 'log_name': 'talos', 10:21:00 INFO - 'log_to_console': True, 10:21:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:21:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:21:00 INFO - 'opt_config_files': (), 10:21:00 INFO - 'pip_index': False, 10:21:00 INFO - 'sps_profile': False, 10:21:00 INFO - 'sps_profile_interval': 0, 10:21:00 INFO - 'suite': 'dromaeojs', 10:21:00 INFO - 'system_bits': '64', 10:21:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:21:00 INFO - 'title': 'talos-linux64-ix-027', 10:21:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:21:00 INFO - 'use_talos_json': True, 10:21:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:21:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:21:00 INFO - 'work_dir': 'build'} 10:21:00 INFO - ##### 10:21:00 INFO - ##### Running clobber step. 10:21:00 INFO - ##### 10:21:00 INFO - Running pre-action listener: _resource_record_pre_action 10:21:00 INFO - Running main action method: clobber 10:21:00 INFO - rmtree: /builds/slave/test/build 10:21:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:21:00 INFO - Running post-action listener: _resource_record_post_action 10:21:00 INFO - ##### 10:21:00 INFO - ##### Running read-buildbot-config step. 10:21:00 INFO - ##### 10:21:00 INFO - Running pre-action listener: _resource_record_pre_action 10:21:00 INFO - Running main action method: read_buildbot_config 10:21:00 INFO - Using buildbot properties: 10:21:00 INFO - { 10:21:00 INFO - "properties": { 10:21:00 INFO - "buildnumber": 2182, 10:21:00 INFO - "product": "firefox", 10:21:00 INFO - "script_repo_revision": "production", 10:21:00 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:21:00 INFO - "repository": "", 10:21:00 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 10:21:00 INFO - "buildid": "20151203092422", 10:21:00 INFO - "slavename": "talos-linux64-ix-027", 10:21:00 INFO - "pgo_build": "False", 10:21:00 INFO - "basedir": "/builds/slave/test", 10:21:00 INFO - "project": "", 10:21:00 INFO - "platform": "ubuntu64_hw", 10:21:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:21:00 INFO - "slavebuilddir": "test", 10:21:00 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:21:00 INFO - "branch": "fx-team", 10:21:00 INFO - "repo_path": "integration/fx-team", 10:21:00 INFO - "stage_platform": "linux64", 10:21:00 INFO - "builduid": "bb4c80b8574941058091bda4c91e1ae6", 10:21:00 INFO - "revision": "4c9ca7614d701d28549ef734d41dcce5ac37cba2" 10:21:00 INFO - }, 10:21:00 INFO - "sourcestamp": { 10:21:00 INFO - "repository": "", 10:21:00 INFO - "hasPatch": false, 10:21:00 INFO - "project": "", 10:21:00 INFO - "branch": "fx-team-linux64-talos", 10:21:00 INFO - "changes": [ 10:21:00 INFO - { 10:21:00 INFO - "category": null, 10:21:00 INFO - "files": [ 10:21:00 INFO - { 10:21:00 INFO - "url": null, 10:21:00 INFO - "name": "https://queue.taskcluster.net/v1/task/5xnCYh_UQbycxpOtMwk46w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 10:21:00 INFO - } 10:21:00 INFO - ], 10:21:00 INFO - "repository": "", 10:21:00 INFO - "rev": "4c9ca7614d701d28549ef734d41dcce5ac37cba2", 10:21:00 INFO - "who": "pbrosset@mozilla.com", 10:21:00 INFO - "when": 1449166500, 10:21:00 INFO - "number": 6740045, 10:21:00 INFO - "comments": "Bug 1230093 - Make the import-headjs-globals rule store variables correctly; r=Mossop", 10:21:00 INFO - "project": "", 10:21:00 INFO - "at": "Thu 03 Dec 2015 10:15:00", 10:21:00 INFO - "branch": "fx-team-linux64-talos", 10:21:00 INFO - "revlink": "", 10:21:00 INFO - "properties": [ 10:21:00 INFO - [ 10:21:00 INFO - "buildid", 10:21:00 INFO - "20151203092422", 10:21:00 INFO - "Change" 10:21:00 INFO - ], 10:21:00 INFO - [ 10:21:00 INFO - "builduid", 10:21:00 INFO - "bb4c80b8574941058091bda4c91e1ae6", 10:21:00 INFO - "Change" 10:21:00 INFO - ], 10:21:00 INFO - [ 10:21:00 INFO - "pgo_build", 10:21:00 INFO - "False", 10:21:00 INFO - "Change" 10:21:00 INFO - ] 10:21:00 INFO - ], 10:21:00 INFO - "revision": "4c9ca7614d701d28549ef734d41dcce5ac37cba2" 10:21:00 INFO - } 10:21:00 INFO - ], 10:21:00 INFO - "revision": "4c9ca7614d701d28549ef734d41dcce5ac37cba2" 10:21:00 INFO - } 10:21:00 INFO - } 10:21:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/5xnCYh_UQbycxpOtMwk46w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 10:21:00 INFO - Running post-action listener: _resource_record_post_action 10:21:00 INFO - ##### 10:21:00 INFO - ##### Running download-and-extract step. 10:21:00 INFO - ##### 10:21:00 INFO - Running pre-action listener: _resource_record_pre_action 10:21:00 INFO - Running main action method: download_and_extract 10:21:00 INFO - mkdir: /builds/slave/test/build/tests 10:21: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')]} 10:21:00 INFO - https://queue.taskcluster.net/v1/task/5xnCYh_UQbycxpOtMwk46w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:21:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5xnCYh_UQbycxpOtMwk46w/artifacts/public/build/test_packages.json 10:21:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5xnCYh_UQbycxpOtMwk46w/artifacts/public/build/test_packages.json 10:21:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5xnCYh_UQbycxpOtMwk46w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 10:21:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5xnCYh_UQbycxpOtMwk46w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 10:21:01 INFO - Downloaded 1302 bytes. 10:21:01 INFO - Reading from file /builds/slave/test/build/test_packages.json 10:21:01 INFO - Using the following test package requirements: 10:21:01 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:21:01 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:21:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:21:01 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:21:01 INFO - u'jsshell-linux-x86_64.zip'], 10:21:01 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:21:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:21:01 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:21:01 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:21:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:21:01 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:21:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:21:01 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:21:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:21:01 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:21:01 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:21:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:21:01 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:21:01 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')]} 10:21:01 INFO - https://queue.taskcluster.net/v1/task/5xnCYh_UQbycxpOtMwk46w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:21:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5xnCYh_UQbycxpOtMwk46w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:21:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5xnCYh_UQbycxpOtMwk46w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:21:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5xnCYh_UQbycxpOtMwk46w/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 10:21:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5xnCYh_UQbycxpOtMwk46w/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 10:21:02 INFO - Downloaded 21788779 bytes. 10:21:02 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 10:21:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:21:02 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 10:21:03 INFO - Return code: 0 10:21:03 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 10:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:03 INFO - https://queue.taskcluster.net/v1/task/5xnCYh_UQbycxpOtMwk46w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:21:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5xnCYh_UQbycxpOtMwk46w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:21:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5xnCYh_UQbycxpOtMwk46w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:21:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5xnCYh_UQbycxpOtMwk46w/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 10:21:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5xnCYh_UQbycxpOtMwk46w/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 10:21:04 INFO - Downloaded 21788779 bytes. 10:21:04 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 10:21:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:21:04 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 10:21:05 INFO - Return code: 0 10:21: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')]} 10:21:05 INFO - https://queue.taskcluster.net/v1/task/5xnCYh_UQbycxpOtMwk46w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:21:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5xnCYh_UQbycxpOtMwk46w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:21:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5xnCYh_UQbycxpOtMwk46w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:21:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5xnCYh_UQbycxpOtMwk46w/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 10:21:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5xnCYh_UQbycxpOtMwk46w/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 10:21:06 INFO - Downloaded 11132001 bytes. 10:21:06 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 10:21:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:21:06 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 10:21:06 INFO - Return code: 0 10:21:06 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')]} 10:21:06 INFO - https://queue.taskcluster.net/v1/task/5xnCYh_UQbycxpOtMwk46w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:21:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5xnCYh_UQbycxpOtMwk46w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:21:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5xnCYh_UQbycxpOtMwk46w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:21:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5xnCYh_UQbycxpOtMwk46w/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 10:21:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5xnCYh_UQbycxpOtMwk46w/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 10:21:08 INFO - Downloaded 57687485 bytes. 10:21:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/5xnCYh_UQbycxpOtMwk46w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:21:08 INFO - mkdir: /builds/slave/test/properties 10:21:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:21:08 INFO - Writing to file /builds/slave/test/properties/build_url 10:21:08 INFO - Contents: 10:21:08 INFO - build_url:https://queue.taskcluster.net/v1/task/5xnCYh_UQbycxpOtMwk46w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:21:08 INFO - Running post-action listener: _resource_record_post_action 10:21:08 INFO - Running post-action listener: set_extra_try_arguments 10:21:08 INFO - ##### 10:21:08 INFO - ##### Running populate-webroot step. 10:21:08 INFO - ##### 10:21:08 INFO - Running pre-action listener: _resource_record_pre_action 10:21:08 INFO - Running main action method: populate_webroot 10:21:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:21:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:21:08 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 10:21:08 INFO - '../fennec_ids.txt'], 10:21:08 INFO - 'tests': ['tcheck2']}, 10:21:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:21:08 INFO - '--tppagecycles', 10:21:08 INFO - '7'], 10:21:08 INFO - 'tests': ['tsvgm']}}, 10:21:08 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:21:08 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:21:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:21:08 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:21:08 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:21:08 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:21:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:21:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:08 INFO - 'talos_options': ['--e10s'], 10:21:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:21:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:08 INFO - 'tests': ['damp', 'tps']}, 10:21:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:08 INFO - 'talos_options': ['--e10s'], 10:21:08 INFO - 'tests': ['damp', 'tps']}, 10:21:08 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:21:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:21:08 INFO - 'other': {'tests': ['a11yr', 10:21:08 INFO - 'ts_paint', 10:21:08 INFO - 'tpaint', 10:21:08 INFO - 'sessionrestore', 10:21:08 INFO - 'sessionrestore_no_auto_restore']}, 10:21:08 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:21:08 INFO - 'tests': ['a11yr', 10:21:08 INFO - 'ts_paint', 10:21:08 INFO - 'tpaint', 10:21:08 INFO - 'sessionrestore', 10:21:08 INFO - 'sessionrestore_no_auto_restore']}, 10:21:08 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:21:08 INFO - 'tests': ['a11yr', 10:21:08 INFO - 'ts_paint', 10:21:08 INFO - 'tpaint', 10:21:08 INFO - 'sessionrestore', 10:21:08 INFO - 'sessionrestore_no_auto_restore']}, 10:21:08 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:21:08 INFO - 'tests': ['a11yr', 10:21:08 INFO - 'ts_paint', 10:21:08 INFO - 'tpaint', 10:21:08 INFO - 'sessionrestore', 10:21:08 INFO - 'sessionrestore_no_auto_restore']}, 10:21:08 INFO - 'other_l64': {'tests': ['a11yr', 10:21:08 INFO - 'ts_paint', 10:21:08 INFO - 'tpaint', 10:21:08 INFO - 'sessionrestore', 10:21:08 INFO - 'sessionrestore_no_auto_restore']}, 10:21:08 INFO - 'other_nol64': {'tests': ['a11yr', 10:21:08 INFO - 'ts_paint', 10:21:08 INFO - 'tpaint', 10:21:08 INFO - 'sessionrestore', 10:21:08 INFO - 'sessionrestore_no_auto_restore']}, 10:21:08 INFO - 'svgr': {'tests': ['tsvgx', 10:21:08 INFO - 'tsvgr_opacity', 10:21:08 INFO - 'tart', 10:21:08 INFO - 'tscrollx', 10:21:08 INFO - 'cart']}, 10:21:08 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:21:08 INFO - 'tests': ['tsvgx', 10:21:08 INFO - 'tsvgr_opacity', 10:21:08 INFO - 'tart', 10:21:08 INFO - 'tscrollx', 10:21:08 INFO - 'cart']}, 10:21:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:08 INFO - 'tests': ['tp5o']}, 10:21:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:08 INFO - 'talos_options': ['--e10s'], 10:21:08 INFO - 'tests': ['tp5o']}, 10:21:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:08 INFO - 'talos_options': ['--xperf_path', 10:21:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:21:08 INFO - 'tests': ['tp5n']}, 10:21:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:08 INFO - 'talos_options': ['--e10s', 10:21:08 INFO - '--xperf_path', 10:21:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:21:08 INFO - 'tests': ['tp5n']}}, 10:21:08 INFO - 'talos.zip': {'path': '', 10:21:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:21:08 INFO - Running post-action listener: _resource_record_post_action 10:21:08 INFO - ##### 10:21:08 INFO - ##### Running create-virtualenv step. 10:21:08 INFO - ##### 10:21:08 INFO - Running pre-action listener: _resource_record_pre_action 10:21:08 INFO - Running main action method: create_virtualenv 10:21:08 INFO - Creating virtualenv /builds/slave/test/build/venv 10:21:08 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 10:21:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:21:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:21:08 INFO - Using real prefix '/usr' 10:21:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:21:08 INFO - Installing distribute.............................................................................................................................................................................................done. 10:21:10 INFO - Installing pip.................done. 10:21:10 INFO - Return code: 0 10:21:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:21:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe32483ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10450b0>, '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 0x1045fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046440>, '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': '447a3abc0420b6a47dd38cba000001bf-1449166858.627147-1782568763', '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 10:21:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:21:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:21:10 INFO - Using env: {'DISPLAY': ':0', 10:21:10 INFO - 'HOME': '/home/cltbld', 10:21:10 INFO - 'LANG': 'en_US.UTF-8', 10:21:10 INFO - 'LANGUAGE': 'en_US:en', 10:21:10 INFO - 'LOGNAME': 'cltbld', 10:21:10 INFO - 'MAIL': '/var/mail/cltbld', 10:21:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:10 INFO - 'MOZ_NO_REMOTE': '1', 10:21:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:10 INFO - 'NO_EM_RESTART': '1', 10:21:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:10 INFO - 'PWD': '/builds/slave/test', 10:21:10 INFO - 'SHELL': '/bin/bash', 10:21:10 INFO - 'SHLVL': '1', 10:21:10 INFO - 'TERM': 'linux', 10:21:10 INFO - 'TMOUT': '86400', 10:21:10 INFO - 'USER': 'cltbld', 10:21:10 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449166858.627147-1782568763', 10:21:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:10 INFO - '_': '/tools/buildbot/bin/python'} 10:21:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:11 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 10:21:11 INFO - Cleaning up... 10:21:11 INFO - Return code: 0 10:21:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:21:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe32483ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10450b0>, '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 0x1045fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046440>, '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': '447a3abc0420b6a47dd38cba000001bf-1449166858.627147-1782568763', '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 10:21:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:21:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:21:11 INFO - Using env: {'DISPLAY': ':0', 10:21:11 INFO - 'HOME': '/home/cltbld', 10:21:11 INFO - 'LANG': 'en_US.UTF-8', 10:21:11 INFO - 'LANGUAGE': 'en_US:en', 10:21:11 INFO - 'LOGNAME': 'cltbld', 10:21:11 INFO - 'MAIL': '/var/mail/cltbld', 10:21:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:11 INFO - 'MOZ_NO_REMOTE': '1', 10:21:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:11 INFO - 'NO_EM_RESTART': '1', 10:21:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:11 INFO - 'PWD': '/builds/slave/test', 10:21:11 INFO - 'SHELL': '/bin/bash', 10:21:11 INFO - 'SHLVL': '1', 10:21:11 INFO - 'TERM': 'linux', 10:21:11 INFO - 'TMOUT': '86400', 10:21:11 INFO - 'USER': 'cltbld', 10:21:11 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449166858.627147-1782568763', 10:21:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:11 INFO - '_': '/tools/buildbot/bin/python'} 10:21:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:11 INFO - Downloading/unpacking psutil>=0.7.1 10:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:12 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 10:21:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:21:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:21:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:21:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:21:13 INFO - Installing collected packages: psutil 10:21:13 INFO - Running setup.py install for psutil 10:21:13 INFO - building 'psutil._psutil_linux' extension 10:21:13 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 10:21:13 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 10:21:13 INFO - building 'psutil._psutil_posix' extension 10:21:13 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 10:21:13 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 10:21:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:21:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:21:13 INFO - Successfully installed psutil 10:21:13 INFO - Cleaning up... 10:21:13 INFO - Return code: 0 10:21:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe32483ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10450b0>, '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 0x1045fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046440>, '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': '447a3abc0420b6a47dd38cba000001bf-1449166858.627147-1782568763', '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 10:21:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:21:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:21:13 INFO - Using env: {'DISPLAY': ':0', 10:21:13 INFO - 'HOME': '/home/cltbld', 10:21:13 INFO - 'LANG': 'en_US.UTF-8', 10:21:13 INFO - 'LANGUAGE': 'en_US:en', 10:21:13 INFO - 'LOGNAME': 'cltbld', 10:21:13 INFO - 'MAIL': '/var/mail/cltbld', 10:21:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:13 INFO - 'MOZ_NO_REMOTE': '1', 10:21:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:13 INFO - 'NO_EM_RESTART': '1', 10:21:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:13 INFO - 'PWD': '/builds/slave/test', 10:21:13 INFO - 'SHELL': '/bin/bash', 10:21:13 INFO - 'SHLVL': '1', 10:21:13 INFO - 'TERM': 'linux', 10:21:13 INFO - 'TMOUT': '86400', 10:21:13 INFO - 'USER': 'cltbld', 10:21:13 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449166858.627147-1782568763', 10:21:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:13 INFO - '_': '/tools/buildbot/bin/python'} 10:21:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:21:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:21:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:21:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:21:15 INFO - Installing collected packages: mozsystemmonitor 10:21:15 INFO - Running setup.py install for mozsystemmonitor 10:21:15 INFO - Successfully installed mozsystemmonitor 10:21:15 INFO - Cleaning up... 10:21:15 INFO - Return code: 0 10:21:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:21:15 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')]} 10:21:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:15 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')]} 10:21:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:15 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 0x7fe32483ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10450b0>, '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 0x1045fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046440>, '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': '447a3abc0420b6a47dd38cba000001bf-1449166858.627147-1782568763', '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 10:21:15 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 10:21:15 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 10:21:15 INFO - Using env: {'DISPLAY': ':0', 10:21:15 INFO - 'HOME': '/home/cltbld', 10:21:15 INFO - 'LANG': 'en_US.UTF-8', 10:21:15 INFO - 'LANGUAGE': 'en_US:en', 10:21:15 INFO - 'LOGNAME': 'cltbld', 10:21:15 INFO - 'MAIL': '/var/mail/cltbld', 10:21:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:15 INFO - 'MOZ_NO_REMOTE': '1', 10:21:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:15 INFO - 'NO_EM_RESTART': '1', 10:21:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:15 INFO - 'PWD': '/builds/slave/test', 10:21:15 INFO - 'SHELL': '/bin/bash', 10:21:15 INFO - 'SHLVL': '1', 10:21:15 INFO - 'TERM': 'linux', 10:21:15 INFO - 'TMOUT': '86400', 10:21:15 INFO - 'USER': 'cltbld', 10:21:15 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449166858.627147-1782568763', 10:21:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:15 INFO - '_': '/tools/buildbot/bin/python'} 10:21:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:15 INFO - Downloading/unpacking blobuploader==1.2.4 10:21:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:17 INFO - Downloading blobuploader-1.2.4.tar.gz 10:21:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:21:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:21:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:21:17 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 10:21:17 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 10:21:17 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 10:21:17 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 10:21:17 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 10:21:17 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 10:21:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:21:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:21:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:21:18 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 10:21:18 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 10:21:18 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 10:21:18 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 10:21:18 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 10:21:18 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 10:21:18 INFO - Downloading docopt-0.6.1.tar.gz 10:21:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:21:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:21:18 INFO - Installing collected packages: blobuploader, requests, docopt 10:21:18 INFO - Running setup.py install for blobuploader 10:21:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:21:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:21:18 INFO - Running setup.py install for requests 10:21:18 INFO - Running setup.py install for docopt 10:21:18 INFO - Successfully installed blobuploader requests docopt 10:21:18 INFO - Cleaning up... 10:21:18 INFO - Return code: 0 10:21:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:21:18 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')]} 10:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:18 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')]} 10:21:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:18 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 0x7fe32483ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10450b0>, '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 0x1045fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046440>, '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': '447a3abc0420b6a47dd38cba000001bf-1449166858.627147-1782568763', '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 10:21:18 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 10:21:18 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 10:21:18 INFO - Using env: {'DISPLAY': ':0', 10:21:18 INFO - 'HOME': '/home/cltbld', 10:21:18 INFO - 'LANG': 'en_US.UTF-8', 10:21:18 INFO - 'LANGUAGE': 'en_US:en', 10:21:18 INFO - 'LOGNAME': 'cltbld', 10:21:18 INFO - 'MAIL': '/var/mail/cltbld', 10:21:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:18 INFO - 'MOZ_NO_REMOTE': '1', 10:21:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:18 INFO - 'NO_EM_RESTART': '1', 10:21:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:18 INFO - 'PWD': '/builds/slave/test', 10:21:18 INFO - 'SHELL': '/bin/bash', 10:21:18 INFO - 'SHLVL': '1', 10:21:18 INFO - 'TERM': 'linux', 10:21:18 INFO - 'TMOUT': '86400', 10:21:18 INFO - 'USER': 'cltbld', 10:21:18 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449166858.627147-1782568763', 10:21:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:18 INFO - '_': '/tools/buildbot/bin/python'} 10:21:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:21:19 INFO - Running setup.py (path:/tmp/pip-ZOsGrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:21:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:21:19 INFO - Running setup.py (path:/tmp/pip-pztkIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:21:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:21:19 INFO - Running setup.py (path:/tmp/pip-3Febji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:21:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:21:19 INFO - Running setup.py (path:/tmp/pip-N7wOG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:21:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:21:19 INFO - Running setup.py (path:/tmp/pip-1_s4rK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:21:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:21:19 INFO - Running setup.py (path:/tmp/pip-QLxzoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:21:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:21:19 INFO - Running setup.py (path:/tmp/pip-0TEZaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:21:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:21:19 INFO - Running setup.py (path:/tmp/pip-xjDLcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:21:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:21:19 INFO - Running setup.py (path:/tmp/pip-53kw4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:21:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:21:19 INFO - Running setup.py (path:/tmp/pip-CkqISD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:21:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:21:19 INFO - Running setup.py (path:/tmp/pip-U7ucx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:21:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:21:19 INFO - Running setup.py (path:/tmp/pip-6dfl2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:21:20 INFO - Running setup.py (path:/tmp/pip-roMWnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:21:20 INFO - Running setup.py (path:/tmp/pip-U386hr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:21:20 INFO - Running setup.py (path:/tmp/pip-x49OJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:21:20 INFO - Running setup.py (path:/tmp/pip-7Il2KD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:21:20 INFO - Running setup.py (path:/tmp/pip-GcspUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:21:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:21:20 INFO - Running setup.py install for manifestparser 10:21:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:21:20 INFO - Running setup.py install for mozcrash 10:21:20 INFO - Running setup.py install for mozdebug 10:21:20 INFO - Running setup.py install for mozdevice 10:21:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:21:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:21:20 INFO - Running setup.py install for mozfile 10:21:20 INFO - Running setup.py install for mozhttpd 10:21:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:21:20 INFO - Running setup.py install for mozinfo 10:21:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:21:21 INFO - Running setup.py install for mozInstall 10:21:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:21:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:21:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:21:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:21:21 INFO - Running setup.py install for mozleak 10:21:21 INFO - Running setup.py install for mozlog 10:21:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:21:21 INFO - Running setup.py install for moznetwork 10:21:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:21:21 INFO - Running setup.py install for mozprocess 10:21:21 INFO - Running setup.py install for mozprofile 10:21:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:21:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:21:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:21:21 INFO - Running setup.py install for mozrunner 10:21:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:21:21 INFO - Running setup.py install for mozscreenshot 10:21:21 INFO - Running setup.py install for moztest 10:21:22 INFO - Running setup.py install for mozversion 10:21:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:21:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:21:22 INFO - Cleaning up... 10:21:22 INFO - Return code: 0 10:21:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:22 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 0x7fe32483ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10450b0>, '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 0x1045fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046440>, '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': '447a3abc0420b6a47dd38cba000001bf-1449166858.627147-1782568763', '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 10:21:22 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 10:21:22 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 10:21:22 INFO - Using env: {'DISPLAY': ':0', 10:21:22 INFO - 'HOME': '/home/cltbld', 10:21:22 INFO - 'LANG': 'en_US.UTF-8', 10:21:22 INFO - 'LANGUAGE': 'en_US:en', 10:21:22 INFO - 'LOGNAME': 'cltbld', 10:21:22 INFO - 'MAIL': '/var/mail/cltbld', 10:21:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:22 INFO - 'MOZ_NO_REMOTE': '1', 10:21:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:22 INFO - 'NO_EM_RESTART': '1', 10:21:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:22 INFO - 'PWD': '/builds/slave/test', 10:21:22 INFO - 'SHELL': '/bin/bash', 10:21:22 INFO - 'SHLVL': '1', 10:21:22 INFO - 'TERM': 'linux', 10:21:22 INFO - 'TMOUT': '86400', 10:21:22 INFO - 'USER': 'cltbld', 10:21:22 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449166858.627147-1782568763', 10:21:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:22 INFO - '_': '/tools/buildbot/bin/python'} 10:21:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:21:22 INFO - Running setup.py (path:/tmp/pip-mp8VQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:21:22 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)) 10:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:21:22 INFO - Running setup.py (path:/tmp/pip-fNQTvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:21:22 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)) 10:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:21:22 INFO - Running setup.py (path:/tmp/pip-OMRFwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:21:22 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)) 10:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:21:22 INFO - Running setup.py (path:/tmp/pip-Df1bqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:21:22 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)) 10:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:21:22 INFO - Running setup.py (path:/tmp/pip-CdtUT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:21:22 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)) 10:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:21:22 INFO - Running setup.py (path:/tmp/pip-gtfowB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:21:22 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)) 10:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:21:22 INFO - Running setup.py (path:/tmp/pip-dhq9px-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:21:22 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)) 10:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:21:22 INFO - Running setup.py (path:/tmp/pip-CYZOgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:21:22 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)) 10:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:21:22 INFO - Running setup.py (path:/tmp/pip-2aaGnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:21:22 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)) 10:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:21:23 INFO - Running setup.py (path:/tmp/pip-oJFSSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:21:23 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)) 10:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:21:23 INFO - Running setup.py (path:/tmp/pip-3LVVvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:21:23 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)) 10:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:21:23 INFO - Running setup.py (path:/tmp/pip-WMNDkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:21:23 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)) 10:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:21:23 INFO - Running setup.py (path:/tmp/pip-G388Gz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:21:23 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)) 10:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:21:23 INFO - Running setup.py (path:/tmp/pip-Q7q5DG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:21:23 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)) 10:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:21:23 INFO - Running setup.py (path:/tmp/pip-bc3XBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:21:23 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)) 10:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:21:23 INFO - Running setup.py (path:/tmp/pip-m8CWfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:21:23 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)) 10:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:21:23 INFO - Running setup.py (path:/tmp/pip-SOIsn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:21:23 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)) 10:21:23 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)) 10:21:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:21:23 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)) 10:21:23 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)) 10:21:23 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)) 10:21:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:21:23 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 10:21:23 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 10:21:23 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 10:21:23 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 10:21:23 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 10:21:23 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 10:21:25 INFO - Downloading blessings-1.5.1.tar.gz 10:21:25 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 10:21:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:21:25 INFO - Installing collected packages: blessings 10:21:25 INFO - Running setup.py install for blessings 10:21:25 INFO - Successfully installed blessings 10:21:25 INFO - Cleaning up... 10:21:25 INFO - Return code: 0 10:21:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:21:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:21:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:21:25 INFO - Reading from file tmpfile_stdout 10:21:25 INFO - Current package versions: 10:21:25 INFO - argparse == 1.2.1 10:21:25 INFO - blessings == 1.5.1 10:21:25 INFO - blobuploader == 1.2.4 10:21:25 INFO - docopt == 0.6.1 10:21:25 INFO - manifestparser == 1.1 10:21:25 INFO - mozInstall == 1.12 10:21:25 INFO - mozcrash == 0.16 10:21:25 INFO - mozdebug == 0.1 10:21:25 INFO - mozdevice == 0.47 10:21:25 INFO - mozfile == 1.2 10:21:25 INFO - mozhttpd == 0.7 10:21:25 INFO - mozinfo == 0.9 10:21:25 INFO - mozleak == 0.1 10:21:25 INFO - mozlog == 3.1 10:21:25 INFO - moznetwork == 0.27 10:21:25 INFO - mozprocess == 0.22 10:21:25 INFO - mozprofile == 0.27 10:21:25 INFO - mozrunner == 6.11 10:21:25 INFO - mozscreenshot == 0.1 10:21:25 INFO - mozsystemmonitor == 0.0 10:21:25 INFO - moztest == 0.7 10:21:25 INFO - mozversion == 1.4 10:21:25 INFO - psutil == 3.1.1 10:21:25 INFO - requests == 1.2.3 10:21:25 INFO - wsgiref == 0.1.2 10:21:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:21: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')]} 10:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21: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')]} 10:21:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:25 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 0x7fe32483ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10450b0>, '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 0x1045fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046440>, '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': '447a3abc0420b6a47dd38cba000001bf-1449166858.627147-1782568763', '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 10:21:25 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 10:21:25 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 10:21:25 INFO - Using env: {'DISPLAY': ':0', 10:21:25 INFO - 'HOME': '/home/cltbld', 10:21:25 INFO - 'LANG': 'en_US.UTF-8', 10:21:25 INFO - 'LANGUAGE': 'en_US:en', 10:21:25 INFO - 'LOGNAME': 'cltbld', 10:21:25 INFO - 'MAIL': '/var/mail/cltbld', 10:21:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:25 INFO - 'MOZ_NO_REMOTE': '1', 10:21:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:25 INFO - 'NO_EM_RESTART': '1', 10:21:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:25 INFO - 'PWD': '/builds/slave/test', 10:21:25 INFO - 'SHELL': '/bin/bash', 10:21:25 INFO - 'SHLVL': '1', 10:21:25 INFO - 'TERM': 'linux', 10:21:25 INFO - 'TMOUT': '86400', 10:21:25 INFO - 'USER': 'cltbld', 10:21:25 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449166858.627147-1782568763', 10:21:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:25 INFO - '_': '/tools/buildbot/bin/python'} 10:21:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:25 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)) 10:21:25 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)) 10:21:25 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)) 10:21:25 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)) 10:21:25 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)) 10:21:25 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)) 10:21:25 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)) 10:21:25 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)) 10:21:25 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)) 10:21:25 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)) 10:21:25 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)) 10:21:25 INFO - Cleaning up... 10:21:25 INFO - Return code: 0 10:21:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:21: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')]} 10:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21: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')]} 10:21:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:25 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 0x7fe32483ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10450b0>, '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 0x1045fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046440>, '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': '447a3abc0420b6a47dd38cba000001bf-1449166858.627147-1782568763', '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 10:21:25 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 10:21:25 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 10:21:25 INFO - Using env: {'DISPLAY': ':0', 10:21:25 INFO - 'HOME': '/home/cltbld', 10:21:25 INFO - 'LANG': 'en_US.UTF-8', 10:21:25 INFO - 'LANGUAGE': 'en_US:en', 10:21:25 INFO - 'LOGNAME': 'cltbld', 10:21:25 INFO - 'MAIL': '/var/mail/cltbld', 10:21:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:25 INFO - 'MOZ_NO_REMOTE': '1', 10:21:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:25 INFO - 'NO_EM_RESTART': '1', 10:21:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:25 INFO - 'PWD': '/builds/slave/test', 10:21:25 INFO - 'SHELL': '/bin/bash', 10:21:25 INFO - 'SHLVL': '1', 10:21:25 INFO - 'TERM': 'linux', 10:21:25 INFO - 'TMOUT': '86400', 10:21:25 INFO - 'USER': 'cltbld', 10:21:25 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449166858.627147-1782568763', 10:21:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:25 INFO - '_': '/tools/buildbot/bin/python'} 10:21:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:26 INFO - Downloading/unpacking jsonschema 10:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:21:27 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 10:21:27 INFO - Downloading/unpacking functools32 (from jsonschema) 10:21:27 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 10:21:27 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 10:21:27 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 10:21:27 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 10:21:27 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 10:21:27 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 10:21:28 INFO - Downloading functools32-3.2.3-2.tar.gz 10:21:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:21:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:21:28 INFO - warning: no files found matching '*.txt' 10:21:28 INFO - no previously-included directories found matching 'build' 10:21:28 INFO - no previously-included directories found matching 'dist' 10:21:28 INFO - no previously-included directories found matching '.git*' 10:21:28 INFO - Installing collected packages: jsonschema, functools32 10:21:28 INFO - Running setup.py install for functools32 10:21:28 INFO - warning: no files found matching '*.txt' 10:21:28 INFO - no previously-included directories found matching 'build' 10:21:28 INFO - no previously-included directories found matching 'dist' 10:21:28 INFO - no previously-included directories found matching '.git*' 10:21:28 INFO - Successfully installed jsonschema functools32 10:21:28 INFO - Cleaning up... 10:21:28 INFO - Return code: 0 10:21:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe32483ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10450b0>, '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 0x1045fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046440>, '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': '447a3abc0420b6a47dd38cba000001bf-1449166858.627147-1782568763', '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 10:21:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:21:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:21:28 INFO - Using env: {'DISPLAY': ':0', 10:21:28 INFO - 'HOME': '/home/cltbld', 10:21:28 INFO - 'LANG': 'en_US.UTF-8', 10:21:28 INFO - 'LANGUAGE': 'en_US:en', 10:21:28 INFO - 'LOGNAME': 'cltbld', 10:21:28 INFO - 'MAIL': '/var/mail/cltbld', 10:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:28 INFO - 'MOZ_NO_REMOTE': '1', 10:21:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:28 INFO - 'NO_EM_RESTART': '1', 10:21:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:28 INFO - 'PWD': '/builds/slave/test', 10:21:28 INFO - 'SHELL': '/bin/bash', 10:21:28 INFO - 'SHLVL': '1', 10:21:28 INFO - 'TERM': 'linux', 10:21:28 INFO - 'TMOUT': '86400', 10:21:28 INFO - 'USER': 'cltbld', 10:21:28 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449166858.627147-1782568763', 10:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:28 INFO - '_': '/tools/buildbot/bin/python'} 10:21:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:28 INFO - Downloading/unpacking flake8 10:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:21:30 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 10:21:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:21:30 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 10:21:30 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 10:21:30 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 10:21:30 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 10:21:30 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 10:21:30 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 10:21:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:21:30 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 10:21:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:21:30 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 10:21:30 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 10:21:30 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 10:21:30 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 10:21:30 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 10:21:30 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 10:21:30 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 10:21:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:21:30 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 10:21:30 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 10:21:30 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 10:21:30 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 10:21:30 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 10:21:30 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 10:21:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:21:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:21:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:21:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:21:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:21:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:21:30 INFO - no previously-included directories found matching 'docs/_build' 10:21:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:21:30 INFO - Running setup.py install for pep8 10:21:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:21:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:21:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:21:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:21:30 INFO - no previously-included directories found matching 'docs/_build' 10:21:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:21:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:21:31 INFO - Cleaning up... 10:21:31 INFO - Return code: 0 10:21:31 INFO - Running post-action listener: _resource_record_post_action 10:21:31 INFO - Running post-action listener: _start_resource_monitoring 10:21:31 INFO - Starting resource monitoring. 10:21:31 INFO - ##### 10:21:31 INFO - ##### Running install step. 10:21:31 INFO - ##### 10:21:31 INFO - Running pre-action listener: _resource_record_pre_action 10:21:31 INFO - Running main action method: install 10:21:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:21:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:21:31 INFO - Reading from file tmpfile_stdout 10:21:31 INFO - Detecting whether we're running mozinstall >=1.0... 10:21:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:21:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:21:31 INFO - Reading from file tmpfile_stdout 10:21:31 INFO - Output received: 10:21:31 INFO - Usage: mozinstall [options] installer 10:21:31 INFO - Options: 10:21:31 INFO - -h, --help show this help message and exit 10:21:31 INFO - -d DEST, --destination=DEST 10:21:31 INFO - Directory to install application into. [default: 10:21:31 INFO - "/builds/slave/test"] 10:21:31 INFO - --app=APP Application being installed. [default: firefox] 10:21:31 INFO - mkdir: /builds/slave/test/build/application 10:21:31 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'] 10:21:31 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 10:21:45 INFO - Reading from file tmpfile_stdout 10:21:45 INFO - Output received: 10:21:45 INFO - /builds/slave/test/build/application/firefox/firefox 10:21:45 INFO - Running post-action listener: _resource_record_post_action 10:21:45 INFO - ##### 10:21:45 INFO - ##### Running run-tests step. 10:21:45 INFO - ##### 10:21:45 INFO - Running pre-action listener: _resource_record_pre_action 10:21:45 INFO - Running main action method: run_tests 10:21:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:21:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:21:45 INFO - Python 2.7.3 10:21:45 INFO - Return code: 0 10:21:45 INFO - grabbing minidump binary from tooltool 10:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:45 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 0x10450b0>, '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 0x1045fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:21:45 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 10:21:45 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 10:21:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:21:45 INFO - Return code: 0 10:21:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:21:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:21:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:21:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:21:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:21:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:21:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:21:46 INFO - Return code: 0 10:21:46 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/5xnCYh_UQbycxpOtMwk46w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost'] in /builds/slave/test/build 10:21:46 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/5xnCYh_UQbycxpOtMwk46w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost 10:21:46 INFO - Using env: {'DISPLAY': ':0', 10:21:46 INFO - 'HOME': '/home/cltbld', 10:21:46 INFO - 'LANG': 'en_US.UTF-8', 10:21:46 INFO - 'LANGUAGE': 'en_US:en', 10:21:46 INFO - 'LOGNAME': 'cltbld', 10:21:46 INFO - 'MAIL': '/var/mail/cltbld', 10:21:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:21:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:21:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:46 INFO - 'MOZ_NO_REMOTE': '1', 10:21:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:21:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:46 INFO - 'NO_EM_RESTART': '1', 10:21:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:46 INFO - 'PWD': '/builds/slave/test', 10:21:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:21:46 INFO - 'SHELL': '/bin/bash', 10:21:46 INFO - 'SHLVL': '1', 10:21:46 INFO - 'TERM': 'linux', 10:21:46 INFO - 'TMOUT': '86400', 10:21:46 INFO - 'USER': 'cltbld', 10:21:46 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449166858.627147-1782568763', 10:21:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:46 INFO - '_': '/tools/buildbot/bin/python'} 10:21:46 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/5xnCYh_UQbycxpOtMwk46w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost'] with output_timeout 3600 10:21:47 INFO - mozversion INFO | application_buildid: 20151203092422 10:21:47 INFO - mozversion INFO | application_changeset: 4c9ca7614d701d28549ef734d41dcce5ac37cba2 10:21:47 INFO - mozversion INFO | application_display_name: Nightly 10:21:47 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:21:47 INFO - mozversion INFO | application_name: Firefox 10:21:47 INFO - mozversion INFO | application_remotingname: firefox 10:21:47 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 10:21:47 INFO - mozversion INFO | application_vendor: Mozilla 10:21:47 INFO - mozversion INFO | application_version: 45.0a1 10:21:47 INFO - mozversion INFO | platform_buildid: 20151203092422 10:21:47 INFO - mozversion INFO | platform_changeset: 4c9ca7614d701d28549ef734d41dcce5ac37cba2 10:21:47 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 10:21:47 INFO - mozversion INFO | platform_version: 45.0a1 10:21:47 INFO - 2015-12-03 10:21:47,129 DEBUG : using testdate: 1449166907 10:21:47 INFO - 2015-12-03 10:21:47,129 DEBUG : actual date: 1449166907 10:21:47 INFO - 2015-12-03 10:21:47,177 INFO : starting webserver on 'localhost:49998' 10:21:47 INFO - 2015-12-03 10:21:47,178 INFO : Starting test suite talos-linux64-ix-027 10:21:47 INFO - 2015-12-03 10:21:47,178 INFO : Starting test dromaeo_css 10:21:47 INFO - 2015-12-03 10:21:47,178 DEBUG : operating with platform_type : linux_ 10:21:47 INFO - 2015-12-03 10:21:47,179 INFO : Initialising browser for dromaeo_css test... 10:21:47 INFO - 2015-12-03 10:21:47,194 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoHxdyF/profile http://localhost:49998/getInfo.html 10:21:51 INFO - 2015-12-03 10:21:51,655 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:21:51 INFO - 2015-12-03 10:21:51,655 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:21:51 INFO - 2015-12-03 10:21:51,655 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:21:51 INFO - 2015-12-03 10:21:51,655 DEBUG : BROWSER_OUTPUT: __metrics 10:21:51 INFO - 2015-12-03 10:21:51,756 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] 10:21:51 INFO - 2015-12-03 10:21:51,812 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] 10:21:51 ERROR - 2015-12-03 10:21:51,833 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 10:21:53 INFO - 2015-12-03 10:21:53,065 INFO : Browser initialized. 10:21:53 INFO - 2015-12-03 10:21:53,066 INFO : Running cycle 1/1 for dromaeo_css test... 10:21:53 INFO - 2015-12-03 10:21:53,066 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoHxdyF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:22:05 INFO - 2015-12-03 10:22:05,054 DEBUG : BROWSER_OUTPUT: RSS: Main: 143405056 10:22:05 INFO - 2015-12-03 10:22:05,054 DEBUG : BROWSER_OUTPUT: 10:22:56 INFO - 2015-12-03 10:22:56,240 DEBUG : BROWSER_OUTPUT: 1449166976236 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] 10:25:08 INFO - 2015-12-03 10:25:08,368 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49998/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49998/tests/dromaeo/cssquery-ext.html) 10:25:09 INFO - 2015-12-03 10:25:09,420 DEBUG : BROWSER_OUTPUT: RSS: Main: 237883392 10:25:09 INFO - 2015-12-03 10:25:09,420 DEBUG : BROWSER_OUTPUT: 10:28:11 INFO - 2015-12-03 10:28:11,906 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49998/tests/dromaeo/cssquery-ext.html (next: http://localhost:49998/tests/dromaeo/cssquery-jquery.html) 10:28:12 INFO - 2015-12-03 10:28:12,476 DEBUG : BROWSER_OUTPUT: RSS: Main: 223338496 10:28:12 INFO - 2015-12-03 10:28:12,476 DEBUG : BROWSER_OUTPUT: 10:31:14 INFO - 2015-12-03 10:31:14,557 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49998/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49998/tests/dromaeo/cssquery-mootools.html) 10:31:15 INFO - 2015-12-03 10:31:15,131 DEBUG : BROWSER_OUTPUT: RSS: Main: 216498176 10:31:15 INFO - 2015-12-03 10:31:15,131 DEBUG : BROWSER_OUTPUT: 10:34:17 INFO - 2015-12-03 10:34:17,119 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49998/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49998/tests/dromaeo/cssquery-prototype.html) 10:34:17 INFO - 2015-12-03 10:34:17,700 DEBUG : BROWSER_OUTPUT: RSS: Main: 204926976 10:34:17 INFO - 2015-12-03 10:34:17,700 DEBUG : BROWSER_OUTPUT: 10:37:20 INFO - 2015-12-03 10:37:20,533 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49998/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49998/tests/dromaeo/cssquery-yui.html) 10:37:21 INFO - 2015-12-03 10:37:21,115 DEBUG : BROWSER_OUTPUT: RSS: Main: 208605184 10:37:21 INFO - 2015-12-03 10:37:21,115 DEBUG : BROWSER_OUTPUT: 10:40:23 INFO - 2015-12-03 10:40:23,540 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49998/tests/dromaeo/cssquery-yui.html (next: http://localhost:49998/tests/dromaeo/cssquery-dojo.html) 10:40:23 INFO - 2015-12-03 10:40:23,790 DEBUG : BROWSER_OUTPUT: RSS: Main: 221069312 10:40:23 INFO - 2015-12-03 10:40:23,791 DEBUG : BROWSER_OUTPUT: 10:40:23 INFO - 2015-12-03 10:40:23,792 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:40:23 INFO - 2015-12-03 10:40:23,792 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:40:23 INFO - 2015-12-03 10:40:23,792 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:40:23 INFO - 2015-12-03 10:40:23,792 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:40:23 INFO - 2015-12-03 10:40:23,794 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2581.9968573067617;2623.6326914232;2630.4607555451134;2638.6965498967625;2657.2426858345375;4440.1785669651135;4523.3441151033085;4532.229520981433;4535.841245556406;4555.293929440933;4430.734155950645;4525.275955847065;4587.174308624446;4605.700629459091;4682.180618391785;4226.260404429228;4254.9149017019645;4295.613394794484;4351.738895666254;4398;4326.480822301328;4336.21948049351;4353.978230108845;4356.6514678825615;4406.449193850769;4081.2449696806184;4172.937405938914;4179.247735407625;4221.810018549173;4344.261475549164;4265.658747300208;4276.486821581399;4276.657867370603;4280.464941882265;4306.138772245532;4240.257954857888;4252.893677658052;4253.255680255943;4293.355996600504;4298.828046878121;4399.252127138394;4471.843485478025;4507.4591049074;4511.706739061983;4625.398698169251;4903.65674402792;4915.16442204826;4915.778789954425;4921.040397122562;4957.058158949824;4971.403431588196;4980.950190498085;4981.37732783402;4981.551660350549;4992.575631071363;4424.225760491901;4519.457665080211;4521.525239849834;4560.110778398181;4681.391419115561;5020.472850350734;5060.898782024339;5061.898762024739;5064.974675126601;5070.239464080344;4849.563539281482;4861.052094841542;4865.172920603506;4866.82966096192;4909.926351104737;4790.329353890458;4915.0415668944215;4917.0903382874285;4936.580390666833;5069.949300507022;4898.559129678275;4909.484504127086;4916.041371932511;4917.262410638433;4961.4294356148785;4876.122297986326;4876.317315575822;4876.707397556158;4891;4927.95072049282;3996;4046.3728122141115;4118.876433706993;4119.361498967664;4120.031792528754;3624.7100231981376;3657.5610926688437;3662.212624285791;3665.340238756996;3692.1692619161013;4265.125649241898;4275.935860962088;4276.401303817468;4276.72201306914;4316.503602085801;4739.099571081483;4848.272759086165;4918.926216106761;4960.553550180501;5014.924776128361;4159.417681524589;4212.410262563244;4256.1487702459635;4271.786410679453;4277.871663850089;4397.846075387346;4409.074094440203;4411.448568928884;4422.29243321067;4472.284434490466;4723.858284251409;4731.739754313546;4737.549932756383;4740.0756852414825;4786.928196077061;4757.167495688172;4858.611311095033;4863.586595139312;4888.7311197884455;4982.6512144149565;4723.598494128038;4736.123817093849;4738.241881298975;4754.025424787979;4783;4926.4088309403105;4928.926066109083;4932.30947667334;4941.110600092018;4978.502149785138;4773.952260477351;4856.78144483492;4886.071646387317;4888.486708895514;5006.824761133343;4799.688020278671;4803.615710743202;4819.614430845594;4848.0546293472435;4863.392075990501;4752.928706069342;4784.425868895755;4790.065937142223;4802.73584952831;4842.080004799077;4519.954800452085;4643.303504474221;4644.117617652635;4679.438467383799;4721;4838.709677419366;4845.491223421631;4852.8301509447;4873.829415970424;4876.975835074674;4689.695169813951;4731.408573928259;4731.787069581946;4737.099951009297;4778.928316075192 10:40:23 INFO - 2015-12-03 10:40:23,797 DEBUG : BROWSER_OUTPUT: |1;ext.html;567.0530214541715;574.5174053794811;575.6373484704633;582.6242073862359;583.7548229743508;25997.870010649945;26564.86717566412;36505.08737281566;37450.25099498008;37487.43768843469;40188.19623607533;40707.59292407075;40712.38931416031;40714.7964260179;40765.38851917224;6937.271586483423;7026.227115017344;7720.922790772104;7874.763757087268;7875.8424831503335;10089.445080520569;10360.53377598006;10374.585016599327;10402.47987600617;10405.739856503573;10061.748456288615;10175.236857235699;10175.38947663139;10179;10185.28702990791;7144.607046612434;7276.163241227274;7279.2356802535505;10032.899671003306;10154.39073655583;9522.428654280766;9608.519574021271;9610.231181505464;9616.66341678045;9622.085901839315;36872.44691329605;37438;37457.25085498302;37481.812590937145;37510;2704.6518220838443;2780.7999041791777;2948.6903875093235;3075.5386691996155;3240.7893486923276;28508.71491285102;28579.42841143186;28654.707623390288;28747.137585872457;29125.126246212647;3390.237196630763;3455.740819438552;3466.324066806974;3510.982445087758;3555.964440355589;207275;207862;208141;208703;208762;45840.5415945843;47128.29307560389;47141.292880606816;53138.46861531412;53547.464525355026;47106.528934710215;47565.5243447568;63386.68306658437;64686.676566616865;65134.34865651378;13725.176489410667;13767.655808604664;13828.861711382757;13906.58280251594;13919.443222271198;10281.794364112826;10348.068673819393;10355.896441035493;10359.533820978075;10366.274360794823;18820.43538693814;18932.810671893105;19066.428007159808;19080.904595476935;19106.2357505701;7466.402687784964;7546.207648196861;7723.575203363869;7735.839624056324;7872.921270787218;856.7001549457765;940.2665920581957;943.5981147944898;986.6448078691665;1060.8037513060108;26428.47143057128;26581.3354666131;26819.32951676224;26980.46039079247;27025.189244322308;903.6475774447971;908.3641450984337;952.9857052144223;979.3046936674898;1076.2681376663786;12494.937525312314;12838.743225135446;13084.869151308365;13120.278384688743;13208.405621746851;257175;261811;261825;262306;262441;44796.3280550792;45041.32438013367;45147;45311;45389.09221815545;1055.6305293147336;1140.0423644138798;1220.9084318676312;1227.2881728597392;1236.863944966053;23797.643035354136;28980;31913.521297181025;32106;32586.34827303488;41263.587364125975;41851;41896.79051604722;41923.37114943339;41988.3701744468;161131;163369.18315408347;169687;174898;175708.121459397;39538.80230598828;39546.80226598849;39754.20491590094;39783.60216397799;39861.60138398695;42281.78859105685;42576.78711606546;42994.78502607467;43110.784446078826;43490.13019739651;35757.28485430329;36275.81862090673;36556.63443365532;36947.815260923526;37726;36318.81840590886;36650.266994659425;36797.81601091977;36839.44740828836;36895.44656830096;34954.30091398107;36020.27959440744;36169.0957726059;36212.63787362198;36237.818810905774;30458.695413045585;32710.182245444055;32862.34275314528;33196.50205246875;33367;25192.874035629706;25243.242702718948;25302.459020475802;25536.872315639048;25739.227823165336 10:40:23 INFO - 2015-12-03 10:40:23,799 DEBUG : BROWSER_OUTPUT: |2;jquery.html;327.0319853234426;328.6975982096472;329.86145818756137;336.99071281511874;339.22656343536727;12577.496900124006;12874.098813083088;15123.773143402845;15532.689346213083;16660.333586656536;8210.384221183405;9536.475493847853;9803.901960980405;12821.294828784414;14273.78589321161;4401.625861801751;4524.5249248828895;4525.298578720303;4525.32120181972;4526.52471490492;3314.320564284328;3354.597448306207;4535.909281814362;5182.196759502264;5207.86980325493;5174.068667639824;5176.0683077046115;5180.507851754077;5198.2722418861385;5199.766010529535;5025.447200807908;5160.432352441228;5165.354330708661;5167.276581278624;5168.483151684839;5043.243513472972;5045.84862454127;5048.268001139851;5052.722100284483;5063.3417655704525;11632.59285924997;11857.110716696283;11968.82046769299;11972.221805582609;11973.221740586834;1793.8654600904983;1832.1388947194798;1863.8136186381253;1872.850171986238;1921.8462522998127;8857.468551886843;8878.689245876363;8951.060138685409;9156.908430915739;9212.723618291462;1674.6315810521667;1678.127373765635;1724.9827501724947;1775.316503146298;1828.4514645606264;52687.736561316946;54996.725016374665;56058.43941560614;56148.59628509279;56206;9064.637414503479;9721;9845.360051596623;9940.552675129637;10020;12340.50637974471;12383.938080309541;12437.564685235973;12439.564615238423;12455.377231138407;6959.095317608679;6980.965095174492;7000.474964377692;7057.400120989773;7077.186123595852;6702.698378572976;6724.831879202961;6754.155730533684;6842.692078856463;6899.206591242071;4277.935830962538;4303.784810759449;4309.482862056573;4315.503717072514;4330.545292744279;1652.9090900000374;1676.9748453773202;1683.6801007808476;1687.2154448181655;1704.8209937956335;372.97948612826553;374.12828110502466;798.7883210949103;905.4069584422214;974.2060220919927;10022.184002592376;10396.48017599117;15722.921385393;16222;17138.14309284531;762.6415584675194;830.3647709502236;845.9788505287418;866.5537248317122;891.772597987522;6668.566543174678;9300.674476393293;9332.440053596805;9333.253339732804;9595.568199431042;470146;476608;477506;478560;484322;60890.08664870031;61907.380926191065;62051.689741551;63213;63449;444.45998112293717;455.0671124195386;456.8423893756649;458.0289785654367;458.34685573058925;9140.177384035469;9434.292428067785;9465.716028519155;9563.760905977406;9626.47054412014;33253.83373083119;33622.49566256557;34251.4862277071;34816;34954;43049.78475107605;43149.352759708;45456;47373.52626473691;49552;8649.654013839376;9025.187733104052;9127.132922372364;9134.177923986874;9141.588628511867;16238.431654892021;16397;16488.505344839676;16630.833691662927;16722.916385417993;13965.860341396863;14170.858291417366;14218.928905355408;14276.928615356857;14427.855721443071;13072.934635327143;13387.330633468093;13641;13700;14166.433342666178;10679;12720.936395317964;13356;13392.129511581716;13837;7491.587962661888;8765.254953328784;8946.910530894607;8965.372423930263;8966.910330896608;13073.869261307265;13141.671458213621;13176.209427434385;13176.802347964596;13784.448622055006 10:40:23 INFO - 2015-12-03 10:40:23,800 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1424.458705691837;1543.1049991005218;1618.9676206475872;1650.463599330218;1707.7950645922492;5626.156076588513;6720.563163394376;6957.026016357701;6981.057557229772;6983.371496565308;6941.687624056917;7129.073220481343;7131.643417829114;7137.179224389197;7138.785836424902;1721.8708596855224;1746.0309528211837;1748.2045669220474;2074.9896250518727;2126.638471459848;1761.0226324389957;1767.5492749348898;1991.2333751505703;1998.5503261766132;2027.2701827342146;2005.79942005799;2008.0863207240743;2008.8192062714352;2009.8090681385318;2010.155734591475;1952.1215453046116;2012.5471768852037;2025.2304124432621;2027.5944811037778;2028.7058376535467;2042.9080691368777;2048.528838367169;2077.6779599162155;2096.7693553709078;2099.748030236366;6898.862022759517;7011.404030657401;7017.122859642544;7020.92979070213;7023.227444981099;4076.7757773322455;4132.028973191298;4146.751194928314;4151.8962025949595;4156.605122513387;2623.5671114266124;2638.2085374387607;2692.744189302013;2693.771029462498;2696.892124315025;878.2271600991087;878.775912142406;894.838928992781;897.6813231302924;904.6833608237064;9685.176759975411;9690.273229507744;9691.321607487478;9697.030296970317;9713.708588742278;3957.3074711925296;4011.438398624195;4019.7789121598007;4076.062505623664;4077.918441631151;8289.502629842229;8303.086660467343;8312.127226641236;8316.542590157478;8335.874961875577;4239.8092085856215;4241.066965267636;4246.957530424718;4252.851150209728;4254;3815.523059617548;3830.5211848518934;3851.171998020439;3862.1503269280715;3868.7678739275734;3389.5424117743787;3399.201187720884;3411.7611767176554;3434.8110853903277;3442.896713098611;924.7364501117149;938.483833891357;1078.730317420645;1086.9510872010778;1097.1223021582703;868.6395146014333;875.8117004843989;877.9946960730056;882.2192359761657;987.3779518903045;6768.627725475048;6797.116374871235;6810.931890681129;6817.863642727118;6832.93167068323;1022.4632068164274;1053.5153829238636;1054.2409465185056;1066.072516910293;1066.9893301067045;5325.041492531304;5374.811881584125;5377.327834020747;5381.515663590218;5391.595630327741;8407.789805254917;8514.957425212959;8611.78470538229;8651.740447786451;8713.738587842376;8512.659493620185;8513.276371508491;8516.40385173032;8608.612612432456;8613.267872230805;6595.472362211011;6654.367835055662;6694.665266736643;6754.83112922171;6788.558743681744;6376.171097757262;6442.065900444503;6457.580257283262;6463.062855885964;6471;7433.293837085468;7662.8084297893;7667.274863155968;7758.4181186410115;7760.728374506865;7722.768316950501;7786.88319675194;7801.2198780121535;7954.204579542;7970.322522585645;5854.736536855937;5918.644881307136;5920.348761636303;5922.7927022554;5929.258842644669;5936.22829032223;6329.778457753957;6516.120323756232;6517.087607734826;6766.120404347404;5844.736986835687;6322.051692246016;6409.519286053472;6423.261324947504;6544.901826472512;6284.591501552567;6291.622502649856;6359.236891573041;6390.073439351361;6464.838379040373;6405.356590462286;6429.839254018687;6433.292337842927;6467.450266727381;6475.384838440341;5992.340842507234;6009.248843894513;6045.758169673164;6048.4858787003595;6048.848778780566;6129.969350153221;6148.877022459616;6161.691915404302;6171.352008039091;6177.382261773787 10:40:23 INFO - 2015-12-03 10:40:23,801 DEBUG : BROWSER_OUTPUT: |4;prototype.html;295.37086006805504;298.1041968883505;305.8012292010194;305.8409626993962;308.3816947021222;5129.281900533928;5153.79384824607;5169.353830771153;5236;5288.735563221842;5097.286379906816;5185.351831021122;5219.608529360295;5228;5240.580753539717;4079.4492743479545;4089.591040895916;4091.734037287567;4092.9386059209137;4107.54816970133;3901.921961560767;3994.900127496807;4000.079981604218;4118.4028315894175;4119.485064366954;4064.126212864234;4064.4919385076864;4070.267351876661;4074.388841673743;4084.407760874686;4032.717709760318;4065.6747460203114;4066.3900414937702;4067.1458993611377;4074.429579858837;3571.785692858437;3576.2311103112957;3581.767185132958;3582;3585.533880595532;4951.8266860659705;5081.618878584084;5085.872853178663;5088.491150884919;5123.666961647481;4607.35497030416;4607.424071991001;4610.585047345721;4612.215923293048;4616.630669546428;5526.640768350085;5535.169724541311;5536.944630553683;5542.5565954723525;5546.140348246028;3677.7425580209397;3754.81225938702;3775.207206486641;3822.751521151144;3853.460515527828;5708.086706127041;5758.88482230353;5775.5957083004205;5780.132980052984;5787.594868359217;3905.1018265799025;3938.4879965604287;3944.901377465529;3945.704072194597;3947.2697550953167;3993.0616305168264;3993.281209382281;4004.8798536043964;4011.498562679665;4022.4368588397647;4500.89728016638;4582.335561343587;4605.769711514478;4608.239640459354;4614.538546145359;5502.312210973629;5511.090670039479;5512.80705175317;5513.724313784295;5518.91721624176;1391.6033930329806;1410.379433049455;1411.0686946615185;1411.082796182469;1415.985840141606;924.1543987251724;925.2089463508603;943.2029934705163;972.6255391674256;973.6300205921705;4811.49479304675;4816.277558366203;4816.277558366273;4821.590164835958;4830.372051633335;5705.74324155414;5709.885802283931;5716.857078573069;5722.971385143048;5723.6279641823985;4810.687305325143;4811.591014763784;4821.927671084936;4822.734749588736;4823.397075365579;2994.2215024093894;3034.726874581254;3066.7546596272246;3068.601081859344;3077.2153100959113;5382.650127741685;5390.137577987582;5394.190871369326;5395.919061214085;5396.055690254189;5847.853803654943;5856.414358564195;5857.384974577608;5857.531397488191;5877.089051197071;5375.3280839895015;5389.946100539023;5401.3248343957;5402.135658294654;5404.756785944642;5587.161925711176;5708.942910571007;5750.396208398058;5759.164921086335;5774.797882074107;5410.97294513525;5520.53075488588;5564.721763911869;5648.63283886546;5652.519535839499;5222.608304377263;5413.648112872651;5432.103702888979;5441.918371224356;5445.237666726741;3828.0238539172333;3856.151646637735;3936.4095385692376;3939.4287828265315;3940.9950462631846;5640.435956404327;5683.658980461186;5684.602077854511;5697.287839020122;5704.885902282014;5469.589780766379;5475.123980163155;5488.862778430571;5494.532964698045;5496.038193316233;5388.434214407431;5464.699441530754;5487.670739755627;5583.972080139573;5587.720613969204;5456.61803673739;5459.918101228564;5465.289512363367;5466.234727138124;5469.9179512306555;5616;5627.52166065889;5631.2960879890015;5632;5633.577481688808;5374.247605335335;5483.067878460751;5483.917741233964;5483.917741233964;5486.451354864482 10:40:23 INFO - 2015-12-03 10:40:23,802 DEBUG : BROWSER_OUTPUT: |5;yui.html;580.2946948015679;632.4434497642077;701.7719241246596;704.7286794584084;722.1074840646033;11867.821982670266;12011.459484323204;12049.216800907945;12053;12079.335636539998;11304.434778261095;11589.130815188873;11600.3039817611;13378.397972091256;13479.191248525096;772.636860675483;783.8902553642466;783.9098503672094;784.3372350363962;784.7606480023591;618.7308520793447;624.6938999890067;772.7102336623766;781.0744268042388;781.9569923654196;815.4047545291941;816.0941355095839;820.3806126374578;822.1203312455675;822.1942496353577;635.6503922842418;643.7907680004017;815.64927081355;817.709713051867;820.0323618130603;593.6823799267371;599.2090440618385;600.2466904035451;600.3966014155745;601.2814686449694;11602.303861768321;11765.294082355085;11777.587784427504;11791.469383877746;11794.705132371759;11052.613158539492;11270.774584508346;11447.599962113878;11452.083833293316;12131.93934030333;8884.822303553958;8961.59672814725;9261.907380926172;9461.38500997433;9473.715788526355;3050.86271117798;3091.5980922480157;3093.334932989418;3148.889788857402;3167.0657156138996;44199.558004419865;44320.3351949721;44722.77638611786;44823.32765008527;44966.55033449689;8494.320454363637;8719.956400218085;8854.822903541894;8942.776430589158;8974.326925480615;15479.22603869802;15613.921930390276;15642.139682317582;15655.84344156544;15663.765043524356;6191.845203869849;6298.905516417258;6305.842353941096;6429.1320671709655;6483.384078512534;3522.225110475691;3551.4672799080345;3569.839357228931;3606.2607165531003;3621.492990981265;2705.9323516912236;2725.6320396746187;2733.3986522964915;2738.0690565207924;2778.1804367711575;489.83590497183843;491.33178876727624;495.51439589202784;495.8363739965803;496.98012079516417;450.8692479181066;472.87468820762524;484.9300562617822;581.1979468333673;600.5705920266943;6834.419074378733;7266;7632;7851;8302.086770455246;448.97755112244255;464.21547584581947;513.6584171525968;605.3825098399695;612.0941007309208;3279.1310302769784;3488.8778892738633;3586.085548185196;3609.296187243515;3650.2699460108083;53228.467715323124;53759;53804;53816;53923.73038134863;46561.76719116451;47354.76322618365;47365.76317118392;47599;47924.52075479201;43275;43715;43735.78132109319;43761.78119109448;43910;6855.5886646801355;6899.75850845218;6916.757913473004;7015.508914376149;7061.329173728487;31589.36821263608;31794;32111.197220069684;32544.83727581347;32549.511757323184;38532.42201366926;38788.80605596954;38913;43394.349084763126;43569.78215108904;8450.915490845013;8519.829603408021;8786.297096232158;8798.648054077765;8860.29117670572;9659.855102173333;9719.319647624598;9731.464769437465;9770.31607787448;9914.900850991398;9046.231070359094;9174.54127293646;9180.540972951192;9186.862197067183;9226.769330766785;9179.862302065341;9395.107464790834;9431.245500360092;9538;9549.99725028862;8781.385303028983;8903.19871211594;9051.275897928019;9076.863847042432;9094.317926155432;7876.72431464896;7922.326602238874;8151.755447336589;8267.131951145284;8367.665293388196;7447.562323163804;7892.131865494676;8103.351731861319;8275.04836943735;8334.874976875473 10:40:23 INFO - 2015-12-03 10:40:23,803 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:40:23 INFO - 2015-12-03 10:40:23,803 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:40:23 INFO - 2015-12-03 10:40:23,803 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,844 10:40:23 INFO - 2015-12-03 10:40:23,803 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:40:23 INFO - 2015-12-03 10:40:23,803 DEBUG : BROWSER_OUTPUT: __startTimestamp1449168023790__endTimestamp 10:40:23 INFO - 2015-12-03 10:40:23,803 DEBUG : BROWSER_OUTPUT: 10:40:23 INFO - 2015-12-03 10:40:23,803 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:40:23 INFO - 2015-12-03 10:40:23,803 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:40:23 INFO - 2015-12-03 10:40:23,803 DEBUG : BROWSER_OUTPUT: 10:40:23 INFO - 2015-12-03 10:40:23,803 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4555.97 Median:4723.86 stddev:470.64 (10.0%) stddev-sans-first:445.88 10:40:23 INFO - 2015-12-03 10:40:23,803 DEBUG : BROWSER_OUTPUT: Values: 2582.0 2623.6 2630.5 2638.7 2657.2 4440.2 4523.3 4532.2 4535.8 4555.3 4430.7 4525.3 4587.2 4605.7 4682.2 4226.3 4254.9 4295.6 4351.7 4398.0 4326.5 4336.2 4354.0 4356.7 4406.4 4081.2 4172.9 4179.2 4221.8 4344.3 4265.7 4276.5 4276.7 4280.5 4306.1 4240.3 4252.9 4253.3 4293.4 4298.8 4399.3 4471.8 4507.5 4511.7 4625.4 4903.7 4915.2 4915.8 4921.0 4957.1 4971.4 4981.0 4981.4 4981.6 4992.6 4424.2 4519.5 4521.5 4560.1 4681.4 5020.5 5060.9 5061.9 5065.0 5070.2 4849.6 4861.1 4865.2 4866.8 4909.9 4790.3 4915.0 4917.1 4936.6 5069.9 4898.6 4909.5 4916.0 4917.3 4961.4 4876.1 4876.3 4876.7 4891.0 4928.0 3996.0 4046.4 4118.9 4119.4 4120.0 3624.7 3657.6 3662.2 3665.3 3692.2 4265.1 4275.9 4276.4 4276.7 4316.5 4739.1 4848.3 4918.9 4960.6 5014.9 4159.4 4212.4 4256.1 4271.8 4277.9 4397.8 4409.1 4411.4 4422.3 4472.3 4723.9 4731.7 4737.5 4740.1 4786.9 4757.2 4858.6 4863.6 4888.7 4982.7 4723.6 4736.1 4738.2 4754.0 4783.0 4926.4 4928.9 4932.3 4941.1 4978.5 4774.0 4856.8 4886.1 4888.5 5006.8 4799.7 4803.6 4819.6 4848.1 4863.4 4752.9 4784.4 4790.1 4802.7 4842.1 4520.0 4643.3 4644.1 4679.4 4721.0 4838.7 4845.5 4852.8 4873.8 4877.0 4689.7 4731.4 4731.8 4737.1 4778.9 10:40:23 INFO - 2015-12-03 10:40:23,803 DEBUG : BROWSER_OUTPUT: 10:40:23 INFO - 2015-12-03 10:40:23,804 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38828.59 Median:3533.47 stddev:56049.44 (1586.2%) stddev-sans-first:56133.04 10:40:23 INFO - 2015-12-03 10:40:23,805 DEBUG : BROWSER_OUTPUT: Values: 567.1 574.5 575.6 582.6 583.8 25997.9 26564.9 36505.1 37450.3 37487.4 40188.2 40707.6 40712.4 40714.8 40765.4 6937.3 7026.2 7720.9 7874.8 7875.8 10089.4 10360.5 10374.6 10402.5 10405.7 10061.7 10175.2 10175.4 10179.0 10185.3 7144.6 7276.2 7279.2 10032.9 10154.4 9522.4 9608.5 9610.2 9616.7 9622.1 36872.4 37438.0 37457.3 37481.8 37510.0 2704.7 2780.8 2948.7 3075.5 3240.8 28508.7 28579.4 28654.7 28747.1 29125.1 3390.2 3455.7 3466.3 3511.0 3556.0 207275.0 207862.0 208141.0 208703.0 208762.0 45840.5 47128.3 47141.3 53138.5 53547.5 47106.5 47565.5 63386.7 64686.7 65134.3 13725.2 13767.7 13828.9 13906.6 13919.4 10281.8 10348.1 10355.9 10359.5 10366.3 18820.4 18932.8 19066.4 19080.9 19106.2 7466.4 7546.2 7723.6 7735.8 7872.9 856.7 940.3 943.6 986.6 1060.8 26428.5 26581.3 26819.3 26980.5 27025.2 903.6 908.4 953.0 979.3 1076.3 12494.9 12838.7 13084.9 13120.3 13208.4 257175.0 261811.0 261825.0 262306.0 262441.0 44796.3 45041.3 45147.0 45311.0 45389.1 1055.6 1140.0 1220.9 1227.3 1236.9 23797.6 28980.0 31913.5 32106.0 32586.3 41263.6 41851.0 41896.8 41923.4 41988.4 161131.0 163369.2 169687.0 174898.0 175708.1 39538.8 39546.8 39754.2 39783.6 39861.6 42281.8 42576.8 42994.8 43110.8 43490.1 35757.3 36275.8 36556.6 36947.8 37726.0 36318.8 36650.3 36797.8 36839.4 36895.4 34954.3 36020.3 36169.1 36212.6 36237.8 30458.7 32710.2 32862.3 33196.5 33367.0 25192.9 25243.2 25302.5 25536.9 25739.2 10:40:23 INFO - 2015-12-03 10:40:23,805 DEBUG : BROWSER_OUTPUT: 10:40:23 INFO - 2015-12-03 10:40:23,805 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25373.36 Median:24995.95 stddev:77955.74 (311.9%) stddev-sans-first:78151.74 10:40:23 INFO - 2015-12-03 10:40:23,805 DEBUG : BROWSER_OUTPUT: Values: 327.0 328.7 329.9 337.0 339.2 12577.5 12874.1 15123.8 15532.7 16660.3 8210.4 9536.5 9803.9 12821.3 14273.8 4401.6 4524.5 4525.3 4525.3 4526.5 3314.3 3354.6 4535.9 5182.2 5207.9 5174.1 5176.1 5180.5 5198.3 5199.8 5025.4 5160.4 5165.4 5167.3 5168.5 5043.2 5045.8 5048.3 5052.7 5063.3 11632.6 11857.1 11968.8 11972.2 11973.2 1793.9 1832.1 1863.8 1872.9 1921.8 8857.5 8878.7 8951.1 9156.9 9212.7 1674.6 1678.1 1725.0 1775.3 1828.5 52687.7 54996.7 56058.4 56148.6 56206.0 9064.6 9721.0 9845.4 9940.6 10020.0 12340.5 12383.9 12437.6 12439.6 12455.4 6959.1 6981.0 7000.5 7057.4 7077.2 6702.7 6724.8 6754.2 6842.7 6899.2 4277.9 4303.8 4309.5 4315.5 4330.5 1652.9 1677.0 1683.7 1687.2 1704.8 373.0 374.1 798.8 905.4 974.2 10022.2 10396.5 15722.9 16222.0 17138.1 762.6 830.4 846.0 866.6 891.8 6668.6 9300.7 9332.4 9333.3 9595.6 470146.0 476608.0 477506.0 478560.0 484322.0 60890.1 61907.4 62051.7 63213.0 63449.0 444.5 455.1 456.8 458.0 458.3 9140.2 9434.3 9465.7 9563.8 9626.5 33253.8 33622.5 34251.5 34816.0 34954.0 43049.8 43149.4 45456.0 47373.5 49552.0 8649.7 9025.2 9127.1 9134.2 9141.6 16238.4 16397.0 16488.5 16630.8 16722.9 13965.9 14170.9 14218.9 14276.9 14427.9 13072.9 13387.3 13641.0 13700.0 14166.4 10679.0 12720.9 13356.0 13392.1 13837.0 7491.6 8765.3 8946.9 8965.4 8966.9 13073.9 13141.7 13176.2 13176.8 13784.4 10:40:23 INFO - 2015-12-03 10:40:23,805 DEBUG : BROWSER_OUTPUT: 10:40:23 INFO - 2015-12-03 10:40:23,805 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4944.40 Median:6230.99 stddev:2580.29 (41.4%) stddev-sans-first:2573.97 10:40:23 INFO - 2015-12-03 10:40:23,805 DEBUG : BROWSER_OUTPUT: Values: 1424.5 1543.1 1619.0 1650.5 1707.8 5626.2 6720.6 6957.0 6981.1 6983.4 6941.7 7129.1 7131.6 7137.2 7138.8 1721.9 1746.0 1748.2 2075.0 2126.6 1761.0 1767.5 1991.2 1998.6 2027.3 2005.8 2008.1 2008.8 2009.8 2010.2 1952.1 2012.5 2025.2 2027.6 2028.7 2042.9 2048.5 2077.7 2096.8 2099.7 6898.9 7011.4 7017.1 7020.9 7023.2 4076.8 4132.0 4146.8 4151.9 4156.6 2623.6 2638.2 2692.7 2693.8 2696.9 878.2 878.8 894.8 897.7 904.7 9685.2 9690.3 9691.3 9697.0 9713.7 3957.3 4011.4 4019.8 4076.1 4077.9 8289.5 8303.1 8312.1 8316.5 8335.9 4239.8 4241.1 4247.0 4252.9 4254.0 3815.5 3830.5 3851.2 3862.2 3868.8 3389.5 3399.2 3411.8 3434.8 3442.9 924.7 938.5 1078.7 1087.0 1097.1 868.6 875.8 878.0 882.2 987.4 6768.6 6797.1 6810.9 6817.9 6832.9 1022.5 1053.5 1054.2 1066.1 1067.0 5325.0 5374.8 5377.3 5381.5 5391.6 8407.8 8515.0 8611.8 8651.7 8713.7 8512.7 8513.3 8516.4 8608.6 8613.3 6595.5 6654.4 6694.7 6754.8 6788.6 6376.2 6442.1 6457.6 6463.1 6471.0 7433.3 7662.8 7667.3 7758.4 7760.7 7722.8 7786.9 7801.2 7954.2 7970.3 5854.7 5918.6 5920.3 5922.8 5929.3 5936.2 6329.8 6516.1 6517.1 6766.1 5844.7 6322.1 6409.5 6423.3 6544.9 6284.6 6291.6 6359.2 6390.1 6464.8 6405.4 6429.8 6433.3 6467.5 6475.4 5992.3 6009.2 6045.8 6048.5 6048.8 6130.0 6148.9 6161.7 6171.4 6177.4 10:40:23 INFO - 2015-12-03 10:40:23,805 DEBUG : BROWSER_OUTPUT: 10:40:23 INFO - 2015-12-03 10:40:23,805 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4569.61 Median:5221.11 stddev:1346.02 (25.8%) stddev-sans-first:1311.01 10:40:23 INFO - 2015-12-03 10:40:23,807 DEBUG : BROWSER_OUTPUT: Values: 295.4 298.1 305.8 305.8 308.4 5129.3 5153.8 5169.4 5236.0 5288.7 5097.3 5185.4 5219.6 5228.0 5240.6 4079.4 4089.6 4091.7 4092.9 4107.5 3901.9 3994.9 4000.1 4118.4 4119.5 4064.1 4064.5 4070.3 4074.4 4084.4 4032.7 4065.7 4066.4 4067.1 4074.4 3571.8 3576.2 3581.8 3582.0 3585.5 4951.8 5081.6 5085.9 5088.5 5123.7 4607.4 4607.4 4610.6 4612.2 4616.6 5526.6 5535.2 5536.9 5542.6 5546.1 3677.7 3754.8 3775.2 3822.8 3853.5 5708.1 5758.9 5775.6 5780.1 5787.6 3905.1 3938.5 3944.9 3945.7 3947.3 3993.1 3993.3 4004.9 4011.5 4022.4 4500.9 4582.3 4605.8 4608.2 4614.5 5502.3 5511.1 5512.8 5513.7 5518.9 1391.6 1410.4 1411.1 1411.1 1416.0 924.2 925.2 943.2 972.6 973.6 4811.5 4816.3 4816.3 4821.6 4830.4 5705.7 5709.9 5716.9 5723.0 5723.6 4810.7 4811.6 4821.9 4822.7 4823.4 2994.2 3034.7 3066.8 3068.6 3077.2 5382.7 5390.1 5394.2 5395.9 5396.1 5847.9 5856.4 5857.4 5857.5 5877.1 5375.3 5389.9 5401.3 5402.1 5404.8 5587.2 5708.9 5750.4 5759.2 5774.8 5411.0 5520.5 5564.7 5648.6 5652.5 5222.6 5413.6 5432.1 5441.9 5445.2 3828.0 3856.2 3936.4 3939.4 3941.0 5640.4 5683.7 5684.6 5697.3 5704.9 5469.6 5475.1 5488.9 5494.5 5496.0 5388.4 5464.7 5487.7 5584.0 5587.7 5456.6 5459.9 5465.3 5466.2 5469.9 5616.0 5627.5 5631.3 5632.0 5633.6 5374.2 5483.1 5483.9 5483.9 5486.5 10:40:23 INFO - 2015-12-03 10:40:23,807 DEBUG : BROWSER_OUTPUT: 10:40:23 INFO - 2015-12-03 10:40:23,807 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12362.35 Median:600.32 stddev:14883.72 (2479.3%) stddev-sans-first:14899.18 10:40:23 INFO - 2015-12-03 10:40:23,807 DEBUG : BROWSER_OUTPUT: Values: 580.3 632.4 701.8 704.7 722.1 11867.8 12011.5 12049.2 12053.0 12079.3 11304.4 11589.1 11600.3 13378.4 13479.2 772.6 783.9 783.9 784.3 784.8 618.7 624.7 772.7 781.1 782.0 815.4 816.1 820.4 822.1 822.2 635.7 643.8 815.6 817.7 820.0 593.7 599.2 600.2 600.4 601.3 11602.3 11765.3 11777.6 11791.5 11794.7 11052.6 11270.8 11447.6 11452.1 12131.9 8884.8 8961.6 9261.9 9461.4 9473.7 3050.9 3091.6 3093.3 3148.9 3167.1 44199.6 44320.3 44722.8 44823.3 44966.6 8494.3 8720.0 8854.8 8942.8 8974.3 15479.2 15613.9 15642.1 15655.8 15663.8 6191.8 6298.9 6305.8 6429.1 6483.4 3522.2 3551.5 3569.8 3606.3 3621.5 2705.9 2725.6 2733.4 2738.1 2778.2 489.8 491.3 495.5 495.8 497.0 450.9 472.9 484.9 581.2 600.6 6834.4 7266.0 7632.0 7851.0 8302.1 449.0 464.2 513.7 605.4 612.1 3279.1 3488.9 3586.1 3609.3 3650.3 53228.5 53759.0 53804.0 53816.0 53923.7 46561.8 47354.8 47365.8 47599.0 47924.5 43275.0 43715.0 43735.8 43761.8 43910.0 6855.6 6899.8 6916.8 7015.5 7061.3 31589.4 31794.0 32111.2 32544.8 32549.5 38532.4 38788.8 38913.0 43394.3 43569.8 8450.9 8519.8 8786.3 8798.6 8860.3 9659.9 9719.3 9731.5 9770.3 9914.9 9046.2 9174.5 9180.5 9186.9 9226.8 9179.9 9395.1 9431.2 9538.0 9550.0 8781.4 8903.2 9051.3 9076.9 9094.3 7876.7 7922.3 8151.8 8267.1 8367.7 7447.6 7892.1 8103.4 8275.0 8334.9 10:40:23 INFO - 2015-12-03 10:40:23,807 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:40:23 INFO - 2015-12-03 10:40:23,807 DEBUG : BROWSER_OUTPUT: 10:40:24 INFO - 2015-12-03 10:40:24,557 INFO : Browser exited with error code: 0 10:40:24 INFO - 2015-12-03 10:40:24,576 INFO : Completed test dromaeo_css (00:18:37) 10:40:24 INFO - 2015-12-03 10:40:24,576 INFO : Starting test kraken 10:40:24 INFO - 2015-12-03 10:40:24,576 DEBUG : operating with platform_type : linux_ 10:40:24 INFO - 2015-12-03 10:40:24,576 INFO : Initialising browser for kraken test... 10:40:24 INFO - 2015-12-03 10:40:24,582 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHfpgQs/profile http://localhost:49998/getInfo.html 10:40:29 INFO - 2015-12-03 10:40:29,009 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:40:29 INFO - 2015-12-03 10:40:29,010 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:40:29 INFO - 2015-12-03 10:40:29,010 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:40:29 INFO - 2015-12-03 10:40:29,010 DEBUG : BROWSER_OUTPUT: __metrics 10:40:29 INFO - 2015-12-03 10:40:29,126 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] 10:40:29 INFO - 2015-12-03 10:40:29,203 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] 10:40:30 INFO - 2015-12-03 10:40:30,253 INFO : Browser initialized. 10:40:30 INFO - 2015-12-03 10:40:30,253 INFO : Running cycle 1/1 for kraken test... 10:40:30 INFO - 2015-12-03 10:40:30,253 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHfpgQs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:40:42 INFO - 2015-12-03 10:40:42,320 DEBUG : BROWSER_OUTPUT: RSS: Main: 144093184 10:40:42 INFO - 2015-12-03 10:40:42,320 DEBUG : BROWSER_OUTPUT: 10:40:44 INFO - 2015-12-03 10:40:44,939 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49998/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49998/tests/kraken/driver.html?testName=audio-beat-detection) 10:40:45 INFO - 2015-12-03 10:40:45,525 DEBUG : BROWSER_OUTPUT: RSS: Main: 183939072 10:40:45 INFO - 2015-12-03 10:40:45,526 DEBUG : BROWSER_OUTPUT: 10:40:48 INFO - 2015-12-03 10:40:48,249 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49998/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49998/tests/kraken/driver.html?testName=audio-dft) 10:40:48 INFO - 2015-12-03 10:40:48,830 DEBUG : BROWSER_OUTPUT: RSS: Main: 170721280 10:40:48 INFO - 2015-12-03 10:40:48,830 DEBUG : BROWSER_OUTPUT: 10:40:51 INFO - 2015-12-03 10:40:51,814 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49998/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49998/tests/kraken/driver.html?testName=audio-fft) 10:40:52 INFO - 2015-12-03 10:40:52,380 DEBUG : BROWSER_OUTPUT: RSS: Main: 155156480 10:40:52 INFO - 2015-12-03 10:40:52,380 DEBUG : BROWSER_OUTPUT: 10:40:54 INFO - 2015-12-03 10:40:54,405 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49998/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49998/tests/kraken/driver.html?testName=audio-oscillator) 10:40:54 INFO - 2015-12-03 10:40:54,978 DEBUG : BROWSER_OUTPUT: RSS: Main: 156774400 10:40:54 INFO - 2015-12-03 10:40:54,978 DEBUG : BROWSER_OUTPUT: 10:40:57 INFO - 2015-12-03 10:40:57,284 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49998/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49998/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:40:57 INFO - 2015-12-03 10:40:57,850 DEBUG : BROWSER_OUTPUT: RSS: Main: 157433856 10:40:57 INFO - 2015-12-03 10:40:57,850 DEBUG : BROWSER_OUTPUT: 10:41:00 INFO - 2015-12-03 10:41:00,829 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49998/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49998/tests/kraken/driver.html?testName=imaging-darkroom) 10:41:01 INFO - 2015-12-03 10:41:01,402 DEBUG : BROWSER_OUTPUT: RSS: Main: 157384704 10:41:01 INFO - 2015-12-03 10:41:01,402 DEBUG : BROWSER_OUTPUT: 10:41:04 INFO - 2015-12-03 10:41:04,845 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49998/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49998/tests/kraken/driver.html?testName=imaging-desaturate) 10:41:05 INFO - 2015-12-03 10:41:05,427 DEBUG : BROWSER_OUTPUT: RSS: Main: 157982720 10:41:05 INFO - 2015-12-03 10:41:05,428 DEBUG : BROWSER_OUTPUT: 10:41:08 INFO - 2015-12-03 10:41:08,266 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49998/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49998/tests/kraken/driver.html?testName=json-parse-financial) 10:41:08 INFO - 2015-12-03 10:41:08,852 DEBUG : BROWSER_OUTPUT: RSS: Main: 158507008 10:41:08 INFO - 2015-12-03 10:41:08,852 DEBUG : BROWSER_OUTPUT: 10:41:10 INFO - 2015-12-03 10:41:10,629 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49998/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49998/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:41:11 INFO - 2015-12-03 10:41:11,195 DEBUG : BROWSER_OUTPUT: RSS: Main: 166756352 10:41:11 INFO - 2015-12-03 10:41:11,195 DEBUG : BROWSER_OUTPUT: 10:41:13 INFO - 2015-12-03 10:41:13,066 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49998/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49998/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:41:13 INFO - 2015-12-03 10:41:13,659 DEBUG : BROWSER_OUTPUT: RSS: Main: 167751680 10:41:13 INFO - 2015-12-03 10:41:13,659 DEBUG : BROWSER_OUTPUT: 10:41:15 INFO - 2015-12-03 10:41:15,811 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49998/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49998/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:41:16 INFO - 2015-12-03 10:41:16,384 DEBUG : BROWSER_OUTPUT: RSS: Main: 180563968 10:41:16 INFO - 2015-12-03 10:41:16,385 DEBUG : BROWSER_OUTPUT: 10:41:18 INFO - 2015-12-03 10:41:18,906 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49998/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49998/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:41:19 INFO - 2015-12-03 10:41:19,493 DEBUG : BROWSER_OUTPUT: RSS: Main: 184909824 10:41:19 INFO - 2015-12-03 10:41:19,493 DEBUG : BROWSER_OUTPUT: 10:41:22 INFO - 2015-12-03 10:41:22,129 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49998/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49998/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:41:22 INFO - 2015-12-03 10:41:22,711 DEBUG : BROWSER_OUTPUT: RSS: Main: 184348672 10:41:22 INFO - 2015-12-03 10:41:22,712 DEBUG : BROWSER_OUTPUT: 10:41:24 INFO - 2015-12-03 10:41:24,514 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49998/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49998/tests/kraken/driver.html?testName=ai-astar) 10:41:24 INFO - 2015-12-03 10:41:24,764 DEBUG : BROWSER_OUTPUT: RSS: Main: 241233920 10:41:24 INFO - 2015-12-03 10:41:24,764 DEBUG : BROWSER_OUTPUT: 10:41:24 INFO - 2015-12-03 10:41:24,768 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:41:24 INFO - 2015-12-03 10:41:24,768 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:41:24 INFO - 2015-12-03 10:41:24,768 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:41:24 INFO - 2015-12-03 10:41:24,768 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:41:24 INFO - 2015-12-03 10:41:24,768 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;111;105;112;114;112;102;112;112;105 10:41:24 INFO - 2015-12-03 10:41:24,769 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;129;152;173;137;157;154;131;172;131 10:41:24 INFO - 2015-12-03 10:41:24,769 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;163;161;160;159;163;162;161;161 10:41:24 INFO - 2015-12-03 10:41:24,769 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;73;87;94;71;72;74;115;89;72 10:41:24 INFO - 2015-12-03 10:41:24,769 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;132;94;94;95;133;94;99;135 10:41:24 INFO - 2015-12-03 10:41:24,769 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;109;109;110;109;109;109;109 10:41:24 INFO - 2015-12-03 10:41:24,769 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;148;147;147;146;147;146;147;147 10:41:24 INFO - 2015-12-03 10:41:24,769 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;96;95;95;95;96;96 10:41:24 INFO - 2015-12-03 10:41:24,770 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;70;71;69;70;78;69;78;67;68 10:41:24 INFO - 2015-12-03 10:41:24,770 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;67;68;68;68;68;67;68;68;68 10:41:24 INFO - 2015-12-03 10:41:24,770 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;85;84;85;84;84;85;86;85;86 10:41:24 INFO - 2015-12-03 10:41:24,770 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;123;129;117;125;119;128;136;126;120 10:41:24 INFO - 2015-12-03 10:41:24,770 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;154;149;147;147;150;136;148;146;146;135 10:41:24 INFO - 2015-12-03 10:41:24,770 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;75;67;68;67;71;67;70;69;70 10:41:24 INFO - 2015-12-03 10:41:24,770 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:41:24 INFO - 2015-12-03 10:41:24,770 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:41:24 INFO - 2015-12-03 10:41:24,771 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,991 10:41:24 INFO - 2015-12-03 10:41:24,771 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:41:24 INFO - 2015-12-03 10:41:24,771 DEBUG : BROWSER_OUTPUT: __startTimestamp1449168084766__endTimestamp 10:41:24 INFO - 2015-12-03 10:41:24,771 DEBUG : BROWSER_OUTPUT: 10:41:24 INFO - 2015-12-03 10:41:24,774 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:41:24 INFO - 2015-12-03 10:41:24,775 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:41:24 INFO - 2015-12-03 10:41:24,775 DEBUG : BROWSER_OUTPUT: 10:41:24 INFO - 2015-12-03 10:41:24,775 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.60 Median:112.00 stddev:4.03 (3.6%) stddev-sans-first:4.25 10:41:24 INFO - 2015-12-03 10:41:24,775 DEBUG : BROWSER_OUTPUT: Values: 111.0 111.0 105.0 112.0 114.0 112.0 102.0 112.0 112.0 105.0 10:41:24 INFO - 2015-12-03 10:41:24,775 DEBUG : BROWSER_OUTPUT: 10:41:24 INFO - 2015-12-03 10:41:24,775 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.90 Median:153.50 stddev:16.37 (10.7%) stddev-sans-first:17.29 10:41:24 INFO - 2015-12-03 10:41:24,775 DEBUG : BROWSER_OUTPUT: Values: 153.0 129.0 152.0 173.0 137.0 157.0 154.0 131.0 172.0 131.0 10:41:24 INFO - 2015-12-03 10:41:24,775 DEBUG : BROWSER_OUTPUT: 10:41:24 INFO - 2015-12-03 10:41:24,775 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.25 (0.8%) stddev-sans-first:1.30 10:41:24 INFO - 2015-12-03 10:41:24,776 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 163.0 161.0 160.0 159.0 163.0 162.0 161.0 161.0 10:41:24 INFO - 2015-12-03 10:41:24,776 DEBUG : BROWSER_OUTPUT: 10:41:24 INFO - 2015-12-03 10:41:24,776 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.10 Median:74.00 stddev:14.29 (19.3%) stddev-sans-first:14.85 10:41:24 INFO - 2015-12-03 10:41:24,776 DEBUG : BROWSER_OUTPUT: Values: 74.0 73.0 87.0 94.0 71.0 72.0 74.0 115.0 89.0 72.0 10:41:24 INFO - 2015-12-03 10:41:24,776 DEBUG : BROWSER_OUTPUT: 10:41:24 INFO - 2015-12-03 10:41:24,776 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.50 Median:94.00 stddev:18.59 (19.8%) stddev-sans-first:19.25 10:41:24 INFO - 2015-12-03 10:41:24,776 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 132.0 94.0 94.0 95.0 133.0 94.0 99.0 135.0 10:41:24 INFO - 2015-12-03 10:41:24,776 DEBUG : BROWSER_OUTPUT: 10:41:24 INFO - 2015-12-03 10:41:24,776 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 10:41:24 INFO - 2015-12-03 10:41:24,776 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 10:41:24 INFO - 2015-12-03 10:41:24,777 DEBUG : BROWSER_OUTPUT: 10:41:24 INFO - 2015-12-03 10:41:24,777 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 10:41:24 INFO - 2015-12-03 10:41:24,777 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 148.0 147.0 147.0 146.0 147.0 146.0 147.0 147.0 10:41:24 INFO - 2015-12-03 10:41:24,777 DEBUG : BROWSER_OUTPUT: 10:41:24 INFO - 2015-12-03 10:41:24,777 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 10:41:24 INFO - 2015-12-03 10:41:24,777 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 96.0 10:41:24 INFO - 2015-12-03 10:41:24,777 DEBUG : BROWSER_OUTPUT: 10:41:24 INFO - 2015-12-03 10:41:24,777 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.10 Median:70.50 stddev:3.84 (5.5%) stddev-sans-first:4.08 10:41:24 INFO - 2015-12-03 10:41:24,777 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 71.0 69.0 70.0 78.0 69.0 78.0 67.0 68.0 10:41:24 INFO - 2015-12-03 10:41:24,777 DEBUG : BROWSER_OUTPUT: 10:41:24 INFO - 2015-12-03 10:41:24,778 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 10:41:24 INFO - 2015-12-03 10:41:24,778 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 68.0 68.0 68.0 68.0 67.0 68.0 68.0 68.0 10:41:24 INFO - 2015-12-03 10:41:24,778 DEBUG : BROWSER_OUTPUT: 10:41:24 INFO - 2015-12-03 10:41:24,778 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:85.00 stddev:0.79 (0.9%) stddev-sans-first:0.78 10:41:24 INFO - 2015-12-03 10:41:24,778 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 84.0 85.0 84.0 84.0 85.0 86.0 85.0 86.0 10:41:24 INFO - 2015-12-03 10:41:24,778 DEBUG : BROWSER_OUTPUT: 10:41:24 INFO - 2015-12-03 10:41:24,778 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.20 Median:125.50 stddev:5.83 (4.6%) stddev-sans-first:5.87 10:41:24 INFO - 2015-12-03 10:41:24,778 DEBUG : BROWSER_OUTPUT: Values: 119.0 123.0 129.0 117.0 125.0 119.0 128.0 136.0 126.0 120.0 10:41:24 INFO - 2015-12-03 10:41:24,778 DEBUG : BROWSER_OUTPUT: 10:41:24 INFO - 2015-12-03 10:41:24,778 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.80 Median:147.50 stddev:5.92 (4.0%) stddev-sans-first:5.49 10:41:24 INFO - 2015-12-03 10:41:24,778 DEBUG : BROWSER_OUTPUT: Values: 154.0 149.0 147.0 147.0 150.0 136.0 148.0 146.0 146.0 135.0 10:41:24 INFO - 2015-12-03 10:41:24,779 DEBUG : BROWSER_OUTPUT: 10:41:24 INFO - 2015-12-03 10:41:24,779 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:70.00 stddev:2.46 (3.5%) stddev-sans-first:2.60 10:41:24 INFO - 2015-12-03 10:41:24,779 DEBUG : BROWSER_OUTPUT: Values: 70.0 75.0 67.0 68.0 67.0 71.0 67.0 70.0 69.0 70.0 10:41:24 INFO - 2015-12-03 10:41:24,779 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:41:24 INFO - 2015-12-03 10:41:24,779 DEBUG : BROWSER_OUTPUT: 10:41:25 INFO - 2015-12-03 10:41:25,689 INFO : Browser exited with error code: 0 10:41:25 INFO - 2015-12-03 10:41:25,738 INFO : Completed test kraken (00:01:01) 10:41:25 INFO - 2015-12-03 10:41:25,738 INFO : Starting test v8_7 10:41:25 INFO - 2015-12-03 10:41:25,738 DEBUG : operating with platform_type : linux_ 10:41:25 INFO - 2015-12-03 10:41:25,738 INFO : Initialising browser for v8_7 test... 10:41:25 INFO - 2015-12-03 10:41:25,744 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppS1O_q/profile http://localhost:49998/getInfo.html 10:41:29 INFO - 2015-12-03 10:41:29,989 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:41:29 INFO - 2015-12-03 10:41:29,989 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:41:29 INFO - 2015-12-03 10:41:29,989 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:41:29 INFO - 2015-12-03 10:41:29,989 DEBUG : BROWSER_OUTPUT: __metrics 10:41:30 INFO - 2015-12-03 10:41:30,106 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] 10:41:30 INFO - 2015-12-03 10:41:30,170 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] 10:41:31 INFO - 2015-12-03 10:41:31,314 INFO : Browser initialized. 10:41:31 INFO - 2015-12-03 10:41:31,314 INFO : Running cycle 1/1 for v8_7 test... 10:41:31 INFO - 2015-12-03 10:41:31,314 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppS1O_q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:41:43 INFO - 2015-12-03 10:41:43,281 DEBUG : BROWSER_OUTPUT: RSS: Main: 143663104 10:41:43 INFO - 2015-12-03 10:41:43,281 DEBUG : BROWSER_OUTPUT: 10:42:04 INFO - 2015-12-03 10:42:04,660 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49998/tests/v8_7/run.html (next: http://localhost:49998/tests/v8_7/run.html) 10:42:04 INFO - 2015-12-03 10:42:04,910 DEBUG : BROWSER_OUTPUT: RSS: Main: 444080128 10:42:04 INFO - 2015-12-03 10:42:04,910 DEBUG : BROWSER_OUTPUT: 10:42:04 INFO - 2015-12-03 10:42:04,910 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:42:04 INFO - 2015-12-03 10:42:04,911 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:42:04 INFO - 2015-12-03 10:42:04,911 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:42:04 INFO - 2015-12-03 10:42:04,911 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:42:04 INFO - 2015-12-03 10:42:04,911 DEBUG : BROWSER_OUTPUT: |0;Richards;166.22340425531914 10:42:04 INFO - 2015-12-03 10:42:04,911 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.11576400521125 10:42:04 INFO - 2015-12-03 10:42:04,911 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.700638711469 10:42:04 INFO - 2015-12-03 10:42:04,911 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5122.448979591837 10:42:04 INFO - 2015-12-03 10:42:04,911 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1992.03187250996 10:42:04 INFO - 2015-12-03 10:42:04,911 DEBUG : BROWSER_OUTPUT: |5;Earley;792.3930269413629 10:42:04 INFO - 2015-12-03 10:42:04,911 DEBUG : BROWSER_OUTPUT: |6;Boyer;12048.192771084337 10:42:04 INFO - 2015-12-03 10:42:04,911 DEBUG : BROWSER_OUTPUT: |7;RegExp;26815.78947368421 10:42:04 INFO - 2015-12-03 10:42:04,911 DEBUG : BROWSER_OUTPUT: |8;Splay;608.6427267194157 10:42:04 INFO - 2015-12-03 10:42:04,911 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 10:42:04 INFO - 2015-12-03 10:42:04,911 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:42:04 INFO - 2015-12-03 10:42:04,911 DEBUG : BROWSER_OUTPUT: __startTimestamp1449168124909__endTimestamp 10:42:04 INFO - 2015-12-03 10:42:04,912 DEBUG : BROWSER_OUTPUT: 10:42:04 INFO - 2015-12-03 10:42:04,912 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:42:04 INFO - 2015-12-03 10:42:04,912 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:42:04 INFO - 2015-12-03 10:42:04,912 DEBUG : BROWSER_OUTPUT: 10:42:04 INFO - 2015-12-03 10:42:04,912 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.22 Median:166.22 stddev:0.00 (0.0%) 10:42:04 INFO - 2015-12-03 10:42:04,912 DEBUG : BROWSER_OUTPUT: Values: 166.2 10:42:04 INFO - 2015-12-03 10:42:04,912 DEBUG : BROWSER_OUTPUT: 10:42:04 INFO - 2015-12-03 10:42:04,912 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.12 Median:186.12 stddev:0.00 (0.0%) 10:42:04 INFO - 2015-12-03 10:42:04,913 DEBUG : BROWSER_OUTPUT: Values: 186.1 10:42:04 INFO - 2015-12-03 10:42:04,913 DEBUG : BROWSER_OUTPUT: 10:42:04 INFO - 2015-12-03 10:42:04,913 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.70 Median:277.70 stddev:0.00 (0.0%) 10:42:04 INFO - 2015-12-03 10:42:04,914 DEBUG : BROWSER_OUTPUT: Values: 277.7 10:42:04 INFO - 2015-12-03 10:42:04,914 DEBUG : BROWSER_OUTPUT: 10:42:04 INFO - 2015-12-03 10:42:04,914 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5122.45 Median:5122.45 stddev:0.00 (0.0%) 10:42:04 INFO - 2015-12-03 10:42:04,914 DEBUG : BROWSER_OUTPUT: Values: 5122.4 10:42:04 INFO - 2015-12-03 10:42:04,914 DEBUG : BROWSER_OUTPUT: 10:42:04 INFO - 2015-12-03 10:42:04,914 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1992.03 Median:1992.03 stddev:0.00 (0.0%) 10:42:04 INFO - 2015-12-03 10:42:04,914 DEBUG : BROWSER_OUTPUT: Values: 1992.0 10:42:04 INFO - 2015-12-03 10:42:04,914 DEBUG : BROWSER_OUTPUT: 10:42:04 INFO - 2015-12-03 10:42:04,914 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:792.39 Median:792.39 stddev:0.00 (0.0%) 10:42:04 INFO - 2015-12-03 10:42:04,914 DEBUG : BROWSER_OUTPUT: Values: 792.4 10:42:04 INFO - 2015-12-03 10:42:04,914 DEBUG : BROWSER_OUTPUT: 10:42:04 INFO - 2015-12-03 10:42:04,914 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12048.19 Median:12048.19 stddev:0.00 (0.0%) 10:42:04 INFO - 2015-12-03 10:42:04,914 DEBUG : BROWSER_OUTPUT: Values: 12048.2 10:42:04 INFO - 2015-12-03 10:42:04,914 DEBUG : BROWSER_OUTPUT: 10:42:04 INFO - 2015-12-03 10:42:04,914 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26815.79 Median:26815.79 stddev:0.00 (0.0%) 10:42:04 INFO - 2015-12-03 10:42:04,915 DEBUG : BROWSER_OUTPUT: Values: 26815.8 10:42:04 INFO - 2015-12-03 10:42:04,915 DEBUG : BROWSER_OUTPUT: 10:42:04 INFO - 2015-12-03 10:42:04,915 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:608.64 Median:608.64 stddev:0.00 (0.0%) 10:42:04 INFO - 2015-12-03 10:42:04,915 DEBUG : BROWSER_OUTPUT: Values: 608.6 10:42:04 INFO - 2015-12-03 10:42:04,915 DEBUG : BROWSER_OUTPUT: 10:42:04 INFO - 2015-12-03 10:42:04,915 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 10:42:04 INFO - 2015-12-03 10:42:04,915 DEBUG : BROWSER_OUTPUT: Values: 4840.6 10:42:04 INFO - 2015-12-03 10:42:04,915 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:42:04 INFO - 2015-12-03 10:42:04,915 DEBUG : BROWSER_OUTPUT: 10:42:05 INFO - 2015-12-03 10:42:05,837 INFO : Browser exited with error code: 0 10:42:05 INFO - 2015-12-03 10:42:05,854 INFO : Completed test v8_7 (00:00:40) 10:42:05 INFO - 2015-12-03 10:42:05,965 INFO : Completed test suite (00:20:18) 10:42:05 INFO - 2015-12-03 10:42:05,966 DEBUG : Working with test: dromaeo_css 10:42:05 INFO - 2015-12-03 10:42:05,966 DEBUG : Generating results file: dromaeo_css 10:42:05 INFO - 2015-12-03 10:42:05,967 DEBUG : Working with test: kraken 10:42:05 INFO - 2015-12-03 10:42:05,967 DEBUG : Generating results file: kraken 10:42:05 INFO - 2015-12-03 10:42:05,967 INFO : javascript benchmark 10:42:05 INFO - 2015-12-03 10:42:05,967 DEBUG : Working with test: v8_7 10:42:05 INFO - 2015-12-03 10:42:05,968 DEBUG : Generating results file: v8_7 10:42:05 INFO - 2015-12-03 10:42:05,968 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:42:06 INFO - 2015-12-03 10:42:06,024 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 10:42:06 INFO - 2015-12-03 10:42:06,024 DEBUG : process_Request line: dromaeo_css 6173.71 graph.html#tests=[[72,132,35]] 10:42:06 INFO - 2015-12-03 10:42:06,024 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:42:06 INFO - 2015-12-03 10:42:06,129 DEBUG : process_Request line: kraken 1523.20 graph.html#tests=[[232,132,35]] 10:42:06 INFO - 2015-12-03 10:42:06,129 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:42:06 INFO - 2015-12-03 10:42:06,172 DEBUG : process_Request line: v8_7 19832.73 graph.html#tests=[[230,132,35]] 10:42:06 INFO - 2015-12-03 10:42:06,174 INFO : javascript benchmark 10:42:06 INFO - 2015-12-03 10:42:06,177 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2581.9968573067617, 2623.6326914232, 2630.4607555451134, 2638.6965498967625, 2657.2426858345375, 4440.1785669651135, 4523.3441151033085, 4532.229520981433, 4535.841245556406, 4555.293929440933, 4430.734155950645, 4525.275955847065, 4587.174308624446, 4605.700629459091, 4682.180618391785, 4226.260404429228, 4254.9149017019645, 4295.613394794484, 4351.738895666254, 4398.0, 4326.480822301328, 4336.21948049351, 4353.978230108845, 4356.6514678825615, 4406.449193850769, 4081.2449696806184, 4172.937405938914, 4179.247735407625, 4221.810018549173, 4344.261475549164, 4265.658747300208, 4276.486821581399, 4276.657867370603, 4280.464941882265, 4306.138772245532, 4240.257954857888, 4252.893677658052, 4253.255680255943, 4293.355996600504, 4298.828046878121, 4399.252127138394, 4471.843485478025, 4507.4591049074, 4511.706739061983, 4625.398698169251, 4903.65674402792, 4915.16442204826, 4915.778789954425, 4921.040397122562, 4957.058158949824, 4971.403431588196, 4980.950190498085, 4981.37732783402, 4981.551660350549, 4992.575631071363, 4424.225760491901, 4519.457665080211, 4521.525239849834, 4560.110778398181, 4681.391419115561, 5020.472850350734, 5060.898782024339, 5061.898762024739, 5064.974675126601, 5070.239464080344, 4849.563539281482, 4861.052094841542, 4865.172920603506, 4866.82966096192, 4909.926351104737, 4790.329353890458, 4915.0415668944215, 4917.0903382874285, 4936.580390666833, 5069.949300507022, 4898.559129678275, 4909.484504127086, 4916.041371932511, 4917.262410638433, 4961.4294356148785, 4876.122297986326, 4876.317315575822, 4876.707397556158, 4891.0, 4927.95072049282, 3996.0, 4046.3728122141115, 4118.876433706993, 4119.361498967664, 4120.031792528754, 3624.7100231981376, 3657.5610926688437, 3662.212624285791, 3665.340238756996, 3692.1692619161013, 4265.125649241898, 4275.935860962088, 4276.401303817468, 4276.72201306914, 4316.503602085801, 4739.099571081483, 4848.272759086165, 4918.926216106761, 4960.553550180501, 5014.924776128361, 4159.417681524589, 4212.410262563244, 4256.1487702459635, 4271.786410679453, 4277.871663850089, 4397.846075387346, 4409.074094440203, 4411.448568928884, 4422.29243321067, 4472.284434490466, 4723.858284251409, 4731.739754313546, 4737.549932756383, 4740.0756852414825, 4786.928196077061, 4757.167495688172, 4858.611311095033, 4863.586595139312, 4888.7311197884455, 4982.6512144149565, 4723.598494128038, 4736.123817093849, 4738.241881298975, 4754.025424787979, 4783.0, 4926.4088309403105, 4928.926066109083, 4932.30947667334, 4941.110600092018, 4978.502149785138, 4773.952260477351, 4856.78144483492, 4886.071646387317, 4888.486708895514, 5006.824761133343, 4799.688020278671, 4803.615710743202, 4819.614430845594, 4848.0546293472435, 4863.392075990501, 4752.928706069342, 4784.425868895755, 4790.065937142223, 4802.73584952831, 4842.080004799077, 4519.954800452085, 4643.303504474221, 4644.117617652635, 4679.438467383799, 4721.0, 4838.709677419366, 4845.491223421631, 4852.8301509447, 4873.829415970424, 4876.975835074674, 4689.695169813951, 4731.408573928259, 4731.787069581946, 4737.099951009297, 4778.928316075192], "unit": "ms", "name": "dojo.html", "value": 4526.731439292369}, {"lowerIsBetter": false, "replicates": [567.0530214541715, 574.5174053794811, 575.6373484704633, 582.6242073862359, 583.7548229743508, 25997.870010649945, 26564.86717566412, 36505.08737281566, 37450.25099498008, 37487.43768843469, 40188.19623607533, 40707.59292407075, 40712.38931416031, 40714.7964260179, 40765.38851917224, 6937.271586483423, 7026.227115017344, 7720.922790772104, 7874.763757087268, 7875.8424831503335, 10089.445080520569, 10360.53377598006, 10374.585016599327, 10402.47987600617, 10405.739856503573, 10061.748456288615, 10175.236857235699, 10175.38947663139, 10179.0, 10185.28702990791, 7144.607046612434, 7276.163241227274, 7279.2356802535505, 10032.899671003306, 10154.39073655583, 9522.428654280766, 9608.519574021271, 9610.231181505464, 9616.66341678045, 9622.085901839315, 36872.44691329605, 37438.0, 37457.25085498302, 37481.812590937145, 37510.0, 2704.6518220838443, 2780.7999041791777, 2948.6903875093235, 3075.5386691996155, 3240.7893486923276, 28508.71491285102, 28579.42841143186, 28654.707623390288, 28747.137585872457, 29125.126246212647, 3390.237196630763, 3455.740819438552, 3466.324066806974, 3510.982445087758, 3555.964440355589, 207275.0, 207862.0, 208141.0, 208703.0, 208762.0, 45840.5415945843, 47128.29307560389, 47141.292880606816, 53138.46861531412, 53547.464525355026, 47106.528934710215, 47565.5243447568, 63386.68306658437, 64686.676566616865, 65134.34865651378, 13725.176489410667, 13767.655808604664, 13828.861711382757, 13906.58280251594, 13919.443222271198, 10281.794364112826, 10348.068673819393, 10355.896441035493, 10359.533820978075, 10366.274360794823, 18820.43538693814, 18932.810671893105, 19066.428007159808, 19080.904595476935, 19106.2357505701, 7466.402687784964, 7546.207648196861, 7723.575203363869, 7735.839624056324, 7872.921270787218, 856.7001549457765, 940.2665920581957, 943.5981147944898, 986.6448078691665, 1060.8037513060108, 26428.47143057128, 26581.3354666131, 26819.32951676224, 26980.46039079247, 27025.189244322308, 903.6475774447971, 908.3641450984337, 952.9857052144223, 979.3046936674898, 1076.2681376663786, 12494.937525312314, 12838.743225135446, 13084.869151308365, 13120.278384688743, 13208.405621746851, 257175.0, 261811.0, 261825.0, 262306.0, 262441.0, 44796.3280550792, 45041.32438013367, 45147.0, 45311.0, 45389.09221815545, 1055.6305293147336, 1140.0423644138798, 1220.9084318676312, 1227.2881728597392, 1236.863944966053, 23797.643035354136, 28980.0, 31913.521297181025, 32106.0, 32586.34827303488, 41263.587364125975, 41851.0, 41896.79051604722, 41923.37114943339, 41988.3701744468, 161131.0, 163369.18315408347, 169687.0, 174898.0, 175708.121459397, 39538.80230598828, 39546.80226598849, 39754.20491590094, 39783.60216397799, 39861.60138398695, 42281.78859105685, 42576.78711606546, 42994.78502607467, 43110.784446078826, 43490.13019739651, 35757.28485430329, 36275.81862090673, 36556.63443365532, 36947.815260923526, 37726.0, 36318.81840590886, 36650.266994659425, 36797.81601091977, 36839.44740828836, 36895.44656830096, 34954.30091398107, 36020.27959440744, 36169.0957726059, 36212.63787362198, 36237.818810905774, 30458.695413045585, 32710.182245444055, 32862.34275314528, 33196.50205246875, 33367.0, 25192.874035629706, 25243.242702718948, 25302.459020475802, 25536.872315639048, 25739.227823165336], "unit": "ms", "name": "ext.html", "value": 17359.662827978078}, {"lowerIsBetter": false, "replicates": [327.0319853234426, 328.6975982096472, 329.86145818756137, 336.99071281511874, 339.22656343536727, 12577.496900124006, 12874.098813083088, 15123.773143402845, 15532.689346213083, 16660.333586656536, 8210.384221183405, 9536.475493847853, 9803.901960980405, 12821.294828784414, 14273.78589321161, 4401.625861801751, 4524.5249248828895, 4525.298578720303, 4525.32120181972, 4526.52471490492, 3314.320564284328, 3354.597448306207, 4535.909281814362, 5182.196759502264, 5207.86980325493, 5174.068667639824, 5176.0683077046115, 5180.507851754077, 5198.2722418861385, 5199.766010529535, 5025.447200807908, 5160.432352441228, 5165.354330708661, 5167.276581278624, 5168.483151684839, 5043.243513472972, 5045.84862454127, 5048.268001139851, 5052.722100284483, 5063.3417655704525, 11632.59285924997, 11857.110716696283, 11968.82046769299, 11972.221805582609, 11973.221740586834, 1793.8654600904983, 1832.1388947194798, 1863.8136186381253, 1872.850171986238, 1921.8462522998127, 8857.468551886843, 8878.689245876363, 8951.060138685409, 9156.908430915739, 9212.723618291462, 1674.6315810521667, 1678.127373765635, 1724.9827501724947, 1775.316503146298, 1828.4514645606264, 52687.736561316946, 54996.725016374665, 56058.43941560614, 56148.59628509279, 56206.0, 9064.637414503479, 9721.0, 9845.360051596623, 9940.552675129637, 10020.0, 12340.50637974471, 12383.938080309541, 12437.564685235973, 12439.564615238423, 12455.377231138407, 6959.095317608679, 6980.965095174492, 7000.474964377692, 7057.400120989773, 7077.186123595852, 6702.698378572976, 6724.831879202961, 6754.155730533684, 6842.692078856463, 6899.206591242071, 4277.935830962538, 4303.784810759449, 4309.482862056573, 4315.503717072514, 4330.545292744279, 1652.9090900000374, 1676.9748453773202, 1683.6801007808476, 1687.2154448181655, 1704.8209937956335, 372.97948612826553, 374.12828110502466, 798.7883210949103, 905.4069584422214, 974.2060220919927, 10022.184002592376, 10396.48017599117, 15722.921385393, 16222.0, 17138.14309284531, 762.6415584675194, 830.3647709502236, 845.9788505287418, 866.5537248317122, 891.772597987522, 6668.566543174678, 9300.674476393293, 9332.440053596805, 9333.253339732804, 9595.568199431042, 470146.0, 476608.0, 477506.0, 478560.0, 484322.0, 60890.08664870031, 61907.380926191065, 62051.689741551, 63213.0, 63449.0, 444.45998112293717, 455.0671124195386, 456.8423893756649, 458.0289785654367, 458.34685573058925, 9140.177384035469, 9434.292428067785, 9465.716028519155, 9563.760905977406, 9626.47054412014, 33253.83373083119, 33622.49566256557, 34251.4862277071, 34816.0, 34954.0, 43049.78475107605, 43149.352759708, 45456.0, 47373.52626473691, 49552.0, 8649.654013839376, 9025.187733104052, 9127.132922372364, 9134.177923986874, 9141.588628511867, 16238.431654892021, 16397.0, 16488.505344839676, 16630.833691662927, 16722.916385417993, 13965.860341396863, 14170.858291417366, 14218.928905355408, 14276.928615356857, 14427.855721443071, 13072.934635327143, 13387.330633468093, 13641.0, 13700.0, 14166.433342666178, 10679.0, 12720.936395317964, 13356.0, 13392.129511581716, 13837.0, 7491.587962661888, 8765.254953328784, 8946.910530894607, 8965.372423930263, 8966.910330896608, 13073.869261307265, 13141.671458213621, 13176.209427434385, 13176.802347964596, 13784.448622055006], "unit": "ms", "name": "jquery.html", "value": 7652.508703121121}, {"lowerIsBetter": false, "replicates": [1424.458705691837, 1543.1049991005218, 1618.9676206475872, 1650.463599330218, 1707.7950645922492, 5626.156076588513, 6720.563163394376, 6957.026016357701, 6981.057557229772, 6983.371496565308, 6941.687624056917, 7129.073220481343, 7131.643417829114, 7137.179224389197, 7138.785836424902, 1721.8708596855224, 1746.0309528211837, 1748.2045669220474, 2074.9896250518727, 2126.638471459848, 1761.0226324389957, 1767.5492749348898, 1991.2333751505703, 1998.5503261766132, 2027.2701827342146, 2005.79942005799, 2008.0863207240743, 2008.8192062714352, 2009.8090681385318, 2010.155734591475, 1952.1215453046116, 2012.5471768852037, 2025.2304124432621, 2027.5944811037778, 2028.7058376535467, 2042.9080691368777, 2048.528838367169, 2077.6779599162155, 2096.7693553709078, 2099.748030236366, 6898.862022759517, 7011.404030657401, 7017.122859642544, 7020.92979070213, 7023.227444981099, 4076.7757773322455, 4132.028973191298, 4146.751194928314, 4151.8962025949595, 4156.605122513387, 2623.5671114266124, 2638.2085374387607, 2692.744189302013, 2693.771029462498, 2696.892124315025, 878.2271600991087, 878.775912142406, 894.838928992781, 897.6813231302924, 904.6833608237064, 9685.176759975411, 9690.273229507744, 9691.321607487478, 9697.030296970317, 9713.708588742278, 3957.3074711925296, 4011.438398624195, 4019.7789121598007, 4076.062505623664, 4077.918441631151, 8289.502629842229, 8303.086660467343, 8312.127226641236, 8316.542590157478, 8335.874961875577, 4239.8092085856215, 4241.066965267636, 4246.957530424718, 4252.851150209728, 4254.0, 3815.523059617548, 3830.5211848518934, 3851.171998020439, 3862.1503269280715, 3868.7678739275734, 3389.5424117743787, 3399.201187720884, 3411.7611767176554, 3434.8110853903277, 3442.896713098611, 924.7364501117149, 938.483833891357, 1078.730317420645, 1086.9510872010778, 1097.1223021582703, 868.6395146014333, 875.8117004843989, 877.9946960730056, 882.2192359761657, 987.3779518903045, 6768.627725475048, 6797.116374871235, 6810.931890681129, 6817.863642727118, 6832.93167068323, 1022.4632068164274, 1053.5153829238636, 1054.2409465185056, 1066.072516910293, 1066.9893301067045, 5325.041492531304, 5374.811881584125, 5377.327834020747, 5381.515663590218, 5391.595630327741, 8407.789805254917, 8514.957425212959, 8611.78470538229, 8651.740447786451, 8713.738587842376, 8512.659493620185, 8513.276371508491, 8516.40385173032, 8608.612612432456, 8613.267872230805, 6595.472362211011, 6654.367835055662, 6694.665266736643, 6754.83112922171, 6788.558743681744, 6376.171097757262, 6442.065900444503, 6457.580257283262, 6463.062855885964, 6471.0, 7433.293837085468, 7662.8084297893, 7667.274863155968, 7758.4181186410115, 7760.728374506865, 7722.768316950501, 7786.88319675194, 7801.2198780121535, 7954.204579542, 7970.322522585645, 5854.736536855937, 5918.644881307136, 5920.348761636303, 5922.7927022554, 5929.258842644669, 5936.22829032223, 6329.778457753957, 6516.120323756232, 6517.087607734826, 6766.120404347404, 5844.736986835687, 6322.051692246016, 6409.519286053472, 6423.261324947504, 6544.901826472512, 6284.591501552567, 6291.622502649856, 6359.236891573041, 6390.073439351361, 6464.838379040373, 6405.356590462286, 6429.839254018687, 6433.292337842927, 6467.450266727381, 6475.384838440341, 5992.340842507234, 6009.248843894513, 6045.758169673164, 6048.4858787003595, 6048.848778780566, 6129.969350153221, 6148.877022459616, 6161.691915404302, 6171.352008039091, 6177.382261773787], "unit": "ms", "name": "mootools.html", "value": 4042.427002077641}, {"lowerIsBetter": false, "replicates": [295.37086006805504, 298.1041968883505, 305.8012292010194, 305.8409626993962, 308.3816947021222, 5129.281900533928, 5153.79384824607, 5169.353830771153, 5236.0, 5288.735563221842, 5097.286379906816, 5185.351831021122, 5219.608529360295, 5228.0, 5240.580753539717, 4079.4492743479545, 4089.591040895916, 4091.734037287567, 4092.9386059209137, 4107.54816970133, 3901.921961560767, 3994.900127496807, 4000.079981604218, 4118.4028315894175, 4119.485064366954, 4064.126212864234, 4064.4919385076864, 4070.267351876661, 4074.388841673743, 4084.407760874686, 4032.717709760318, 4065.6747460203114, 4066.3900414937702, 4067.1458993611377, 4074.429579858837, 3571.785692858437, 3576.2311103112957, 3581.767185132958, 3582.0, 3585.533880595532, 4951.8266860659705, 5081.618878584084, 5085.872853178663, 5088.491150884919, 5123.666961647481, 4607.35497030416, 4607.424071991001, 4610.585047345721, 4612.215923293048, 4616.630669546428, 5526.640768350085, 5535.169724541311, 5536.944630553683, 5542.5565954723525, 5546.140348246028, 3677.7425580209397, 3754.81225938702, 3775.207206486641, 3822.751521151144, 3853.460515527828, 5708.086706127041, 5758.88482230353, 5775.5957083004205, 5780.132980052984, 5787.594868359217, 3905.1018265799025, 3938.4879965604287, 3944.901377465529, 3945.704072194597, 3947.2697550953167, 3993.0616305168264, 3993.281209382281, 4004.8798536043964, 4011.498562679665, 4022.4368588397647, 4500.89728016638, 4582.335561343587, 4605.769711514478, 4608.239640459354, 4614.538546145359, 5502.312210973629, 5511.090670039479, 5512.80705175317, 5513.724313784295, 5518.91721624176, 1391.6033930329806, 1410.379433049455, 1411.0686946615185, 1411.082796182469, 1415.985840141606, 924.1543987251724, 925.2089463508603, 943.2029934705163, 972.6255391674256, 973.6300205921705, 4811.49479304675, 4816.277558366203, 4816.277558366273, 4821.590164835958, 4830.372051633335, 5705.74324155414, 5709.885802283931, 5716.857078573069, 5722.971385143048, 5723.6279641823985, 4810.687305325143, 4811.591014763784, 4821.927671084936, 4822.734749588736, 4823.397075365579, 2994.2215024093894, 3034.726874581254, 3066.7546596272246, 3068.601081859344, 3077.2153100959113, 5382.650127741685, 5390.137577987582, 5394.190871369326, 5395.919061214085, 5396.055690254189, 5847.853803654943, 5856.414358564195, 5857.384974577608, 5857.531397488191, 5877.089051197071, 5375.3280839895015, 5389.946100539023, 5401.3248343957, 5402.135658294654, 5404.756785944642, 5587.161925711176, 5708.942910571007, 5750.396208398058, 5759.164921086335, 5774.797882074107, 5410.97294513525, 5520.53075488588, 5564.721763911869, 5648.63283886546, 5652.519535839499, 5222.608304377263, 5413.648112872651, 5432.103702888979, 5441.918371224356, 5445.237666726741, 3828.0238539172333, 3856.151646637735, 3936.4095385692376, 3939.4287828265315, 3940.9950462631846, 5640.435956404327, 5683.658980461186, 5684.602077854511, 5697.287839020122, 5704.885902282014, 5469.589780766379, 5475.123980163155, 5488.862778430571, 5494.532964698045, 5496.038193316233, 5388.434214407431, 5464.699441530754, 5487.670739755627, 5583.972080139573, 5587.720613969204, 5456.61803673739, 5459.918101228564, 5465.289512363367, 5466.234727138124, 5469.9179512306555, 5616.0, 5627.52166065889, 5631.2960879890015, 5632.0, 5633.577481688808, 5374.247605335335, 5483.067878460751, 5483.917741233964, 5483.917741233964, 5486.451354864482], "unit": "ms", "name": "prototype.html", "value": 4136.953221996125}, {"lowerIsBetter": false, "replicates": [580.2946948015679, 632.4434497642077, 701.7719241246596, 704.7286794584084, 722.1074840646033, 11867.821982670266, 12011.459484323204, 12049.216800907945, 12053.0, 12079.335636539998, 11304.434778261095, 11589.130815188873, 11600.3039817611, 13378.397972091256, 13479.191248525096, 772.636860675483, 783.8902553642466, 783.9098503672094, 784.3372350363962, 784.7606480023591, 618.7308520793447, 624.6938999890067, 772.7102336623766, 781.0744268042388, 781.9569923654196, 815.4047545291941, 816.0941355095839, 820.3806126374578, 822.1203312455675, 822.1942496353577, 635.6503922842418, 643.7907680004017, 815.64927081355, 817.709713051867, 820.0323618130603, 593.6823799267371, 599.2090440618385, 600.2466904035451, 600.3966014155745, 601.2814686449694, 11602.303861768321, 11765.294082355085, 11777.587784427504, 11791.469383877746, 11794.705132371759, 11052.613158539492, 11270.774584508346, 11447.599962113878, 11452.083833293316, 12131.93934030333, 8884.822303553958, 8961.59672814725, 9261.907380926172, 9461.38500997433, 9473.715788526355, 3050.86271117798, 3091.5980922480157, 3093.334932989418, 3148.889788857402, 3167.0657156138996, 44199.558004419865, 44320.3351949721, 44722.77638611786, 44823.32765008527, 44966.55033449689, 8494.320454363637, 8719.956400218085, 8854.822903541894, 8942.776430589158, 8974.326925480615, 15479.22603869802, 15613.921930390276, 15642.139682317582, 15655.84344156544, 15663.765043524356, 6191.845203869849, 6298.905516417258, 6305.842353941096, 6429.1320671709655, 6483.384078512534, 3522.225110475691, 3551.4672799080345, 3569.839357228931, 3606.2607165531003, 3621.492990981265, 2705.9323516912236, 2725.6320396746187, 2733.3986522964915, 2738.0690565207924, 2778.1804367711575, 489.83590497183843, 491.33178876727624, 495.51439589202784, 495.8363739965803, 496.98012079516417, 450.8692479181066, 472.87468820762524, 484.9300562617822, 581.1979468333673, 600.5705920266943, 6834.419074378733, 7266.0, 7632.0, 7851.0, 8302.086770455246, 448.97755112244255, 464.21547584581947, 513.6584171525968, 605.3825098399695, 612.0941007309208, 3279.1310302769784, 3488.8778892738633, 3586.085548185196, 3609.296187243515, 3650.2699460108083, 53228.467715323124, 53759.0, 53804.0, 53816.0, 53923.73038134863, 46561.76719116451, 47354.76322618365, 47365.76317118392, 47599.0, 47924.52075479201, 43275.0, 43715.0, 43735.78132109319, 43761.78119109448, 43910.0, 6855.5886646801355, 6899.75850845218, 6916.757913473004, 7015.508914376149, 7061.329173728487, 31589.36821263608, 31794.0, 32111.197220069684, 32544.83727581347, 32549.511757323184, 38532.42201366926, 38788.80605596954, 38913.0, 43394.349084763126, 43569.78215108904, 8450.915490845013, 8519.829603408021, 8786.297096232158, 8798.648054077765, 8860.29117670572, 9659.855102173333, 9719.319647624598, 9731.464769437465, 9770.31607787448, 9914.900850991398, 9046.231070359094, 9174.54127293646, 9180.540972951192, 9186.862197067183, 9226.769330766785, 9179.862302065341, 9395.107464790834, 9431.245500360092, 9538.0, 9549.99725028862, 8781.385303028983, 8903.19871211594, 9051.275897928019, 9076.863847042432, 9094.317926155432, 7876.72431464896, 7922.326602238874, 8151.755447336589, 8267.131951145284, 8367.665293388196, 7447.562323163804, 7892.131865494676, 8103.351731861319, 8275.04836943735, 8334.874976875473], "unit": "ms", "name": "yui.html", "value": 5505.2462966140265}], "name": "dromaeo_css", "value": 6173.707551312392}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 111.0, 105.0, 112.0, 114.0, 112.0, 102.0, 112.0, 112.0, 105.0], "unit": "ms", "name": "ai-astar", "value": 109.6}, {"lowerIsBetter": true, "replicates": [153.0, 129.0, 152.0, 173.0, 137.0, 157.0, 154.0, 131.0, 172.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.9}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 163.0, 161.0, 160.0, 159.0, 163.0, 162.0, 161.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 87.0, 94.0, 71.0, 72.0, 74.0, 115.0, 89.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 82.1}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 132.0, 94.0, 94.0, 95.0, 133.0, 94.0, 99.0, 135.0], "unit": "ms", "name": "audio-oscillator", "value": 106.5}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 148.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 71.0, 69.0, 70.0, 78.0, 69.0, 78.0, 67.0, 68.0], "unit": "ms", "name": "json-parse-financial", "value": 71.1}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 68.0, 68.0, 68.0, 67.0, 68.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 84.0, 85.0, 84.0, 84.0, 85.0, 86.0, 85.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.8}, {"lowerIsBetter": true, "replicates": [119.0, 123.0, 129.0, 117.0, 125.0, 119.0, 128.0, 136.0, 126.0, 120.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.2}, {"lowerIsBetter": true, "replicates": [154.0, 149.0, 147.0, 147.0, 150.0, 136.0, 148.0, 146.0, 146.0, 135.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.8}, {"lowerIsBetter": true, "replicates": [70.0, 75.0, 67.0, 68.0, 67.0, 71.0, 67.0, 70.0, 69.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.4}], "name": "kraken", "value": 1523.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.22340425531914], "unit": "score", "name": "Richards", "value": 212.37683199999995}, {"lowerIsBetter": false, "replicates": [186.11576400521125], "unit": "score", "name": "DeltaBlue", "value": 355.2520139999999}, {"lowerIsBetter": false, "replicates": [277.700638711469], "unit": "score", "name": "Encrypt", "value": 958.5177809999998}, {"lowerIsBetter": false, "replicates": [5122.448979591837], "unit": "score", "name": "Decrypt", "value": 51.96362151394425}, {"lowerIsBetter": false, "replicates": [1992.03187250996], "unit": "score", "name": "RayTrace", "value": 371.474478}, {"lowerIsBetter": false, "replicates": [792.3930269413629], "unit": "score", "name": "Earley", "value": 841.0763060000003}, {"lowerIsBetter": false, "replicates": [12048.192771084337], "unit": "score", "name": "Boyer", "value": 55.31642899999996}, {"lowerIsBetter": false, "replicates": [26815.78947368421], "unit": "score", "name": "RegExp", "value": 33.97196270853777}, {"lowerIsBetter": false, "replicates": [608.6427267194157], "unit": "score", "name": "Splay", "value": 133.88971299999997}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19832.73085415646}]} 10:42:06 INFO - RETURN: dromaeo_css: 6173.71 10:42:06 INFO - RETURN: kraken: 1523.20 10:42:06 INFO - RETURN: v8_7: 19832.73 10:42:06 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19832.73"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1523.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6173.71"}}} 10:42:06 INFO - Return code: 0 10:42:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:42:06 ERROR - # TBPL SUCCESS # 10:42:06 INFO - Running post-action listener: _resource_record_post_action 10:42:06 INFO - Running post-run listener: _resource_record_post_run 10:42:07 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 0; Write bytes: 519462912; Read time: 0; Write time: 518532 10:42:07 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 231088128; Read time: 0; Write time: 328888 10:42:07 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 0; Write bytes: 273375232; Read time: 0; Write time: 185856 10:42:07 INFO - Running post-run listener: _upload_blobber_files 10:42:07 INFO - Blob upload gear active. 10:42:07 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:42:07 INFO - Copying logs to upload dir... 10:42:07 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1267.075863 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-12-03 10:42:07.354098) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 10:42:07.357568) ========= 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=447a3abc0420b6a47dd38cba000001bf-1449166858.627147-1782568763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/5xnCYh_UQbycxpOtMwk46w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010047 build_url: 'https://queue.taskcluster.net/v1/task/5xnCYh_UQbycxpOtMwk46w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 10:42:07.409587) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 10:42:07.409930) ========= 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=447a3abc0420b6a47dd38cba000001bf-1449166858.627147-1782568763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004514 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 10:42:07.460653) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 10:42:07.461010) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 10:42:07.461323) ========= ========= Total master_lag: 0.23 =========