builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-035 starttime: 1449787194.39 results: success (0) buildid: 20151210135938 builduid: 5d38158cbe8b45708e0570c48bc503e7 revision: 6320b1962b04ab3a905586f938c823ef6a557ea5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-10 14:39:54.394787) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-10 14:39:54.395641) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-10 14:39:54.396009) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1449787102.767408-465478612 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006352 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-10 14:39:54.432625) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-10 14:39:54.433583) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-10 14:39:54.460014) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 14:39:54.460371) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1449787102.767408-465478612 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004561 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 14:39:54.511071) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-10 14:39:54.511428) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-10 14:39:54.511820) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 14:39:54.512149) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1449787102.767408-465478612 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-10 14:39:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.9M=0s 2015-12-10 14:39:56 (42.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.138264 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 14:39:54.667735) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 14:39:54.668136) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1449787102.767408-465478612 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014514 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 14:39:54.719613) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 14:39:54.720173) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6320b1962b04ab3a905586f938c823ef6a557ea5 --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 6320b1962b04ab3a905586f938c823ef6a557ea5 --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=0d7d1540fd7fba0c6b8b7f12000001dc-1449787102.767408-465478612 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-10 14:39:56,323 truncating revision to first 12 chars 2015-12-10 14:39:56,323 Setting DEBUG logging. 2015-12-10 14:39:56,324 attempt 1/10 2015-12-10 14:39:56,324 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6320b1962b04?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-10 14:39:56,561 unpacking tar archive at: fx-team-6320b1962b04/testing/mozharness/ program finished with exit code 0 elapsedTime=0.557741 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 14:39:55.291661) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-10 14:39:55.292053) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-10 14:39:55.302110) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-10 14:39:55.302472) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-10 14:39:55.302939) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-10 14:39:55.303291) ========= /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=0d7d1540fd7fba0c6b8b7f12000001dc-1449787102.767408-465478612 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:39:56 INFO - MultiFileLogger online at 20151210 14:39:56 in /builds/slave/test 14:39:56 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 14:39:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:39:56 INFO - {'append_to_log': False, 14:39:56 INFO - 'base_work_dir': '/builds/slave/test', 14:39:56 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:39:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:39:56 INFO - 'branch': 'Fx-Team-Non-PGO', 14:39:56 INFO - 'buildbot_json_path': 'buildprops.json', 14:39:56 INFO - 'config_files': ('talos/linux_config.py',), 14:39:56 INFO - 'default_actions': ('clobber', 14:39:56 INFO - 'read-buildbot-config', 14:39:56 INFO - 'download-and-extract', 14:39:56 INFO - 'populate-webroot', 14:39:56 INFO - 'create-virtualenv', 14:39:56 INFO - 'install', 14:39:56 INFO - 'run-tests'), 14:39:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:39:56 INFO - 'download_minidump_stackwalk': True, 14:39:56 INFO - 'download_symbols': 'ondemand', 14:39:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:39:56 INFO - 'tooltool.py': '/tools/tooltool.py', 14:39:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:39:56 INFO - '/tools/misc-python/virtualenv.py')}, 14:39:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:39:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:39:56 INFO - 'installer_path': 'installer.exe', 14:39:56 INFO - 'log_level': 'info', 14:39:56 INFO - 'log_name': 'talos', 14:39:56 INFO - 'log_to_console': True, 14:39:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:39:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:39:56 INFO - 'opt_config_files': (), 14:39:56 INFO - 'pip_index': False, 14:39:56 INFO - 'sps_profile': False, 14:39:56 INFO - 'sps_profile_interval': 0, 14:39:56 INFO - 'suite': 'dromaeojs', 14:39:56 INFO - 'system_bits': '64', 14:39:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:39:56 INFO - 'title': 'talos-linux64-ix-035', 14:39:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:39:56 INFO - 'use_talos_json': True, 14:39:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:39:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:39:56 INFO - 'work_dir': 'build'} 14:39:56 INFO - ##### 14:39:56 INFO - ##### Running clobber step. 14:39:56 INFO - ##### 14:39:56 INFO - Running pre-action listener: _resource_record_pre_action 14:39:56 INFO - Running main action method: clobber 14:39:56 INFO - rmtree: /builds/slave/test/build 14:39:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:39:57 INFO - Running post-action listener: _resource_record_post_action 14:39:57 INFO - ##### 14:39:57 INFO - ##### Running read-buildbot-config step. 14:39:57 INFO - ##### 14:39:57 INFO - Running pre-action listener: _resource_record_pre_action 14:39:57 INFO - Running main action method: read_buildbot_config 14:39:57 INFO - Using buildbot properties: 14:39:57 INFO - { 14:39:57 INFO - "properties": { 14:39:57 INFO - "buildnumber": 2200, 14:39:57 INFO - "product": "firefox", 14:39:57 INFO - "script_repo_revision": "production", 14:39:57 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:39:57 INFO - "repository": "", 14:39:57 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 14:39:57 INFO - "buildid": "20151210135938", 14:39:57 INFO - "slavename": "talos-linux64-ix-035", 14:39:57 INFO - "pgo_build": "False", 14:39:57 INFO - "basedir": "/builds/slave/test", 14:39:57 INFO - "project": "", 14:39:57 INFO - "platform": "ubuntu64_hw", 14:39:57 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:39:57 INFO - "slavebuilddir": "test", 14:39:57 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:39:57 INFO - "branch": "fx-team", 14:39:57 INFO - "repo_path": "integration/fx-team", 14:39:57 INFO - "stage_platform": "linux64", 14:39:57 INFO - "builduid": "5d38158cbe8b45708e0570c48bc503e7", 14:39:57 INFO - "revision": "6320b1962b04ab3a905586f938c823ef6a557ea5" 14:39:57 INFO - }, 14:39:57 INFO - "sourcestamp": { 14:39:57 INFO - "repository": "", 14:39:57 INFO - "hasPatch": false, 14:39:57 INFO - "project": "", 14:39:57 INFO - "branch": "fx-team-linux64-talos", 14:39:57 INFO - "changes": [ 14:39:57 INFO - { 14:39:57 INFO - "category": null, 14:39:57 INFO - "files": [ 14:39:57 INFO - { 14:39:57 INFO - "url": null, 14:39:57 INFO - "name": "https://queue.taskcluster.net/v1/task/Mvm8tJ1sQna5ejOTgStUAQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 14:39:57 INFO - } 14:39:57 INFO - ], 14:39:57 INFO - "repository": "", 14:39:57 INFO - "rev": "6320b1962b04ab3a905586f938c823ef6a557ea5", 14:39:57 INFO - "who": "jlong@mozilla.com", 14:39:57 INFO - "when": 1449787128, 14:39:57 INFO - "number": 7276961, 14:39:57 INFO - "comments": "Bug 1230299 - avoid fetching sources twice on navigation in debugger", 14:39:57 INFO - "project": "", 14:39:57 INFO - "at": "Thu 10 Dec 2015 14:38:48", 14:39:57 INFO - "branch": "fx-team-linux64-talos", 14:39:57 INFO - "revlink": "", 14:39:57 INFO - "properties": [ 14:39:57 INFO - [ 14:39:57 INFO - "buildid", 14:39:57 INFO - "20151210135938", 14:39:57 INFO - "Change" 14:39:57 INFO - ], 14:39:57 INFO - [ 14:39:57 INFO - "builduid", 14:39:57 INFO - "5d38158cbe8b45708e0570c48bc503e7", 14:39:57 INFO - "Change" 14:39:57 INFO - ], 14:39:57 INFO - [ 14:39:57 INFO - "pgo_build", 14:39:57 INFO - "False", 14:39:57 INFO - "Change" 14:39:57 INFO - ] 14:39:57 INFO - ], 14:39:57 INFO - "revision": "6320b1962b04ab3a905586f938c823ef6a557ea5" 14:39:57 INFO - } 14:39:57 INFO - ], 14:39:57 INFO - "revision": "6320b1962b04ab3a905586f938c823ef6a557ea5" 14:39:57 INFO - } 14:39:57 INFO - } 14:39:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/Mvm8tJ1sQna5ejOTgStUAQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 14:39:57 INFO - Running post-action listener: _resource_record_post_action 14:39:57 INFO - ##### 14:39:57 INFO - ##### Running download-and-extract step. 14:39:57 INFO - ##### 14:39:57 INFO - Running pre-action listener: _resource_record_pre_action 14:39:57 INFO - Running main action method: download_and_extract 14:39:57 INFO - mkdir: /builds/slave/test/build/tests 14:39:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:57 INFO - https://queue.taskcluster.net/v1/task/Mvm8tJ1sQna5ejOTgStUAQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:39:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mvm8tJ1sQna5ejOTgStUAQ/artifacts/public/build/test_packages.json 14:39:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mvm8tJ1sQna5ejOTgStUAQ/artifacts/public/build/test_packages.json 14:39:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mvm8tJ1sQna5ejOTgStUAQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 14:39:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mvm8tJ1sQna5ejOTgStUAQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 14:39:58 INFO - Downloaded 1302 bytes. 14:39:58 INFO - Reading from file /builds/slave/test/build/test_packages.json 14:39:58 INFO - Using the following test package requirements: 14:39:58 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 14:39:58 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:39:58 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:39:58 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:39:58 INFO - u'jsshell-linux-x86_64.zip'], 14:39:58 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:39:58 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:39:58 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 14:39:58 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:39:58 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:39:58 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:39:58 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:39:58 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:39:58 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:39:58 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 14:39:58 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:39:58 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:39:58 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:39:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:58 INFO - https://queue.taskcluster.net/v1/task/Mvm8tJ1sQna5ejOTgStUAQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:39:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mvm8tJ1sQna5ejOTgStUAQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:39:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mvm8tJ1sQna5ejOTgStUAQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:39:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mvm8tJ1sQna5ejOTgStUAQ/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 14:39:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mvm8tJ1sQna5ejOTgStUAQ/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 14:39:59 INFO - Downloaded 21866925 bytes. 14:39:59 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 14:39:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:39:59 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 14:40:00 INFO - Return code: 0 14:40:00 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 14:40:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:00 INFO - https://queue.taskcluster.net/v1/task/Mvm8tJ1sQna5ejOTgStUAQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:40:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mvm8tJ1sQna5ejOTgStUAQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:40:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mvm8tJ1sQna5ejOTgStUAQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:40:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mvm8tJ1sQna5ejOTgStUAQ/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 14:40:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mvm8tJ1sQna5ejOTgStUAQ/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 14:40:01 INFO - Downloaded 21866925 bytes. 14:40:01 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 14:40:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:40:01 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 14:40:02 INFO - Return code: 0 14:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:02 INFO - https://queue.taskcluster.net/v1/task/Mvm8tJ1sQna5ejOTgStUAQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:40:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mvm8tJ1sQna5ejOTgStUAQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:40:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mvm8tJ1sQna5ejOTgStUAQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:40:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mvm8tJ1sQna5ejOTgStUAQ/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 14:40:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mvm8tJ1sQna5ejOTgStUAQ/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 14:40:04 INFO - Downloaded 11132038 bytes. 14:40:04 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 14:40:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:40:04 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 14:40:05 INFO - Return code: 0 14:40:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:05 INFO - https://queue.taskcluster.net/v1/task/Mvm8tJ1sQna5ejOTgStUAQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:40:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mvm8tJ1sQna5ejOTgStUAQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:40:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mvm8tJ1sQna5ejOTgStUAQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:40:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mvm8tJ1sQna5ejOTgStUAQ/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 14:40:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mvm8tJ1sQna5ejOTgStUAQ/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 14:40:06 INFO - Downloaded 57734364 bytes. 14:40:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Mvm8tJ1sQna5ejOTgStUAQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:40:06 INFO - mkdir: /builds/slave/test/properties 14:40:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:40:06 INFO - Writing to file /builds/slave/test/properties/build_url 14:40:06 INFO - Contents: 14:40:06 INFO - build_url:https://queue.taskcluster.net/v1/task/Mvm8tJ1sQna5ejOTgStUAQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:40:06 INFO - Running post-action listener: _resource_record_post_action 14:40:06 INFO - Running post-action listener: set_extra_try_arguments 14:40:06 INFO - ##### 14:40:06 INFO - ##### Running populate-webroot step. 14:40:06 INFO - ##### 14:40:06 INFO - Running pre-action listener: _resource_record_pre_action 14:40:06 INFO - Running main action method: populate_webroot 14:40:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:40:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:40:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:40:06 INFO - '--tppagecycles', 14:40:06 INFO - '7'], 14:40:06 INFO - 'tests': ['tsvgm']}}, 14:40:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:40:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:40:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:40:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:40:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:40:06 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:40:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:40:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:40:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:40:06 INFO - 'talos_options': ['--e10s'], 14:40:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:40:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:40:06 INFO - 'tests': ['damp', 'tps']}, 14:40:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:40:06 INFO - 'talos_options': ['--e10s'], 14:40:06 INFO - 'tests': ['damp', 'tps']}, 14:40:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:40:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:40:06 INFO - 'other': {'tests': ['a11yr', 14:40:06 INFO - 'ts_paint', 14:40:06 INFO - 'tpaint', 14:40:06 INFO - 'sessionrestore', 14:40:06 INFO - 'sessionrestore_no_auto_restore']}, 14:40:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:40:06 INFO - 'tests': ['a11yr', 14:40:06 INFO - 'ts_paint', 14:40:06 INFO - 'tpaint', 14:40:06 INFO - 'sessionrestore', 14:40:06 INFO - 'sessionrestore_no_auto_restore']}, 14:40:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:40:06 INFO - 'tests': ['a11yr', 14:40:06 INFO - 'ts_paint', 14:40:06 INFO - 'tpaint', 14:40:06 INFO - 'sessionrestore', 14:40:06 INFO - 'sessionrestore_no_auto_restore']}, 14:40:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:40:06 INFO - 'tests': ['a11yr', 14:40:06 INFO - 'ts_paint', 14:40:06 INFO - 'tpaint', 14:40:06 INFO - 'sessionrestore', 14:40:06 INFO - 'sessionrestore_no_auto_restore']}, 14:40:06 INFO - 'other_l64': {'tests': ['a11yr', 14:40:06 INFO - 'ts_paint', 14:40:06 INFO - 'tpaint', 14:40:06 INFO - 'sessionrestore', 14:40:06 INFO - 'sessionrestore_no_auto_restore']}, 14:40:06 INFO - 'other_nol64': {'tests': ['a11yr', 14:40:06 INFO - 'ts_paint', 14:40:06 INFO - 'tpaint', 14:40:06 INFO - 'sessionrestore', 14:40:06 INFO - 'sessionrestore_no_auto_restore']}, 14:40:06 INFO - 'svgr': {'tests': ['tsvgx', 14:40:06 INFO - 'tsvgr_opacity', 14:40:06 INFO - 'tart', 14:40:06 INFO - 'tscrollx', 14:40:06 INFO - 'cart']}, 14:40:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:40:06 INFO - 'tests': ['tsvgx', 14:40:06 INFO - 'tsvgr_opacity', 14:40:06 INFO - 'tart', 14:40:06 INFO - 'tscrollx', 14:40:06 INFO - 'cart']}, 14:40:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:40:06 INFO - 'tests': ['tp5o']}, 14:40:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:40:06 INFO - 'talos_options': ['--e10s'], 14:40:06 INFO - 'tests': ['tp5o']}, 14:40:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:40:06 INFO - 'talos_options': ['--xperf_path', 14:40:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:40:06 INFO - 'tests': ['tp5n']}, 14:40:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:40:06 INFO - 'talos_options': ['--e10s', 14:40:06 INFO - '--xperf_path', 14:40:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:40:06 INFO - 'tests': ['tp5n']}}, 14:40:06 INFO - 'talos.zip': {'path': '', 14:40:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:40:06 INFO - Running post-action listener: _resource_record_post_action 14:40:06 INFO - ##### 14:40:06 INFO - ##### Running create-virtualenv step. 14:40:06 INFO - ##### 14:40:06 INFO - Running pre-action listener: _resource_record_pre_action 14:40:06 INFO - Running main action method: create_virtualenv 14:40:06 INFO - Creating virtualenv /builds/slave/test/build/venv 14:40:06 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:40:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:40:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:40:06 INFO - Using real prefix '/usr' 14:40:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:40:07 INFO - Installing distribute.............................................................................................................................................................................................done. 14:40:09 INFO - Installing pip.................done. 14:40:09 INFO - Return code: 0 14:40:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:40:09 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')]} 14:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:09 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')]} 14:40:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:09 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 0x7f7792841f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c450b0>, '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 0x1c45fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c46440>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1449787102.767408-465478612', '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 14:40:09 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 14:40:09 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 14:40:09 INFO - Using env: {'DISPLAY': ':0', 14:40:09 INFO - 'HOME': '/home/cltbld', 14:40:09 INFO - 'LANG': 'en_US.UTF-8', 14:40:09 INFO - 'LANGUAGE': 'en_US:en', 14:40:09 INFO - 'LOGNAME': 'cltbld', 14:40:09 INFO - 'MAIL': '/var/mail/cltbld', 14:40:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:09 INFO - 'MOZ_NO_REMOTE': '1', 14:40:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:09 INFO - 'NO_EM_RESTART': '1', 14:40:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:09 INFO - 'PWD': '/builds/slave/test', 14:40:09 INFO - 'SHELL': '/bin/bash', 14:40:09 INFO - 'SHLVL': '1', 14:40:09 INFO - 'TERM': 'linux', 14:40:09 INFO - 'TMOUT': '86400', 14:40:09 INFO - 'USER': 'cltbld', 14:40:09 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1449787102.767408-465478612', 14:40:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:09 INFO - '_': '/tools/buildbot/bin/python'} 14:40:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:09 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 14:40:09 INFO - Cleaning up... 14:40:09 INFO - Return code: 0 14:40:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:40:09 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')]} 14:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:09 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')]} 14:40:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:09 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 0x7f7792841f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c450b0>, '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 0x1c45fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c46440>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1449787102.767408-465478612', '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 14:40:09 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 14:40:09 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 14:40:09 INFO - Using env: {'DISPLAY': ':0', 14:40:09 INFO - 'HOME': '/home/cltbld', 14:40:09 INFO - 'LANG': 'en_US.UTF-8', 14:40:09 INFO - 'LANGUAGE': 'en_US:en', 14:40:09 INFO - 'LOGNAME': 'cltbld', 14:40:09 INFO - 'MAIL': '/var/mail/cltbld', 14:40:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:09 INFO - 'MOZ_NO_REMOTE': '1', 14:40:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:09 INFO - 'NO_EM_RESTART': '1', 14:40:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:09 INFO - 'PWD': '/builds/slave/test', 14:40:09 INFO - 'SHELL': '/bin/bash', 14:40:09 INFO - 'SHLVL': '1', 14:40:09 INFO - 'TERM': 'linux', 14:40:09 INFO - 'TMOUT': '86400', 14:40:09 INFO - 'USER': 'cltbld', 14:40:09 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1449787102.767408-465478612', 14:40:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:09 INFO - '_': '/tools/buildbot/bin/python'} 14:40:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:09 INFO - Downloading/unpacking psutil>=0.7.1 14:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:11 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 14:40:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:40:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:40:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:40:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:40:11 INFO - Installing collected packages: psutil 14:40:11 INFO - Running setup.py install for psutil 14:40:11 INFO - building 'psutil._psutil_linux' extension 14:40:11 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 14:40:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:40:11 INFO - building 'psutil._psutil_posix' extension 14:40:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:40:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:40:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:40:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:40:11 INFO - Successfully installed psutil 14:40:11 INFO - Cleaning up... 14:40:11 INFO - Return code: 0 14:40:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:40: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')]} 14:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40: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')]} 14:40:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7792841f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c450b0>, '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 0x1c45fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c46440>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1449787102.767408-465478612', '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 14:40:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:40:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:40:11 INFO - Using env: {'DISPLAY': ':0', 14:40:11 INFO - 'HOME': '/home/cltbld', 14:40:11 INFO - 'LANG': 'en_US.UTF-8', 14:40:11 INFO - 'LANGUAGE': 'en_US:en', 14:40:11 INFO - 'LOGNAME': 'cltbld', 14:40:11 INFO - 'MAIL': '/var/mail/cltbld', 14:40:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:11 INFO - 'MOZ_NO_REMOTE': '1', 14:40:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:11 INFO - 'NO_EM_RESTART': '1', 14:40:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:11 INFO - 'PWD': '/builds/slave/test', 14:40:11 INFO - 'SHELL': '/bin/bash', 14:40:11 INFO - 'SHLVL': '1', 14:40:11 INFO - 'TERM': 'linux', 14:40:11 INFO - 'TMOUT': '86400', 14:40:11 INFO - 'USER': 'cltbld', 14:40:11 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1449787102.767408-465478612', 14:40:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:11 INFO - '_': '/tools/buildbot/bin/python'} 14:40:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:40:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:40:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:40:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:40:14 INFO - Installing collected packages: mozsystemmonitor 14:40:14 INFO - Running setup.py install for mozsystemmonitor 14:40:14 INFO - Successfully installed mozsystemmonitor 14:40:14 INFO - Cleaning up... 14:40:14 INFO - Return code: 0 14:40:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:40:14 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')]} 14:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:14 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')]} 14:40:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:14 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 0x7f7792841f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c450b0>, '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 0x1c45fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c46440>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1449787102.767408-465478612', '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 14:40:14 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 14:40:14 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 14:40:14 INFO - Using env: {'DISPLAY': ':0', 14:40:14 INFO - 'HOME': '/home/cltbld', 14:40:14 INFO - 'LANG': 'en_US.UTF-8', 14:40:14 INFO - 'LANGUAGE': 'en_US:en', 14:40:14 INFO - 'LOGNAME': 'cltbld', 14:40:14 INFO - 'MAIL': '/var/mail/cltbld', 14:40:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:14 INFO - 'MOZ_NO_REMOTE': '1', 14:40:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:14 INFO - 'NO_EM_RESTART': '1', 14:40:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:14 INFO - 'PWD': '/builds/slave/test', 14:40:14 INFO - 'SHELL': '/bin/bash', 14:40:14 INFO - 'SHLVL': '1', 14:40:14 INFO - 'TERM': 'linux', 14:40:14 INFO - 'TMOUT': '86400', 14:40:14 INFO - 'USER': 'cltbld', 14:40:14 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1449787102.767408-465478612', 14:40:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:14 INFO - '_': '/tools/buildbot/bin/python'} 14:40:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:14 INFO - Downloading/unpacking blobuploader==1.2.4 14:40:14 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 14:40:14 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 14:40:14 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 14:40:14 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 14:40:14 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 14:40:14 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 14:40:16 INFO - Downloading blobuploader-1.2.4.tar.gz 14:40:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:40:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:40:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:40:16 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 14:40:16 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 14:40:16 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 14:40:16 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 14:40:16 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 14:40:16 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 14:40:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:40:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:40:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:40:16 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 14:40:16 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 14:40:16 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 14:40:16 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 14:40:16 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 14:40:16 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 14:40:16 INFO - Downloading docopt-0.6.1.tar.gz 14:40:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:40:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:40:16 INFO - Installing collected packages: blobuploader, requests, docopt 14:40:16 INFO - Running setup.py install for blobuploader 14:40:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:40:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:40:17 INFO - Running setup.py install for requests 14:40:17 INFO - Running setup.py install for docopt 14:40:17 INFO - Successfully installed blobuploader requests docopt 14:40:17 INFO - Cleaning up... 14:40:17 INFO - Return code: 0 14:40:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:40:17 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')]} 14:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:17 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')]} 14:40:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:17 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 0x7f7792841f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c450b0>, '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 0x1c45fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c46440>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1449787102.767408-465478612', '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 14:40:17 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 14:40:17 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 14:40:17 INFO - Using env: {'DISPLAY': ':0', 14:40:17 INFO - 'HOME': '/home/cltbld', 14:40:17 INFO - 'LANG': 'en_US.UTF-8', 14:40:17 INFO - 'LANGUAGE': 'en_US:en', 14:40:17 INFO - 'LOGNAME': 'cltbld', 14:40:17 INFO - 'MAIL': '/var/mail/cltbld', 14:40:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:17 INFO - 'MOZ_NO_REMOTE': '1', 14:40:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:17 INFO - 'NO_EM_RESTART': '1', 14:40:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:17 INFO - 'PWD': '/builds/slave/test', 14:40:17 INFO - 'SHELL': '/bin/bash', 14:40:17 INFO - 'SHLVL': '1', 14:40:17 INFO - 'TERM': 'linux', 14:40:17 INFO - 'TMOUT': '86400', 14:40:17 INFO - 'USER': 'cltbld', 14:40:17 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1449787102.767408-465478612', 14:40:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:17 INFO - '_': '/tools/buildbot/bin/python'} 14:40:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:40:17 INFO - Running setup.py (path:/tmp/pip-FVE8ur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:40:17 INFO - Running setup.py (path:/tmp/pip-pk06JX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:40:17 INFO - Running setup.py (path:/tmp/pip-pRzfpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:40:17 INFO - Running setup.py (path:/tmp/pip-qGfGsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:40:18 INFO - Running setup.py (path:/tmp/pip-xlhAbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:40:18 INFO - Running setup.py (path:/tmp/pip-ZjyCMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:40:18 INFO - Running setup.py (path:/tmp/pip-OGaZ_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:40:18 INFO - Running setup.py (path:/tmp/pip-9LUjEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:40:18 INFO - Running setup.py (path:/tmp/pip-NmdNn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:40:18 INFO - Running setup.py (path:/tmp/pip-7GX37N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:40:18 INFO - Running setup.py (path:/tmp/pip-FeiFgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:40:18 INFO - Running setup.py (path:/tmp/pip-He6yeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:40:18 INFO - Running setup.py (path:/tmp/pip-iaOliy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:40:18 INFO - Running setup.py (path:/tmp/pip-Zadbza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:40:18 INFO - Running setup.py (path:/tmp/pip-jAWgez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:40:18 INFO - Running setup.py (path:/tmp/pip-Za9N2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:40:18 INFO - Running setup.py (path:/tmp/pip-nF5R67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:40:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:40:18 INFO - Running setup.py install for manifestparser 14:40:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:40:19 INFO - Running setup.py install for mozcrash 14:40:19 INFO - Running setup.py install for mozdebug 14:40:19 INFO - Running setup.py install for mozdevice 14:40:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:40:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:40:19 INFO - Running setup.py install for mozfile 14:40:19 INFO - Running setup.py install for mozhttpd 14:40:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:40:19 INFO - Running setup.py install for mozinfo 14:40:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:40:19 INFO - Running setup.py install for mozInstall 14:40:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:40:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:40:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:40:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:40:19 INFO - Running setup.py install for mozleak 14:40:19 INFO - Running setup.py install for mozlog 14:40:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:40:20 INFO - Running setup.py install for moznetwork 14:40:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:40:20 INFO - Running setup.py install for mozprocess 14:40:20 INFO - Running setup.py install for mozprofile 14:40:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:40:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:40:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:40:20 INFO - Running setup.py install for mozrunner 14:40:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:40:20 INFO - Running setup.py install for mozscreenshot 14:40:20 INFO - Running setup.py install for moztest 14:40:20 INFO - Running setup.py install for mozversion 14:40:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:40:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:40:20 INFO - Cleaning up... 14:40:20 INFO - Return code: 0 14:40:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:40:20 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')]} 14:40:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:20 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')]} 14:40:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:20 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 0x7f7792841f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c450b0>, '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 0x1c45fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c46440>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1449787102.767408-465478612', '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 14:40:20 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 14:40:20 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 14:40:20 INFO - Using env: {'DISPLAY': ':0', 14:40:20 INFO - 'HOME': '/home/cltbld', 14:40:20 INFO - 'LANG': 'en_US.UTF-8', 14:40:20 INFO - 'LANGUAGE': 'en_US:en', 14:40:20 INFO - 'LOGNAME': 'cltbld', 14:40:20 INFO - 'MAIL': '/var/mail/cltbld', 14:40:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:20 INFO - 'MOZ_NO_REMOTE': '1', 14:40:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:20 INFO - 'NO_EM_RESTART': '1', 14:40:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:20 INFO - 'PWD': '/builds/slave/test', 14:40:20 INFO - 'SHELL': '/bin/bash', 14:40:20 INFO - 'SHLVL': '1', 14:40:20 INFO - 'TERM': 'linux', 14:40:20 INFO - 'TMOUT': '86400', 14:40:20 INFO - 'USER': 'cltbld', 14:40:20 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1449787102.767408-465478612', 14:40:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:20 INFO - '_': '/tools/buildbot/bin/python'} 14:40:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:40:20 INFO - Running setup.py (path:/tmp/pip-IGAA3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:40:21 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)) 14:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:40:21 INFO - Running setup.py (path:/tmp/pip-uLdUWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:40:21 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)) 14:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:40:21 INFO - Running setup.py (path:/tmp/pip-ILYWSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:40:21 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)) 14:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:40:21 INFO - Running setup.py (path:/tmp/pip-I2wtAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:40:21 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)) 14:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:40:21 INFO - Running setup.py (path:/tmp/pip-CRgxJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:40:21 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)) 14:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:40:21 INFO - Running setup.py (path:/tmp/pip-8WD1dm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:40:21 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)) 14:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:40:21 INFO - Running setup.py (path:/tmp/pip-xHX3Gs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:40:21 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)) 14:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:40:21 INFO - Running setup.py (path:/tmp/pip-Hvbwmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:40:21 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)) 14:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:40:21 INFO - Running setup.py (path:/tmp/pip-9cGnB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:40:21 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)) 14:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:40:21 INFO - Running setup.py (path:/tmp/pip-XzaQmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:40:21 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)) 14:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:40:21 INFO - Running setup.py (path:/tmp/pip-PcFmW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:40:21 INFO - Running setup.py (path:/tmp/pip-sXwqod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:40:21 INFO - Running setup.py (path:/tmp/pip-ezjYVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:40:21 INFO - Running setup.py (path:/tmp/pip-vDLtds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:40:22 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)) 14:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:40:22 INFO - Running setup.py (path:/tmp/pip-leufCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:40:22 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)) 14:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:40:22 INFO - Running setup.py (path:/tmp/pip-hDJx7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:40:22 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)) 14:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:40:22 INFO - Running setup.py (path:/tmp/pip-g3zT0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:40:22 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)) 14:40:22 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)) 14:40:22 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)) 14:40:22 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)) 14:40:22 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)) 14:40:22 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)) 14:40:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:40:22 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 14:40:22 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 14:40:22 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 14:40:22 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 14:40:22 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 14:40:22 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 14:40:23 INFO - Downloading blessings-1.5.1.tar.gz 14:40:23 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 14:40:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:40:23 INFO - Installing collected packages: blessings 14:40:23 INFO - Running setup.py install for blessings 14:40:24 INFO - Successfully installed blessings 14:40:24 INFO - Cleaning up... 14:40:24 INFO - Return code: 0 14:40:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:40:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:40:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:40:24 INFO - Reading from file tmpfile_stdout 14:40:24 INFO - Current package versions: 14:40:24 INFO - argparse == 1.2.1 14:40:24 INFO - blessings == 1.5.1 14:40:24 INFO - blobuploader == 1.2.4 14:40:24 INFO - docopt == 0.6.1 14:40:24 INFO - manifestparser == 1.1 14:40:24 INFO - mozInstall == 1.12 14:40:24 INFO - mozcrash == 0.16 14:40:24 INFO - mozdebug == 0.1 14:40:24 INFO - mozdevice == 0.47 14:40:24 INFO - mozfile == 1.2 14:40:24 INFO - mozhttpd == 0.7 14:40:24 INFO - mozinfo == 0.9 14:40:24 INFO - mozleak == 0.1 14:40:24 INFO - mozlog == 3.1 14:40:24 INFO - moznetwork == 0.27 14:40:24 INFO - mozprocess == 0.22 14:40:24 INFO - mozprofile == 0.27 14:40:24 INFO - mozrunner == 6.11 14:40:24 INFO - mozscreenshot == 0.1 14:40:24 INFO - mozsystemmonitor == 0.0 14:40:24 INFO - moztest == 0.7 14:40:24 INFO - mozversion == 1.4 14:40:24 INFO - psutil == 3.1.1 14:40:24 INFO - requests == 1.2.3 14:40:24 INFO - wsgiref == 0.1.2 14:40:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:40:24 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')]} 14:40:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:24 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')]} 14:40:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:24 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 0x7f7792841f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c450b0>, '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 0x1c45fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c46440>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1449787102.767408-465478612', '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 14:40:24 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 14:40:24 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 14:40:24 INFO - Using env: {'DISPLAY': ':0', 14:40:24 INFO - 'HOME': '/home/cltbld', 14:40:24 INFO - 'LANG': 'en_US.UTF-8', 14:40:24 INFO - 'LANGUAGE': 'en_US:en', 14:40:24 INFO - 'LOGNAME': 'cltbld', 14:40:24 INFO - 'MAIL': '/var/mail/cltbld', 14:40:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:24 INFO - 'MOZ_NO_REMOTE': '1', 14:40:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:24 INFO - 'NO_EM_RESTART': '1', 14:40:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:24 INFO - 'PWD': '/builds/slave/test', 14:40:24 INFO - 'SHELL': '/bin/bash', 14:40:24 INFO - 'SHLVL': '1', 14:40:24 INFO - 'TERM': 'linux', 14:40:24 INFO - 'TMOUT': '86400', 14:40:24 INFO - 'USER': 'cltbld', 14:40:24 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1449787102.767408-465478612', 14:40:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:24 INFO - '_': '/tools/buildbot/bin/python'} 14:40:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:24 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)) 14:40:24 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)) 14:40:24 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)) 14:40:24 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)) 14:40:24 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)) 14:40:24 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)) 14:40:24 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)) 14:40:24 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)) 14:40:24 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)) 14:40:24 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)) 14:40:24 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)) 14:40:24 INFO - Cleaning up... 14:40:24 INFO - Return code: 0 14:40:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:40:24 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')]} 14:40:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:24 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')]} 14:40:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:24 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 0x7f7792841f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c450b0>, '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 0x1c45fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c46440>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1449787102.767408-465478612', '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 14:40:24 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 14:40:24 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 14:40:24 INFO - Using env: {'DISPLAY': ':0', 14:40:24 INFO - 'HOME': '/home/cltbld', 14:40:24 INFO - 'LANG': 'en_US.UTF-8', 14:40:24 INFO - 'LANGUAGE': 'en_US:en', 14:40:24 INFO - 'LOGNAME': 'cltbld', 14:40:24 INFO - 'MAIL': '/var/mail/cltbld', 14:40:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:24 INFO - 'MOZ_NO_REMOTE': '1', 14:40:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:24 INFO - 'NO_EM_RESTART': '1', 14:40:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:24 INFO - 'PWD': '/builds/slave/test', 14:40:24 INFO - 'SHELL': '/bin/bash', 14:40:24 INFO - 'SHLVL': '1', 14:40:24 INFO - 'TERM': 'linux', 14:40:24 INFO - 'TMOUT': '86400', 14:40:24 INFO - 'USER': 'cltbld', 14:40:24 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1449787102.767408-465478612', 14:40:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:24 INFO - '_': '/tools/buildbot/bin/python'} 14:40:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:24 INFO - Downloading/unpacking jsonschema 14:40:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:40:26 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 14:40:26 INFO - Downloading/unpacking functools32 (from jsonschema) 14:40: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 14:40: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 14:40: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 14:40: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 14:40: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 14:40: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 14:40:26 INFO - Downloading functools32-3.2.3-2.tar.gz 14:40:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 14:40:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:40:26 INFO - warning: no files found matching '*.txt' 14:40:26 INFO - no previously-included directories found matching 'build' 14:40:26 INFO - no previously-included directories found matching 'dist' 14:40:26 INFO - no previously-included directories found matching '.git*' 14:40:26 INFO - Installing collected packages: jsonschema, functools32 14:40:26 INFO - Running setup.py install for functools32 14:40:26 INFO - warning: no files found matching '*.txt' 14:40:26 INFO - no previously-included directories found matching 'build' 14:40:26 INFO - no previously-included directories found matching 'dist' 14:40:26 INFO - no previously-included directories found matching '.git*' 14:40:26 INFO - Successfully installed jsonschema functools32 14:40:26 INFO - Cleaning up... 14:40:26 INFO - Return code: 0 14:40:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:40:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7792841f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c450b0>, '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 0x1c45fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c46440>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1449787102.767408-465478612', '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 14:40:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:40:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:40:26 INFO - Using env: {'DISPLAY': ':0', 14:40:26 INFO - 'HOME': '/home/cltbld', 14:40:26 INFO - 'LANG': 'en_US.UTF-8', 14:40:26 INFO - 'LANGUAGE': 'en_US:en', 14:40:26 INFO - 'LOGNAME': 'cltbld', 14:40:26 INFO - 'MAIL': '/var/mail/cltbld', 14:40:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:26 INFO - 'MOZ_NO_REMOTE': '1', 14:40:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:26 INFO - 'NO_EM_RESTART': '1', 14:40:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:26 INFO - 'PWD': '/builds/slave/test', 14:40:26 INFO - 'SHELL': '/bin/bash', 14:40:26 INFO - 'SHLVL': '1', 14:40:26 INFO - 'TERM': 'linux', 14:40:26 INFO - 'TMOUT': '86400', 14:40:26 INFO - 'USER': 'cltbld', 14:40:26 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1449787102.767408-465478612', 14:40:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:26 INFO - '_': '/tools/buildbot/bin/python'} 14:40:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:27 INFO - Downloading/unpacking flake8 14:40: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 14:40: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 14:40: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 14:40: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 14:40: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 14:40: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 14:40:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:40:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 14:40:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:40: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 14:40: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 14:40: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 14:40: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 14:40: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 14:40: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 14:40:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:40:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 14:40:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:40:29 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 14:40:29 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 14:40:29 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 14:40:29 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 14:40:29 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 14:40:29 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 14:40:29 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 14:40:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:40:29 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 14:40:29 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 14:40:29 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 14:40:29 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 14:40:29 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 14:40:29 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 14:40:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 14:40:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:40:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:40:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:40:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:40:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:40:29 INFO - no previously-included directories found matching 'docs/_build' 14:40:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:40:29 INFO - Running setup.py install for pep8 14:40:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:40:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:40:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:40:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:40:29 INFO - no previously-included directories found matching 'docs/_build' 14:40:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:40:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:40:29 INFO - Cleaning up... 14:40:29 INFO - Return code: 0 14:40:29 INFO - Running post-action listener: _resource_record_post_action 14:40:29 INFO - Running post-action listener: _start_resource_monitoring 14:40:29 INFO - Starting resource monitoring. 14:40:29 INFO - ##### 14:40:29 INFO - ##### Running install step. 14:40:29 INFO - ##### 14:40:29 INFO - Running pre-action listener: _resource_record_pre_action 14:40:29 INFO - Running main action method: install 14:40:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:40:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:40:29 INFO - Reading from file tmpfile_stdout 14:40:29 INFO - Detecting whether we're running mozinstall >=1.0... 14:40:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:40:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:40:30 INFO - Reading from file tmpfile_stdout 14:40:30 INFO - Output received: 14:40:30 INFO - Usage: mozinstall [options] installer 14:40:30 INFO - Options: 14:40:30 INFO - -h, --help show this help message and exit 14:40:30 INFO - -d DEST, --destination=DEST 14:40:30 INFO - Directory to install application into. [default: 14:40:30 INFO - "/builds/slave/test"] 14:40:30 INFO - --app=APP Application being installed. [default: firefox] 14:40:30 INFO - mkdir: /builds/slave/test/build/application 14:40:30 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'] 14:40:30 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 14:40:44 INFO - Reading from file tmpfile_stdout 14:40:44 INFO - Output received: 14:40:44 INFO - /builds/slave/test/build/application/firefox/firefox 14:40:44 INFO - Running post-action listener: _resource_record_post_action 14:40:44 INFO - ##### 14:40:44 INFO - ##### Running run-tests step. 14:40:44 INFO - ##### 14:40:44 INFO - Running pre-action listener: _resource_record_pre_action 14:40:44 INFO - Running main action method: run_tests 14:40:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:40:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:40:44 INFO - Python 2.7.3 14:40:44 INFO - Return code: 0 14:40:44 INFO - grabbing minidump binary from tooltool 14:40:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:44 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c450b0>, '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 0x1c45fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c46440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:40:44 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:40:44 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:40:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:40:44 INFO - Return code: 0 14:40:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:40:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:40:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:40:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:40:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:40:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:40:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:40:45 INFO - Return code: 0 14:40:45 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/Mvm8tJ1sQna5ejOTgStUAQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost'] in /builds/slave/test/build 14:40:45 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/Mvm8tJ1sQna5ejOTgStUAQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost 14:40:45 INFO - Using env: {'DISPLAY': ':0', 14:40:45 INFO - 'HOME': '/home/cltbld', 14:40:45 INFO - 'LANG': 'en_US.UTF-8', 14:40:45 INFO - 'LANGUAGE': 'en_US:en', 14:40:45 INFO - 'LOGNAME': 'cltbld', 14:40:45 INFO - 'MAIL': '/var/mail/cltbld', 14:40:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:40:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:40:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:45 INFO - 'MOZ_NO_REMOTE': '1', 14:40:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:40:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:45 INFO - 'NO_EM_RESTART': '1', 14:40:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:45 INFO - 'PWD': '/builds/slave/test', 14:40:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:40:45 INFO - 'SHELL': '/bin/bash', 14:40:45 INFO - 'SHLVL': '1', 14:40:45 INFO - 'TERM': 'linux', 14:40:45 INFO - 'TMOUT': '86400', 14:40:45 INFO - 'USER': 'cltbld', 14:40:45 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1449787102.767408-465478612', 14:40:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:45 INFO - '_': '/tools/buildbot/bin/python'} 14:40:45 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/Mvm8tJ1sQna5ejOTgStUAQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost'] with output_timeout 3600 14:40:45 INFO - mozversion INFO | application_buildid: 20151210135938 14:40:45 INFO - mozversion INFO | application_changeset: 6320b1962b04ab3a905586f938c823ef6a557ea5 14:40:45 INFO - mozversion INFO | application_display_name: Nightly 14:40:45 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:40:45 INFO - mozversion INFO | application_name: Firefox 14:40:45 INFO - mozversion INFO | application_remotingname: firefox 14:40:45 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 14:40:45 INFO - mozversion INFO | application_vendor: Mozilla 14:40:45 INFO - mozversion INFO | application_version: 45.0a1 14:40:45 INFO - mozversion INFO | platform_buildid: 20151210135938 14:40:45 INFO - mozversion INFO | platform_changeset: 6320b1962b04ab3a905586f938c823ef6a557ea5 14:40:45 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 14:40:45 INFO - mozversion INFO | platform_version: 45.0a1 14:40:45 INFO - 2015-12-10 14:40:45,785 DEBUG : using testdate: 1449787245 14:40:45 INFO - 2015-12-10 14:40:45,785 DEBUG : actual date: 1449787245 14:40:45 INFO - 2015-12-10 14:40:45,795 INFO : starting webserver on 'localhost:41563' 14:40:45 INFO - 2015-12-10 14:40:45,796 INFO : Starting test suite talos-linux64-ix-035 14:40:45 INFO - 2015-12-10 14:40:45,796 INFO : Starting test dromaeo_css 14:40:45 INFO - 2015-12-10 14:40:45,796 DEBUG : operating with platform_type : linux_ 14:40:45 INFO - 2015-12-10 14:40:45,797 INFO : Initialising browser for dromaeo_css test... 14:40:45 INFO - 2015-12-10 14:40:45,813 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe5JiWN/profile http://localhost:41563/getInfo.html 14:40:50 INFO - 2015-12-10 14:40:50,022 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:40:50 INFO - 2015-12-10 14:40:50,022 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:40:50 INFO - 2015-12-10 14:40:50,022 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:40:50 INFO - 2015-12-10 14:40:50,023 DEBUG : BROWSER_OUTPUT: __metrics 14:40:50 INFO - 2015-12-10 14:40:50,131 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] 14:40:50 INFO - 2015-12-10 14:40:50,191 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] 14:40:51 INFO - 2015-12-10 14:40:51,283 INFO : Browser initialized. 14:40:51 INFO - 2015-12-10 14:40:51,283 INFO : Running cycle 1/1 for dromaeo_css test... 14:40:51 INFO - 2015-12-10 14:40:51,283 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe5JiWN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:41:03 INFO - 2015-12-10 14:41:03,241 DEBUG : BROWSER_OUTPUT: RSS: Main: 143044608 14:41:03 INFO - 2015-12-10 14:41:03,242 DEBUG : BROWSER_OUTPUT: 14:41:54 INFO - 2015-12-10 14:41:54,522 DEBUG : BROWSER_OUTPUT: 1449787314519 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] 14:44:06 INFO - 2015-12-10 14:44:06,421 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41563/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41563/tests/dromaeo/cssquery-ext.html) 14:44:07 INFO - 2015-12-10 14:44:07,550 DEBUG : BROWSER_OUTPUT: RSS: Main: 242352128 14:44:07 INFO - 2015-12-10 14:44:07,550 DEBUG : BROWSER_OUTPUT: 14:47:10 INFO - 2015-12-10 14:47:10,085 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41563/tests/dromaeo/cssquery-ext.html (next: http://localhost:41563/tests/dromaeo/cssquery-jquery.html) 14:47:10 INFO - 2015-12-10 14:47:10,666 DEBUG : BROWSER_OUTPUT: RSS: Main: 224948224 14:47:10 INFO - 2015-12-10 14:47:10,666 DEBUG : BROWSER_OUTPUT: 14:50:12 INFO - 2015-12-10 14:50:12,785 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41563/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41563/tests/dromaeo/cssquery-mootools.html) 14:50:13 INFO - 2015-12-10 14:50:13,371 DEBUG : BROWSER_OUTPUT: RSS: Main: 216403968 14:50:13 INFO - 2015-12-10 14:50:13,371 DEBUG : BROWSER_OUTPUT: 14:53:15 INFO - 2015-12-10 14:53:15,306 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41563/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41563/tests/dromaeo/cssquery-prototype.html) 14:53:15 INFO - 2015-12-10 14:53:15,893 DEBUG : BROWSER_OUTPUT: RSS: Main: 202711040 14:53:15 INFO - 2015-12-10 14:53:15,893 DEBUG : BROWSER_OUTPUT: 14:56:18 INFO - 2015-12-10 14:56:18,717 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41563/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41563/tests/dromaeo/cssquery-yui.html) 14:56:19 INFO - 2015-12-10 14:56:19,290 DEBUG : BROWSER_OUTPUT: RSS: Main: 208846848 14:56:19 INFO - 2015-12-10 14:56:19,290 DEBUG : BROWSER_OUTPUT: 14:59:21 INFO - 2015-12-10 14:59:21,832 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41563/tests/dromaeo/cssquery-yui.html (next: http://localhost:41563/tests/dromaeo/cssquery-dojo.html) 14:59:22 INFO - 2015-12-10 14:59:22,095 DEBUG : BROWSER_OUTPUT: RSS: Main: 256524288 14:59:22 INFO - 2015-12-10 14:59:22,095 DEBUG : BROWSER_OUTPUT: 14:59:22 INFO - 2015-12-10 14:59:22,095 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:59:22 INFO - 2015-12-10 14:59:22,095 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:59:22 INFO - 2015-12-10 14:59:22,095 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:59:22 INFO - 2015-12-10 14:59:22,095 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:59:22 INFO - 2015-12-10 14:59:22,095 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2581.9930227211385;2649.6290519327285;2679.3971356444813;2692.9461410771787;2695.838249705018;4433.490148632908;4532.63738900888;4584.472785629654;4665.04366604846;4672.0889426561835;4531.071130418264;4617.676762626617;4619.74591397473;4643.210654188788;4837.975810120954;4251.171021650764;4314.762688052156;4374.015846434559;4438.42300500936;4455.933161002571;4380.5838445347645;4422.292433210687;4431.49037860647;4456.309272062836;4486.484054333744;4159.168166366739;4176.4570605821355;4258.254805409041;4264.552222016675;4295.334223195378;4172.144710334404;4299.05420807425;4301.204277208726;4320.783960801948;4344.391785150082;4079.97960010201;4256.042390462152;4270.103278311558;4295.055087880662;4318.589733975267;4473.664475164375;4534.795934182936;4550.226461501553;4565.794539245742;4580.6335493160805;4985.227289770091;5038.949610503884;5041.72270525121;5084.313617661605;5084.339035925343;4862.3922009748785;5051.747412629354;5062.443131255596;5066.468020857794;5069.366329208849;4474.32885067236;4534.274516077412;4552.203364411214;4563.315502674625;4590.632749380042;5110.66780659256;5152.690838549699;5154.53609175176;5155.845324640191;5158.871028224249;4734.076855013308;4945.975270123627;4948.529889660476;4949.356583644103;4979.751012449363;4869.123557759637;4917.926231106536;4922.655414121049;4937.604991600663;4987.451380348159;4964.776585053609;5031.4213865405945;5036.496350365008;5043.949560504421;5087;4833.564979151894;5006.274090256892;5030.119729047402;5031.547160755549;5083.440821509631;4123.711340206157;4155.252054630196;4162.271602469556;4208.894777630584;4213.599708027732;3658.487811706363;3675.1363429594026;3681.2821499807815;3712.053426376257;3715.7213209009433;4366.737995720267;4370.541093185233;4381.737095774264;4382.912341753147;4414.050979039458;4759.286107083896;4899.902001959941;4927.113119638428;4933.555979961749;4945.975270123627;4351.564843515623;4360.018995725936;4361.258586040381;4365.541618130114;4387.122575484916;4485.596296333346;4492.707973981681;4495.977520112378;4507.504174540798;4543.977280113579;4581.450225972904;4707.976460117815;4708.317293992421;4779.187538118528;4803.855884323406;4814.566688998007;4881.219004959189;4885.633577481632;4921.950780492292;4925.655204135676;4667.696599721007;4740.265258884879;4746.098241334135;4767.261074533453;4787.54518320759;4833.3958255218095;4927.901441971212;4950.77721502526;4964.453910069961;5002.499750025114;4871.90256194867;4923.335349727741;4944.975275123601;4945.77744001528;4959.181735013683;4850.369451971221;4871.488493708252;4876.487968763229;4913.115639184981;4916.3362946001835;4618.399608050931;4825.9758701206265;4864.440589332272;4888.340074089952;4915.434725006527;4602.079584083263;4674.579287864109;4719.7404142772475;4725.8582242532775;4732.195526760528;4917.803287868445;4934.259861020875;4943.159662857395;4947.529984651453;4989.201727723546;4550.954490455186;4809.591184749335;4826.903461930812;4832.420109586872;4861.319415281792 14:59:22 INFO - 2015-12-10 14:59:22,095 DEBUG : BROWSER_OUTPUT: |1;ext.html;577.2351634084837;585.3385674188166;587.6063037764698;594.4620118792488;595.8331667133205;26276.474470510577;26449.206523804292;34783.65216347836;35309.11727206815;35373.2925341493;39222.60777392225;39643.801780991125;39644;39651.80174099133;39667;6969.4424446044195;7860.606969651523;8026.558539280337;8033.6384862681025;8038.477498962578;7089.397401220876;10102.191824654046;10329.53517091729;10331.27681062326;10332.58669653213;10010.949945250264;10112.797744045114;10115.595376184981;10117.038881306264;10118.89881101187;7150.785476435715;7343.77968660941;9942.304038717293;10021.148202402768;10251.538680759384;9929.25530585209;10082.89917100827;10085.394876307371;10086.9495652522;10092.091711745905;36743.265134697154;37306.81346593249;37318;37410.62589374126;37437.25125497502;2768.2387343480505;2776.281936217319;2838.3188034871687;2987.8954236601617;3349.882754103595;27945;27972.300692482648;28080.719192808014;28118.718812811814;28329.033935248877;3364.9495257571157;3532.1346270163976;3559.2169722660974;3570.535830342065;3656.5063716398213;214597;216905;217505;217852;218571;52330;53249.2012619811;54713.72643136759;55115;55236.72381638066;66576;67498.31254218586;67573.32426675671;67655;67672;13766.587002389944;13944.58166255014;13946.442142314194;13947.093438926437;13954.720905582035;9682.080202380763;9693.854592181124;9712;9730.805383892424;9779.266555008402;19019.524511887037;19249.51876203106;19260.518487037654;19262.903685481484;19278.71081933772;7631.818227235845;7754.961225193951;7784.8053798654355;7822.765317040498;7843.529388236724;895.3732387328896;932.5383934952242;952.6475204174361;970.9562220612728;1001.3541265883464;26117.73882261191;26251.435992208488;26537.601935970975;26651.733482665313;26770.5984410234;874.9212570868652;902.2466240688967;923.9974627529072;1004.3973615830589;1024.144839059379;13198.20810751358;13814.140647621962;13898.58304250874;13909.443622254996;13973.231472268919;264839;266707;266807;269047;269281;43829.34255986163;44156;44222.11555768867;44235;44244.55755442469;1128.4696192789377;1128.7686024364984;1153.6250718516349;1153.7750138723036;1160.825876118589;22734.886325568266;22948.655770163794;23251.418714532272;23404.414889627213;23475.530489389774;36012.27975440529;36599.26801463903;39744.40383394309;39988;40080;332362;341777;344037;344125;344729;28413.289667758472;28846.855765721037;28864.278393040342;28882.42235155243;28923.276918077216;37897.4315385275;38857.80571097126;39272.214555709295;39360.6063939357;39562.604373957045;32774.67225327716;33436.33127337488;33679.66320336765;34168.14579635429;34370.48444273288;32982.5052624206;33079.50380744339;33238.16904577405;33537.66462335443;33590.83204583961;33236.83381583077;33438.49842252417;35659.10852228715;36211.637883620824;36375;26978.603245306782;30050.24874378158;33821;35349.29301414009;35570;23421.344442113248;23552.52894942057;23603.173888913807;23630.17294394688;23858.642120367862 14:59:22 INFO - 2015-12-10 14:59:22,097 DEBUG : BROWSER_OUTPUT: |2;jquery.html;341.04677426592673;342.38712704259376;343.1969192090511;343.7748274879953;348.0376758263402;12139.696507587314;12460.314682692448;14818.110913345194;14972;15314.999999999985;12611.43248553815;14659.486917957873;15151.393944242218;15595.220238988062;15601;4852.2721591761165;4938.703677779345;4991.32617096691;5082.593392528607;5093.134167191586;3567.661072198137;3664.7068234541307;5067.138586440314;5188.818391356303;5234.7120908350025;5146.125158723026;5161.045206636784;5221.582273418117;5224.50367215114;5229.529342359187;5166.715830629314;5176.352955880515;5382.30030096085;5796.2464879565805;5801.50687191585;5140.614453915971;5144.022635699205;5164.870878228036;5166.044281807877;5170.793168273264;11757.235779674294;11901.226420282654;12251.816222756666;12255.509779608805;12257;1736.7481715151232;1742.6514697060638;1748.4841971618403;1820.0535721424785;1862.748528948588;9053.366264361497;9161.679341223025;9240.722778316662;10921.890781092166;11943.40282985856;1675.689997350494;1695.3981336625443;1784.9375271865551;1801.9909900450414;1818.254515648591;51517;54032.45967540353;54053;54060.45939540594;54116.18825717657;9537.189338906132;9632.47021413829;9697.612095516242;9722.368046076983;9871.950640246752;12337.259764414164;12402.75194496105;12445.315507647167;12458.937705311597;12491.063170262085;6986.16166060076;7072.115985501812;7093.609851458116;7122.145342558926;7154.928450715426;6777.762778302736;6797.0823938767635;6812.523123381316;6819.556728812611;6846.486513511507;4217.536071032184;4238.85164019264;4240.936385954213;4246.278132717445;4265.210935976792;1645.539249010279;1695.788026496688;1701.055913967735;1730.1176400036072;1751.6321572469924;739.4860571902476;812.4678335690132;865.7359505350803;894.6063731957918;993.2550587059706;15827.52517424479;16012.11933343654;16075.276612552463;16238.863279570553;16439.91780041092;768.2125821033374;786.1627366854282;791.7941335252875;816.0289255785597;820.4175035724583;8909.955450222707;9059.59231834569;9188.173064424234;9257.398269112486;9429.2928030398;502919.7919217226;515671;523791;528209;529738;70564;70780.99999999897;71559.28440715527;72234;72781;1062.697131317571;1069.267551727085;1071.0574694268994;1075.860138182047;1079.7300674831292;14499.827810801604;14580.927095364455;14780.260986950394;14816.40734370613;15037.548873533811;33650.83174584111;34226.48660270148;34440.483392748625;34505;34900.127496812784;44444.77777611091;45268.54731452643;45489.317660235785;46167;47869;8642.351823613128;8686.739397818075;8727.956360218159;8931.19619234272;9248.398854074463;15062.472813451477;16023.198840058183;16111.919440402722;16260.918695406921;16264.918675406547;11099.944500277446;11421.771564568828;11833.704157396134;13815.723685526435;13945;12547.874521254671;13300.135491193041;13306.46774129024;13713.588592342247;13738.450461981409;13789.24159171215;13928.930355348159;13963.720725585228;14044.438222470986;14183.219922903927;8774.692885748967;8830.116988301119;8883.33374996865;8927.196552310323;8941.46351218929;9822.55798489084;9912.405255684682;10670.46647667598;14246.501372451914;14494.637634059232 14:59:22 INFO - 2015-12-10 14:59:22,097 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1249.82502449657;1644.7532870069492;1670.690922179397;1714.4942242038594;1714.9485515434533;5996.460318571328;6205;6825.65871706414;6997.090378250833;7023.2625574314725;7028.578285302872;7045.718171273143;7094.077769889907;7098.432125429966;7113.146422429316;2039.3677959832426;2065.2255404223415;2067.111142208857;2067.8138967492923;2068.8758674479577;2087.8516815751277;2101.1700378350542;2128.4253251622054;2176.4450065233345;2181.9781802181933;2091.801278878504;2099.454141923103;2101.4326131944367;2127.6489379252403;2128.9041993110345;2073.3365323096614;2096.0882016322794;2098.58028394321;2098.8635738676935;2103.5897999890026;2052.823877268607;2087.3842216546154;2110.8944552772455;2113.228671534894;2113.9577208455744;6820.079289295931;6882.139732533434;6882.793516194522;6898.206706228748;6899.241083480813;4124.484439445069;4200.243956087903;4203.07532342884;4216.57834216579;4231.449911511515;2666.3603032997194;2681.785457163422;2684.5033668771143;2693.5151672698908;2700.9594856077174;831.8876951611516;842.6839935024366;853.4537895746727;871.111466304366;880.286967556275;9459.054094590554;9474;9487.383320084242;9496.572654230577;9509.286803489696;3881.049142959993;3895.8052097395016;3946.1910308387287;3977.184677141237;3984.940225896614;8008;8034.839303213903;8063.596820159086;8095.5142691438705;8096.987876515435;4154.626083652486;4157.64660003897;4159.168166366739;4164.895877603084;4165.208610364081;3311.1391038329725;3407.9829600851835;3794.753341032824;3798.25933942884;3872.3223435898603;3493.63316851732;3500.3524347995703;3528.5060091587197;3541.698955588752;3544.379733546619;1090.5637744902103;1094.316052467208;1097.1223021582862;1101.487808169189;1102.6636875752813;1136.3863513702672;1139.1114930354338;1140.6977151054978;1158.0619698044611;1165.7493638867684;6574.211094668574;6618.8345291368105;6653.168353955755;6705.798826035227;6720.361565651256;407.2872473171949;420.3547554503822;424.26601978576616;425.47666370364004;426.1902385467574;5167.560757335594;5223.712695801692;5261.789528418897;5268.051750684837;5278.815241466607;8340.582970851434;8348.499090054616;8553.486790792573;8587.355948303903;8626.223639872442;8498.490090594583;8551.401401901807;8559.57202139903;8565.871511927326;8566.48601083937;6457.483401327882;6557.278699343068;6580.703868325937;6640.601563906181;6655.73377064912;6317.684115794284;6336.841578960563;6356.078368636614;6364.204474440695;6390.87218255623;7629.504082234637;7643.235676432312;7716.459847810824;7749.690012399667;7803.96098019529;7131.429485641032;7385.372243359375;7394.075740532434;7947.443678942419;7968.442209045311;5696.287964004499;5804.042333015005;5831.4168583141345;6752.7298908045095;6847.520673553003;5915.822525324247;5954.46409823118;6434.549581529248;6450.322716114741;6465.547411681137;6282.120503129474;6302.401271879165;6356.269029061532;6364.140840986408;6477.4170324671;6313.2424109107205;6315.273743519554;6376.39424254695;6446.355364463704;6562.967185164043;6454.548181627429;6503.772367967098;6539.247986481616;6562.77030303937;6569.901451478136;5481.945180548143;6057;6099.359567245376;6107.8778424430375;6109.908351374644;6163.96918015407;6189.938100618936;6196.318404975539;6197.504199663926;6198.566100372931 14:59:22 INFO - 2015-12-10 14:59:22,098 DEBUG : BROWSER_OUTPUT: |4;prototype.html;309.8048229615342;318.15847084461586;320.6921355498721;320.95667084943534;323.19363188843823;5217.34783152106;5267.236250743645;5274.894502109955;5315.335583052119;5326.7070311132875;5228.686278823264;5233.3981592116825;5234.50272224139;5235.083860324437;5249.580033597313;3899.7270191086636;3985.083430810915;4000.9599904001025;4110.403991421242;4111.177764447115;4080.0819815541563;4087.7532352632434;4103.548609652936;4115.341545352744;4137.979310103446;4091.9386209206887;4096.836126554934;4097.610726980932;4100.118474527976;4103.199876024177;3913.119548101683;3961.6038396160443;4010.418489319047;4034.3948407739076;4050.5544390117066;3591.8204089795404;3599.406097993828;3628.818559072036;3628.872989445357;3630.782153070798;5073.873153171164;5077.593792496628;5085.23721441783;5089.440161582223;5098.056859481007;4687.6249900007915;4705.106029854317;4706.717596944194;4711.481737008926;4720.95279047212;5357.785688572452;5501.367342755594;5518.779248830042;5525.502704756591;5537;3953.743006704555;3956.0307724607655;3958.960410395888;3961;3961.98019009906;5793.623414478087;5801.129830525413;5802.535797136261;5807.593468457209;5811.970940145315;4082.4488694026522;4084.5302790179508;4086.162336720965;4088.9386659200136;4090.202410529918;3900.4929359183693;4010.498687664042;4017.397390391406;4137.131202447459;4142.420061191436;4612.584867361954;4624.075184963021;4624.098300831306;4628;4633.559811817872;5527.226188333637;5545.390007099216;5546.251256080458;5550.69471179089;5550.750216240279;1405.276282714403;1426.5720283914784;1426.9571912842423;1429.2925002124016;1430.1347684650636;960.5917485068958;961.7643677299106;968.8062387522383;992.9921130053002;993.9006099390003;4866.902661946741;4869.026194761062;4877.926831097537;4880.975595122001;4888.291197776302;5724.713764311768;5737.3688894221605;5741.224934633771;5749.367569567345;5756.079027355603;4835.879103022453;4862.222044472867;4871.975640121776;4882.048000639912;4889.65772395936;2869.239651492356;2961.0820645599933;3037.8481075946115;3062.892798752033;3096.922576935595;5424.077906755861;5425.484578964992;5502.8349149525575;5504;5511.889762204733;5960.403959604092;5965.582409231399;5969.611975221596;5971.641701497924;5972.790952316648;5497.340319161646;5497.780088796403;5505.119180931192;5510.559155267569;5510.91733624004;5649.12438572022;5750.913736293875;5795.855103622274;5812;5815.709214539341;5639.6334238274385;5679.091345384719;5680.835428737181;5683.976884160891;5684;5498.367687715964;5500.037493438712;5502.257195278587;5504.119340905436;5504.559635229252;4004.619561141687;4083.5303940047274;4124;4126;4131.235721391552;5728.054870946414;5764.106563482667;5766.192733017297;5769.59612827098;5771.047777116729;5532.336119665666;5539.667619942817;5540.916886246629;5543.9168412474655;5547.611667183259;5518.19986102021;5529.640573362719;5535.169724541351;5539.41836107219;5544.473275038865;5278.1027225372545;5410.323709536308;5410.377806552139;5423.810166644306;5425.484578964992;5564.721763911869;5567.331920169606;5567.7494512747835;5567.832965011056;5568.1091025435735;5234.555062819551;5326.067938110893;5416.9729151353995;5482.5613950883035;5492.148716948879 14:59:22 INFO - 2015-12-10 14:59:22,099 DEBUG : BROWSER_OUTPUT: |5;yui.html;792.3938187286725;792.4650860669047;801.6753214947948;820.1388542030866;827.1563005734151;11131.666050018503;11516.71208219795;11533.135014873886;11548;11583.710407239823;11685.29888206706;11778.29330240184;11822;11842.171048026641;11861.288322700622;633.5185259203016;634.0869148426275;789.0255534415007;806.3508875355336;808.5431731071925;813.3330668851544;814.1573471457043;821.6507984106761;821.6754382019099;822.4489591973393;840.4915026408995;850.7235148576707;851.2296371783515;851.2551517422255;853.4409961475244;663.3697986912429;663.6814329122025;840.6301227459898;851.9787005324855;855.3542075732782;635.3836778325064;635.5646382228142;636.4399328590856;636.5162476517879;636.5862189576766;12089.697757556043;12201.572944946973;12213.572524961584;12255.080868934865;12274;10777.784444311148;11500.88499115015;11555.94222028893;11888.702782430422;12070.27578345302;9482.19401350886;9578.281628877861;9590.37662551939;9689.079537444002;9786.804263914682;3164.8892288769784;3200.9679903200904;3220.1949512621845;3227.144806626246;3280.934381312384;39966;40636.79681601573;40689.186216275804;40705.796471017755;40740;8489.235968762841;8502.872456913152;8641.092685268082;8767.605457754416;8817.647294108292;15910.284037218353;15939.203039848193;15960.201989900459;15970.121643309498;15976.76034859478;6269.529785266123;6348.904766428507;6362.331955144736;6469.223693156851;6470.09418681385;3477.23500829817;3535.4520049392386;3550.2544465661986;3554.9466757998653;3559.5906470755676;2772.085211880075;2815.8732857021073;2816;2816.1270006298114;2819.5488721804413;463.51562617065247;475.59811958894676;480.9086273608003;481.4703825791601;481.94939531348706;408.96114869087387;420.46180888462817;434.5697759218351;439.4682434254524;442.5242863921233;6992.930070699228;7013.229774239249;7032.359983705815;7143.678534465961;7301.1968683444775;427.40377173842313;440.7906244533885;553.8698405874616;560.6776103740366;564.5314389057073;3264.1513206566465;3383.7293016558615;3394.3381040696827;3419.9316013679586;3449.6550344965804;48348;48945.75527122413;49053.754731226116;49073.263901041515;49091.263631045564;42374.36438453426;42636.57363426388;43224.351634725506;43412.56587434148;43499;40090.398644020366;40113.598864010986;40270.59729402727;40473.19053618911;40900.59099408968;7010.754623588354;7026.789196324118;7063.258357872555;7130.964345178241;7213.422926165789;29837;30539.38921221519;30651.386972259985;30667.386652266385;30922;35611;36187.638123618424;36234.27531449409;37232.25535489329;39985.600143998185;8359.414840961075;8886.60010299551;8905.688300909436;8930.86603700932;8943.731688049369;9509.809803804024;9882.258830587878;9912.653057142965;10054.245931555017;10109.545070471993;9047.276217902683;9064.818703625759;9116.772080698036;9122.087791220825;9135.63457461694;9561.952190239004;9625.663101791404;9648;9679.322447428895;9680.322377433793;9493.762655933657;9502.572384242587;9521.761955951157;9541.236701064037;9649.372790768577;7981.321587664881;8460.323174145931;8512.616932237941;8516.914830851612;8606.913930860612;7904.225015438022;8103.635336409758;8262.132476089924;8295.460795048302;8306.501609903426 14:59:22 INFO - 2015-12-10 14:59:22,099 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:59:22 INFO - 2015-12-10 14:59:22,099 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:59:22 INFO - 2015-12-10 14:59:22,099 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,909 14:59:22 INFO - 2015-12-10 14:59:22,100 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:59:22 INFO - 2015-12-10 14:59:22,100 DEBUG : BROWSER_OUTPUT: __startTimestamp1449788362093__endTimestamp 14:59:22 INFO - 2015-12-10 14:59:22,100 DEBUG : BROWSER_OUTPUT: 14:59:22 INFO - 2015-12-10 14:59:22,100 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:59:22 INFO - 2015-12-10 14:59:22,100 DEBUG : BROWSER_OUTPUT: Number of tests: 6 14:59:22 INFO - 2015-12-10 14:59:22,100 DEBUG : BROWSER_OUTPUT: 14:59:22 INFO - 2015-12-10 14:59:22,100 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4604.79 Median:4719.74 stddev:474.86 (10.1%) stddev-sans-first:449.02 14:59:22 INFO - 2015-12-10 14:59:22,100 DEBUG : BROWSER_OUTPUT: Values: 2582.0 2649.6 2679.4 2692.9 2695.8 4433.5 4532.6 4584.5 4665.0 4672.1 4531.1 4617.7 4619.7 4643.2 4838.0 4251.2 4314.8 4374.0 4438.4 4455.9 4380.6 4422.3 4431.5 4456.3 4486.5 4159.2 4176.5 4258.3 4264.6 4295.3 4172.1 4299.1 4301.2 4320.8 4344.4 4080.0 4256.0 4270.1 4295.1 4318.6 4473.7 4534.8 4550.2 4565.8 4580.6 4985.2 5038.9 5041.7 5084.3 5084.3 4862.4 5051.7 5062.4 5066.5 5069.4 4474.3 4534.3 4552.2 4563.3 4590.6 5110.7 5152.7 5154.5 5155.8 5158.9 4734.1 4946.0 4948.5 4949.4 4979.8 4869.1 4917.9 4922.7 4937.6 4987.5 4964.8 5031.4 5036.5 5043.9 5087.0 4833.6 5006.3 5030.1 5031.5 5083.4 4123.7 4155.3 4162.3 4208.9 4213.6 3658.5 3675.1 3681.3 3712.1 3715.7 4366.7 4370.5 4381.7 4382.9 4414.1 4759.3 4899.9 4927.1 4933.6 4946.0 4351.6 4360.0 4361.3 4365.5 4387.1 4485.6 4492.7 4496.0 4507.5 4544.0 4581.5 4708.0 4708.3 4779.2 4803.9 4814.6 4881.2 4885.6 4922.0 4925.7 4667.7 4740.3 4746.1 4767.3 4787.5 4833.4 4927.9 4950.8 4964.5 5002.5 4871.9 4923.3 4945.0 4945.8 4959.2 4850.4 4871.5 4876.5 4913.1 4916.3 4618.4 4826.0 4864.4 4888.3 4915.4 4602.1 4674.6 4719.7 4725.9 4732.2 4917.8 4934.3 4943.2 4947.5 4989.2 4551.0 4809.6 4826.9 4832.4 4861.3 14:59:22 INFO - 2015-12-10 14:59:22,100 DEBUG : BROWSER_OUTPUT: 14:59:22 INFO - 2015-12-10 14:59:22,100 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43412.11 Median:33564.25 stddev:73431.97 (218.8%) stddev-sans-first:73567.53 14:59:22 INFO - 2015-12-10 14:59:22,101 DEBUG : BROWSER_OUTPUT: Values: 577.2 585.3 587.6 594.5 595.8 26276.5 26449.2 34783.7 35309.1 35373.3 39222.6 39643.8 39644.0 39651.8 39667.0 6969.4 7860.6 8026.6 8033.6 8038.5 7089.4 10102.2 10329.5 10331.3 10332.6 10010.9 10112.8 10115.6 10117.0 10118.9 7150.8 7343.8 9942.3 10021.1 10251.5 9929.3 10082.9 10085.4 10086.9 10092.1 36743.3 37306.8 37318.0 37410.6 37437.3 2768.2 2776.3 2838.3 2987.9 3349.9 27945.0 27972.3 28080.7 28118.7 28329.0 3364.9 3532.1 3559.2 3570.5 3656.5 214597.0 216905.0 217505.0 217852.0 218571.0 52330.0 53249.2 54713.7 55115.0 55236.7 66576.0 67498.3 67573.3 67655.0 67672.0 13766.6 13944.6 13946.4 13947.1 13954.7 9682.1 9693.9 9712.0 9730.8 9779.3 19019.5 19249.5 19260.5 19262.9 19278.7 7631.8 7755.0 7784.8 7822.8 7843.5 895.4 932.5 952.6 971.0 1001.4 26117.7 26251.4 26537.6 26651.7 26770.6 874.9 902.2 924.0 1004.4 1024.1 13198.2 13814.1 13898.6 13909.4 13973.2 264839.0 266707.0 266807.0 269047.0 269281.0 43829.3 44156.0 44222.1 44235.0 44244.6 1128.5 1128.8 1153.6 1153.8 1160.8 22734.9 22948.7 23251.4 23404.4 23475.5 36012.3 36599.3 39744.4 39988.0 40080.0 332362.0 341777.0 344037.0 344125.0 344729.0 28413.3 28846.9 28864.3 28882.4 28923.3 37897.4 38857.8 39272.2 39360.6 39562.6 32774.7 33436.3 33679.7 34168.1 34370.5 32982.5 33079.5 33238.2 33537.7 33590.8 33236.8 33438.5 35659.1 36211.6 36375.0 26978.6 30050.2 33821.0 35349.3 35570.0 23421.3 23552.5 23603.2 23630.2 23858.6 14:59:22 INFO - 2015-12-10 14:59:22,102 DEBUG : BROWSER_OUTPUT: 14:59:22 INFO - 2015-12-10 14:59:22,102 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27094.13 Median:4255.74 stddev:84930.03 (1995.7%) stddev-sans-first:85144.52 14:59:22 INFO - 2015-12-10 14:59:22,102 DEBUG : BROWSER_OUTPUT: Values: 341.0 342.4 343.2 343.8 348.0 12139.7 12460.3 14818.1 14972.0 15315.0 12611.4 14659.5 15151.4 15595.2 15601.0 4852.3 4938.7 4991.3 5082.6 5093.1 3567.7 3664.7 5067.1 5188.8 5234.7 5146.1 5161.0 5221.6 5224.5 5229.5 5166.7 5176.4 5382.3 5796.2 5801.5 5140.6 5144.0 5164.9 5166.0 5170.8 11757.2 11901.2 12251.8 12255.5 12257.0 1736.7 1742.7 1748.5 1820.1 1862.7 9053.4 9161.7 9240.7 10921.9 11943.4 1675.7 1695.4 1784.9 1802.0 1818.3 51517.0 54032.5 54053.0 54060.5 54116.2 9537.2 9632.5 9697.6 9722.4 9872.0 12337.3 12402.8 12445.3 12458.9 12491.1 6986.2 7072.1 7093.6 7122.1 7154.9 6777.8 6797.1 6812.5 6819.6 6846.5 4217.5 4238.9 4240.9 4246.3 4265.2 1645.5 1695.8 1701.1 1730.1 1751.6 739.5 812.5 865.7 894.6 993.3 15827.5 16012.1 16075.3 16238.9 16439.9 768.2 786.2 791.8 816.0 820.4 8910.0 9059.6 9188.2 9257.4 9429.3 502919.8 515671.0 523791.0 528209.0 529738.0 70564.0 70781.0 71559.3 72234.0 72781.0 1062.7 1069.3 1071.1 1075.9 1079.7 14499.8 14580.9 14780.3 14816.4 15037.5 33650.8 34226.5 34440.5 34505.0 34900.1 44444.8 45268.5 45489.3 46167.0 47869.0 8642.4 8686.7 8728.0 8931.2 9248.4 15062.5 16023.2 16111.9 16260.9 16264.9 11099.9 11421.8 11833.7 13815.7 13945.0 12547.9 13300.1 13306.5 13713.6 13738.5 13789.2 13928.9 13963.7 14044.4 14183.2 8774.7 8830.1 8883.3 8927.2 8941.5 9822.6 9912.4 10670.5 14246.5 14494.6 14:59:22 INFO - 2015-12-10 14:59:22,102 DEBUG : BROWSER_OUTPUT: 14:59:22 INFO - 2015-12-10 14:59:22,102 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4913.24 Median:6136.94 stddev:2542.61 (41.4%) stddev-sans-first:2534.83 14:59:22 INFO - 2015-12-10 14:59:22,102 DEBUG : BROWSER_OUTPUT: Values: 1249.8 1644.8 1670.7 1714.5 1714.9 5996.5 6205.0 6825.7 6997.1 7023.3 7028.6 7045.7 7094.1 7098.4 7113.1 2039.4 2065.2 2067.1 2067.8 2068.9 2087.9 2101.2 2128.4 2176.4 2182.0 2091.8 2099.5 2101.4 2127.6 2128.9 2073.3 2096.1 2098.6 2098.9 2103.6 2052.8 2087.4 2110.9 2113.2 2114.0 6820.1 6882.1 6882.8 6898.2 6899.2 4124.5 4200.2 4203.1 4216.6 4231.4 2666.4 2681.8 2684.5 2693.5 2701.0 831.9 842.7 853.5 871.1 880.3 9459.1 9474.0 9487.4 9496.6 9509.3 3881.0 3895.8 3946.2 3977.2 3984.9 8008.0 8034.8 8063.6 8095.5 8097.0 4154.6 4157.6 4159.2 4164.9 4165.2 3311.1 3408.0 3794.8 3798.3 3872.3 3493.6 3500.4 3528.5 3541.7 3544.4 1090.6 1094.3 1097.1 1101.5 1102.7 1136.4 1139.1 1140.7 1158.1 1165.7 6574.2 6618.8 6653.2 6705.8 6720.4 407.3 420.4 424.3 425.5 426.2 5167.6 5223.7 5261.8 5268.1 5278.8 8340.6 8348.5 8553.5 8587.4 8626.2 8498.5 8551.4 8559.6 8565.9 8566.5 6457.5 6557.3 6580.7 6640.6 6655.7 6317.7 6336.8 6356.1 6364.2 6390.9 7629.5 7643.2 7716.5 7749.7 7804.0 7131.4 7385.4 7394.1 7947.4 7968.4 5696.3 5804.0 5831.4 6752.7 6847.5 5915.8 5954.5 6434.5 6450.3 6465.5 6282.1 6302.4 6356.3 6364.1 6477.4 6313.2 6315.3 6376.4 6446.4 6563.0 6454.5 6503.8 6539.2 6562.8 6569.9 5481.9 6057.0 6099.4 6107.9 6109.9 6164.0 6189.9 6196.3 6197.5 6198.6 14:59:22 INFO - 2015-12-10 14:59:22,102 DEBUG : BROWSER_OUTPUT: 14:59:22 INFO - 2015-12-10 14:59:22,102 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4612.77 Median:5242.33 stddev:1350.68 (25.8%) stddev-sans-first:1315.29 14:59:22 INFO - 2015-12-10 14:59:22,103 DEBUG : BROWSER_OUTPUT: Values: 309.8 318.2 320.7 321.0 323.2 5217.3 5267.2 5274.9 5315.3 5326.7 5228.7 5233.4 5234.5 5235.1 5249.6 3899.7 3985.1 4001.0 4110.4 4111.2 4080.1 4087.8 4103.5 4115.3 4138.0 4091.9 4096.8 4097.6 4100.1 4103.2 3913.1 3961.6 4010.4 4034.4 4050.6 3591.8 3599.4 3628.8 3628.9 3630.8 5073.9 5077.6 5085.2 5089.4 5098.1 4687.6 4705.1 4706.7 4711.5 4721.0 5357.8 5501.4 5518.8 5525.5 5537.0 3953.7 3956.0 3959.0 3961.0 3962.0 5793.6 5801.1 5802.5 5807.6 5812.0 4082.4 4084.5 4086.2 4088.9 4090.2 3900.5 4010.5 4017.4 4137.1 4142.4 4612.6 4624.1 4624.1 4628.0 4633.6 5527.2 5545.4 5546.3 5550.7 5550.8 1405.3 1426.6 1427.0 1429.3 1430.1 960.6 961.8 968.8 993.0 993.9 4866.9 4869.0 4877.9 4881.0 4888.3 5724.7 5737.4 5741.2 5749.4 5756.1 4835.9 4862.2 4872.0 4882.0 4889.7 2869.2 2961.1 3037.8 3062.9 3096.9 5424.1 5425.5 5502.8 5504.0 5511.9 5960.4 5965.6 5969.6 5971.6 5972.8 5497.3 5497.8 5505.1 5510.6 5510.9 5649.1 5750.9 5795.9 5812.0 5815.7 5639.6 5679.1 5680.8 5684.0 5684.0 5498.4 5500.0 5502.3 5504.1 5504.6 4004.6 4083.5 4124.0 4126.0 4131.2 5728.1 5764.1 5766.2 5769.6 5771.0 5532.3 5539.7 5540.9 5543.9 5547.6 5518.2 5529.6 5535.2 5539.4 5544.5 5278.1 5410.3 5410.4 5423.8 5425.5 5564.7 5567.3 5567.7 5567.8 5568.1 5234.6 5326.1 5417.0 5482.6 5492.1 14:59:22 INFO - 2015-12-10 14:59:22,103 DEBUG : BROWSER_OUTPUT: 14:59:22 INFO - 2015-12-10 14:59:22,103 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11799.61 Median:562.60 stddev:13531.43 (2405.1%) stddev-sans-first:13544.14 14:59:22 INFO - 2015-12-10 14:59:22,103 DEBUG : BROWSER_OUTPUT: Values: 792.4 792.5 801.7 820.1 827.2 11131.7 11516.7 11533.1 11548.0 11583.7 11685.3 11778.3 11822.0 11842.2 11861.3 633.5 634.1 789.0 806.4 808.5 813.3 814.2 821.7 821.7 822.4 840.5 850.7 851.2 851.3 853.4 663.4 663.7 840.6 852.0 855.4 635.4 635.6 636.4 636.5 636.6 12089.7 12201.6 12213.6 12255.1 12274.0 10777.8 11500.9 11555.9 11888.7 12070.3 9482.2 9578.3 9590.4 9689.1 9786.8 3164.9 3201.0 3220.2 3227.1 3280.9 39966.0 40636.8 40689.2 40705.8 40740.0 8489.2 8502.9 8641.1 8767.6 8817.6 15910.3 15939.2 15960.2 15970.1 15976.8 6269.5 6348.9 6362.3 6469.2 6470.1 3477.2 3535.5 3550.3 3554.9 3559.6 2772.1 2815.9 2816.0 2816.1 2819.5 463.5 475.6 480.9 481.5 481.9 409.0 420.5 434.6 439.5 442.5 6992.9 7013.2 7032.4 7143.7 7301.2 427.4 440.8 553.9 560.7 564.5 3264.2 3383.7 3394.3 3419.9 3449.7 48348.0 48945.8 49053.8 49073.3 49091.3 42374.4 42636.6 43224.4 43412.6 43499.0 40090.4 40113.6 40270.6 40473.2 40900.6 7010.8 7026.8 7063.3 7131.0 7213.4 29837.0 30539.4 30651.4 30667.4 30922.0 35611.0 36187.6 36234.3 37232.3 39985.6 8359.4 8886.6 8905.7 8930.9 8943.7 9509.8 9882.3 9912.7 10054.2 10109.5 9047.3 9064.8 9116.8 9122.1 9135.6 9562.0 9625.7 9648.0 9679.3 9680.3 9493.8 9502.6 9521.8 9541.2 9649.4 7981.3 8460.3 8512.6 8516.9 8606.9 7904.2 8103.6 8262.1 8295.5 8306.5 14:59:22 INFO - 2015-12-10 14:59:22,104 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:59:22 INFO - 2015-12-10 14:59:22,104 DEBUG : BROWSER_OUTPUT: 14:59:22 INFO - 2015-12-10 14:59:22,877 INFO : Browser exited with error code: 0 14:59:22 INFO - 2015-12-10 14:59:22,901 INFO : Completed test dromaeo_css (00:18:37) 14:59:22 INFO - 2015-12-10 14:59:22,901 INFO : Starting test kraken 14:59:22 INFO - 2015-12-10 14:59:22,901 DEBUG : operating with platform_type : linux_ 14:59:22 INFO - 2015-12-10 14:59:22,901 INFO : Initialising browser for kraken test... 14:59:22 INFO - 2015-12-10 14:59:22,907 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmHfjB9/profile http://localhost:41563/getInfo.html 14:59:26 INFO - 2015-12-10 14:59:26,994 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:59:26 INFO - 2015-12-10 14:59:26,994 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:59:26 INFO - 2015-12-10 14:59:26,994 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:59:26 INFO - 2015-12-10 14:59:26,994 DEBUG : BROWSER_OUTPUT: __metrics 14:59:27 INFO - 2015-12-10 14:59:27,115 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] 14:59:27 INFO - 2015-12-10 14:59:27,180 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] 14:59:28 INFO - 2015-12-10 14:59:28,226 INFO : Browser initialized. 14:59:28 INFO - 2015-12-10 14:59:28,227 INFO : Running cycle 1/1 for kraken test... 14:59:28 INFO - 2015-12-10 14:59:28,227 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmHfjB9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:59:40 INFO - 2015-12-10 14:59:40,238 DEBUG : BROWSER_OUTPUT: RSS: Main: 142139392 14:59:40 INFO - 2015-12-10 14:59:40,238 DEBUG : BROWSER_OUTPUT: 14:59:42 INFO - 2015-12-10 14:59:42,860 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41563/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41563/tests/kraken/driver.html?testName=audio-beat-detection) 14:59:43 INFO - 2015-12-10 14:59:43,450 DEBUG : BROWSER_OUTPUT: RSS: Main: 179630080 14:59:43 INFO - 2015-12-10 14:59:43,450 DEBUG : BROWSER_OUTPUT: 14:59:46 INFO - 2015-12-10 14:59:46,219 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41563/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41563/tests/kraken/driver.html?testName=audio-dft) 14:59:46 INFO - 2015-12-10 14:59:46,800 DEBUG : BROWSER_OUTPUT: RSS: Main: 167723008 14:59:46 INFO - 2015-12-10 14:59:46,800 DEBUG : BROWSER_OUTPUT: 14:59:49 INFO - 2015-12-10 14:59:49,824 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41563/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41563/tests/kraken/driver.html?testName=audio-fft) 14:59:50 INFO - 2015-12-10 14:59:50,390 DEBUG : BROWSER_OUTPUT: RSS: Main: 153677824 14:59:50 INFO - 2015-12-10 14:59:50,390 DEBUG : BROWSER_OUTPUT: 14:59:52 INFO - 2015-12-10 14:59:52,406 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41563/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41563/tests/kraken/driver.html?testName=audio-oscillator) 14:59:52 INFO - 2015-12-10 14:59:52,989 DEBUG : BROWSER_OUTPUT: RSS: Main: 155877376 14:59:52 INFO - 2015-12-10 14:59:52,989 DEBUG : BROWSER_OUTPUT: 14:59:55 INFO - 2015-12-10 14:59:55,255 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41563/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41563/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:59:55 INFO - 2015-12-10 14:59:55,825 DEBUG : BROWSER_OUTPUT: RSS: Main: 157519872 14:59:55 INFO - 2015-12-10 14:59:55,826 DEBUG : BROWSER_OUTPUT: 14:59:58 INFO - 2015-12-10 14:59:58,824 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41563/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41563/tests/kraken/driver.html?testName=imaging-darkroom) 14:59:59 INFO - 2015-12-10 14:59:59,393 DEBUG : BROWSER_OUTPUT: RSS: Main: 158527488 14:59:59 INFO - 2015-12-10 14:59:59,393 DEBUG : BROWSER_OUTPUT: 15:00:02 INFO - 2015-12-10 15:00:02,774 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41563/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41563/tests/kraken/driver.html?testName=imaging-desaturate) 15:00:03 INFO - 2015-12-10 15:00:03,347 DEBUG : BROWSER_OUTPUT: RSS: Main: 157749248 15:00:03 INFO - 2015-12-10 15:00:03,347 DEBUG : BROWSER_OUTPUT: 15:00:06 INFO - 2015-12-10 15:00:06,173 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41563/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41563/tests/kraken/driver.html?testName=json-parse-financial) 15:00:06 INFO - 2015-12-10 15:00:06,754 DEBUG : BROWSER_OUTPUT: RSS: Main: 157290496 15:00:06 INFO - 2015-12-10 15:00:06,754 DEBUG : BROWSER_OUTPUT: 15:00:08 INFO - 2015-12-10 15:00:08,535 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41563/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41563/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:00:09 INFO - 2015-12-10 15:00:09,101 DEBUG : BROWSER_OUTPUT: RSS: Main: 166354944 15:00:09 INFO - 2015-12-10 15:00:09,101 DEBUG : BROWSER_OUTPUT: 15:00:10 INFO - 2015-12-10 15:00:10,996 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41563/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41563/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:00:11 INFO - 2015-12-10 15:00:11,591 DEBUG : BROWSER_OUTPUT: RSS: Main: 167325696 15:00:11 INFO - 2015-12-10 15:00:11,592 DEBUG : BROWSER_OUTPUT: 15:00:13 INFO - 2015-12-10 15:00:13,707 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41563/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41563/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:00:14 INFO - 2015-12-10 15:00:14,288 DEBUG : BROWSER_OUTPUT: RSS: Main: 179441664 15:00:14 INFO - 2015-12-10 15:00:14,289 DEBUG : BROWSER_OUTPUT: 15:00:16 INFO - 2015-12-10 15:00:16,829 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41563/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41563/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:00:17 INFO - 2015-12-10 15:00:17,418 DEBUG : BROWSER_OUTPUT: RSS: Main: 183664640 15:00:17 INFO - 2015-12-10 15:00:17,419 DEBUG : BROWSER_OUTPUT: 15:00:20 INFO - 2015-12-10 15:00:20,013 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41563/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41563/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:00:20 INFO - 2015-12-10 15:00:20,600 DEBUG : BROWSER_OUTPUT: RSS: Main: 181395456 15:00:20 INFO - 2015-12-10 15:00:20,600 DEBUG : BROWSER_OUTPUT: 15:00:22 INFO - 2015-12-10 15:00:22,353 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41563/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41563/tests/kraken/driver.html?testName=ai-astar) 15:00:22 INFO - 2015-12-10 15:00:22,603 DEBUG : BROWSER_OUTPUT: RSS: Main: 240328704 15:00:22 INFO - 2015-12-10 15:00:22,604 DEBUG : BROWSER_OUTPUT: 15:00:22 INFO - 2015-12-10 15:00:22,604 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:00:22 INFO - 2015-12-10 15:00:22,604 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:00:22 INFO - 2015-12-10 15:00:22,605 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:00:22 INFO - 2015-12-10 15:00:22,605 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:00:22 INFO - 2015-12-10 15:00:22,605 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;114;107;112;112;112;101;113;113;121 15:00:22 INFO - 2015-12-10 15:00:22,605 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;161;128;150;173;129;158;150;130;178;133 15:00:22 INFO - 2015-12-10 15:00:22,606 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;159;160;160;160;162;161;161;162 15:00:22 INFO - 2015-12-10 15:00:22,606 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;75;88;91;72;72;72;105;87;74 15:00:22 INFO - 2015-12-10 15:00:22,606 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;95;134;93;95;96;131;94;95;138 15:00:22 INFO - 2015-12-10 15:00:22,606 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;109;109;109;110;109;109;110 15:00:22 INFO - 2015-12-10 15:00:22,606 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;147;146;146;147;146;146;146;147 15:00:22 INFO - 2015-12-10 15:00:22,606 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;94;95;96;95;95;95;95;95;95 15:00:22 INFO - 2015-12-10 15:00:22,606 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;71;71;71;72;71;71;80;69;71 15:00:22 INFO - 2015-12-10 15:00:22,606 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;67;68;68;70;68;68;68;68;69 15:00:22 INFO - 2015-12-10 15:00:22,606 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;84;85;83;88;83;84;84;83;83 15:00:22 INFO - 2015-12-10 15:00:22,606 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;124;124;128;119;125;128;139;128;120;126 15:00:22 INFO - 2015-12-10 15:00:22,606 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;141;146;161;138;154;147;148;146;133 15:00:22 INFO - 2015-12-10 15:00:22,606 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;69;68;69;71;71;70;68;70;72 15:00:22 INFO - 2015-12-10 15:00:22,606 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:00:22 INFO - 2015-12-10 15:00:22,606 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:00:22 INFO - 2015-12-10 15:00:22,606 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1010 15:00:22 INFO - 2015-12-10 15:00:22,606 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:00:22 INFO - 2015-12-10 15:00:22,607 DEBUG : BROWSER_OUTPUT: __startTimestamp1449788422603__endTimestamp 15:00:22 INFO - 2015-12-10 15:00:22,607 DEBUG : BROWSER_OUTPUT: 15:00:22 INFO - 2015-12-10 15:00:22,610 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:00:22 INFO - 2015-12-10 15:00:22,610 DEBUG : BROWSER_OUTPUT: Number of tests: 14 15:00:22 INFO - 2015-12-10 15:00:22,610 DEBUG : BROWSER_OUTPUT: 15:00:22 INFO - 2015-12-10 15:00:22,610 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.50 Median:112.50 stddev:5.10 (4.5%) stddev-sans-first:5.39 15:00:22 INFO - 2015-12-10 15:00:22,610 DEBUG : BROWSER_OUTPUT: Values: 110.0 114.0 107.0 112.0 112.0 112.0 101.0 113.0 113.0 121.0 15:00:22 INFO - 2015-12-10 15:00:22,610 DEBUG : BROWSER_OUTPUT: 15:00:22 INFO - 2015-12-10 15:00:22,610 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.00 Median:154.00 stddev:18.57 (12.1%) stddev-sans-first:19.18 15:00:22 INFO - 2015-12-10 15:00:22,610 DEBUG : BROWSER_OUTPUT: Values: 161.0 128.0 150.0 173.0 129.0 158.0 150.0 130.0 178.0 133.0 15:00:22 INFO - 2015-12-10 15:00:22,610 DEBUG : BROWSER_OUTPUT: 15:00:22 INFO - 2015-12-10 15:00:22,610 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.90 Median:161.50 stddev:1.10 (0.7%) stddev-sans-first:1.09 15:00:22 INFO - 2015-12-10 15:00:22,611 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 159.0 160.0 160.0 160.0 162.0 161.0 161.0 162.0 15:00:22 INFO - 2015-12-10 15:00:22,611 DEBUG : BROWSER_OUTPUT: 15:00:22 INFO - 2015-12-10 15:00:22,611 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.80 Median:74.50 stddev:11.40 (15.3%) stddev-sans-first:11.64 15:00:22 INFO - 2015-12-10 15:00:22,611 DEBUG : BROWSER_OUTPUT: Values: 72.0 75.0 88.0 91.0 72.0 72.0 72.0 105.0 87.0 74.0 15:00:22 INFO - 2015-12-10 15:00:22,611 DEBUG : BROWSER_OUTPUT: 15:00:22 INFO - 2015-12-10 15:00:22,611 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.70 Median:95.00 stddev:19.16 (20.2%) stddev-sans-first:19.93 15:00:22 INFO - 2015-12-10 15:00:22,611 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 134.0 93.0 95.0 96.0 131.0 94.0 95.0 138.0 15:00:22 INFO - 2015-12-10 15:00:22,611 DEBUG : BROWSER_OUTPUT: 15:00:22 INFO - 2015-12-10 15:00:22,611 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 15:00:22 INFO - 2015-12-10 15:00:22,611 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 110.0 15:00:22 INFO - 2015-12-10 15:00:22,611 DEBUG : BROWSER_OUTPUT: 15:00:22 INFO - 2015-12-10 15:00:22,611 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 15:00:22 INFO - 2015-12-10 15:00:22,611 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 147.0 15:00:22 INFO - 2015-12-10 15:00:22,611 DEBUG : BROWSER_OUTPUT: 15:00:22 INFO - 2015-12-10 15:00:22,611 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 15:00:22 INFO - 2015-12-10 15:00:22,611 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 15:00:22 INFO - 2015-12-10 15:00:22,612 DEBUG : BROWSER_OUTPUT: 15:00:22 INFO - 2015-12-10 15:00:22,612 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.80 Median:71.00 stddev:2.97 (4.2%) stddev-sans-first:3.14 15:00:22 INFO - 2015-12-10 15:00:22,612 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 71.0 71.0 72.0 71.0 71.0 80.0 69.0 71.0 15:00:22 INFO - 2015-12-10 15:00:22,612 DEBUG : BROWSER_OUTPUT: 15:00:22 INFO - 2015-12-10 15:00:22,612 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 15:00:22 INFO - 2015-12-10 15:00:22,612 DEBUG : BROWSER_OUTPUT: Values: 69.0 67.0 68.0 68.0 70.0 68.0 68.0 68.0 68.0 69.0 15:00:22 INFO - 2015-12-10 15:00:22,612 DEBUG : BROWSER_OUTPUT: 15:00:22 INFO - 2015-12-10 15:00:22,612 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:84.00 stddev:1.56 (1.9%) stddev-sans-first:1.62 15:00:22 INFO - 2015-12-10 15:00:22,613 DEBUG : BROWSER_OUTPUT: Values: 83.0 84.0 85.0 83.0 88.0 83.0 84.0 84.0 83.0 83.0 15:00:22 INFO - 2015-12-10 15:00:22,613 DEBUG : BROWSER_OUTPUT: 15:00:22 INFO - 2015-12-10 15:00:22,613 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.10 Median:127.00 stddev:5.53 (4.4%) stddev-sans-first:5.81 15:00:22 INFO - 2015-12-10 15:00:22,613 DEBUG : BROWSER_OUTPUT: Values: 124.0 124.0 128.0 119.0 125.0 128.0 139.0 128.0 120.0 126.0 15:00:22 INFO - 2015-12-10 15:00:22,613 DEBUG : BROWSER_OUTPUT: 15:00:22 INFO - 2015-12-10 15:00:22,613 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.20 Median:146.50 stddev:8.23 (5.6%) stddev-sans-first:8.31 15:00:22 INFO - 2015-12-10 15:00:22,613 DEBUG : BROWSER_OUTPUT: Values: 138.0 141.0 146.0 161.0 138.0 154.0 147.0 148.0 146.0 133.0 15:00:22 INFO - 2015-12-10 15:00:22,614 DEBUG : BROWSER_OUTPUT: 15:00:22 INFO - 2015-12-10 15:00:22,614 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.00 stddev:1.32 (1.9%) stddev-sans-first:1.39 15:00:22 INFO - 2015-12-10 15:00:22,614 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 68.0 69.0 71.0 71.0 70.0 68.0 70.0 72.0 15:00:22 INFO - 2015-12-10 15:00:22,614 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:00:22 INFO - 2015-12-10 15:00:22,614 DEBUG : BROWSER_OUTPUT: 15:00:23 INFO - 2015-12-10 15:00:23,525 INFO : Browser exited with error code: 0 15:00:23 INFO - 2015-12-10 15:00:23,579 INFO : Completed test kraken (00:01:00) 15:00:23 INFO - 2015-12-10 15:00:23,579 INFO : Starting test v8_7 15:00:23 INFO - 2015-12-10 15:00:23,579 DEBUG : operating with platform_type : linux_ 15:00:23 INFO - 2015-12-10 15:00:23,579 INFO : Initialising browser for v8_7 test... 15:00:23 INFO - 2015-12-10 15:00:23,585 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSPqbCv/profile http://localhost:41563/getInfo.html 15:00:27 INFO - 2015-12-10 15:00:27,746 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:00:27 INFO - 2015-12-10 15:00:27,746 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:00:27 INFO - 2015-12-10 15:00:27,746 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:00:27 INFO - 2015-12-10 15:00:27,746 DEBUG : BROWSER_OUTPUT: __metrics 15:00:27 INFO - 2015-12-10 15:00:27,868 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] 15:00:27 INFO - 2015-12-10 15:00:27,944 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] 15:00:29 INFO - 2015-12-10 15:00:29,055 INFO : Browser initialized. 15:00:29 INFO - 2015-12-10 15:00:29,056 INFO : Running cycle 1/1 for v8_7 test... 15:00:29 INFO - 2015-12-10 15:00:29,056 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSPqbCv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:00:41 INFO - 2015-12-10 15:00:41,058 DEBUG : BROWSER_OUTPUT: RSS: Main: 142479360 15:00:41 INFO - 2015-12-10 15:00:41,059 DEBUG : BROWSER_OUTPUT: 15:01:02 INFO - 2015-12-10 15:01:02,441 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41563/tests/v8_7/run.html (next: http://localhost:41563/tests/v8_7/run.html) 15:01:02 INFO - 2015-12-10 15:01:02,692 DEBUG : BROWSER_OUTPUT: RSS: Main: 443981824 15:01:02 INFO - 2015-12-10 15:01:02,692 DEBUG : BROWSER_OUTPUT: 15:01:02 INFO - 2015-12-10 15:01:02,692 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:01:02 INFO - 2015-12-10 15:01:02,693 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:01:02 INFO - 2015-12-10 15:01:02,693 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:01:02 INFO - 2015-12-10 15:01:02,693 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:01:02 INFO - 2015-12-10 15:01:02,693 DEBUG : BROWSER_OUTPUT: |0;Richards;167.16817118020728 15:01:02 INFO - 2015-12-10 15:01:02,694 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.77624206200971 15:01:02 INFO - 2015-12-10 15:01:02,694 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.473962684489 15:01:02 INFO - 2015-12-10 15:01:02,694 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5133.333333333333 15:01:02 INFO - 2015-12-10 15:01:02,694 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2000 15:01:02 INFO - 2015-12-10 15:01:02,695 DEBUG : BROWSER_OUTPUT: |5;Earley;784.3137254901961 15:01:02 INFO - 2015-12-10 15:01:02,695 DEBUG : BROWSER_OUTPUT: |6;Boyer;12231.707317073171 15:01:02 INFO - 2015-12-10 15:01:02,695 DEBUG : BROWSER_OUTPUT: |7;RegExp;27675.675675675677 15:01:02 INFO - 2015-12-10 15:01:02,695 DEBUG : BROWSER_OUTPUT: |8;Splay;614.2506142506143 15:01:02 INFO - 2015-12-10 15:01:02,696 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 15:01:02 INFO - 2015-12-10 15:01:02,696 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:01:02 INFO - 2015-12-10 15:01:02,696 DEBUG : BROWSER_OUTPUT: __startTimestamp1449788462689__endTimestamp 15:01:02 INFO - 2015-12-10 15:01:02,696 DEBUG : BROWSER_OUTPUT: 15:01:02 INFO - 2015-12-10 15:01:02,697 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:01:02 INFO - 2015-12-10 15:01:02,697 DEBUG : BROWSER_OUTPUT: Number of tests: 10 15:01:02 INFO - 2015-12-10 15:01:02,697 DEBUG : BROWSER_OUTPUT: 15:01:02 INFO - 2015-12-10 15:01:02,697 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.17 Median:167.17 stddev:0.00 (0.0%) 15:01:02 INFO - 2015-12-10 15:01:02,697 DEBUG : BROWSER_OUTPUT: Values: 167.2 15:01:02 INFO - 2015-12-10 15:01:02,697 DEBUG : BROWSER_OUTPUT: 15:01:02 INFO - 2015-12-10 15:01:02,697 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.78 Median:186.78 stddev:0.00 (0.0%) 15:01:02 INFO - 2015-12-10 15:01:02,697 DEBUG : BROWSER_OUTPUT: Values: 186.8 15:01:02 INFO - 2015-12-10 15:01:02,698 DEBUG : BROWSER_OUTPUT: 15:01:02 INFO - 2015-12-10 15:01:02,698 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.47 Median:278.47 stddev:0.00 (0.0%) 15:01:02 INFO - 2015-12-10 15:01:02,698 DEBUG : BROWSER_OUTPUT: Values: 278.5 15:01:02 INFO - 2015-12-10 15:01:02,698 DEBUG : BROWSER_OUTPUT: 15:01:02 INFO - 2015-12-10 15:01:02,698 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5133.33 Median:5133.33 stddev:0.00 (0.0%) 15:01:02 INFO - 2015-12-10 15:01:02,698 DEBUG : BROWSER_OUTPUT: Values: 5133.3 15:01:02 INFO - 2015-12-10 15:01:02,698 DEBUG : BROWSER_OUTPUT: 15:01:02 INFO - 2015-12-10 15:01:02,698 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2000.00 Median:2000.00 stddev:0.00 (0.0%) 15:01:02 INFO - 2015-12-10 15:01:02,698 DEBUG : BROWSER_OUTPUT: Values: 2000.0 15:01:02 INFO - 2015-12-10 15:01:02,699 DEBUG : BROWSER_OUTPUT: 15:01:02 INFO - 2015-12-10 15:01:02,699 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:784.31 Median:784.31 stddev:0.00 (0.0%) 15:01:02 INFO - 2015-12-10 15:01:02,699 DEBUG : BROWSER_OUTPUT: Values: 784.3 15:01:02 INFO - 2015-12-10 15:01:02,699 DEBUG : BROWSER_OUTPUT: 15:01:02 INFO - 2015-12-10 15:01:02,699 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12231.71 Median:12231.71 stddev:0.00 (0.0%) 15:01:02 INFO - 2015-12-10 15:01:02,699 DEBUG : BROWSER_OUTPUT: Values: 12231.7 15:01:02 INFO - 2015-12-10 15:01:02,699 DEBUG : BROWSER_OUTPUT: 15:01:02 INFO - 2015-12-10 15:01:02,699 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27675.68 Median:27675.68 stddev:0.00 (0.0%) 15:01:02 INFO - 2015-12-10 15:01:02,699 DEBUG : BROWSER_OUTPUT: Values: 27675.7 15:01:02 INFO - 2015-12-10 15:01:02,699 DEBUG : BROWSER_OUTPUT: 15:01:02 INFO - 2015-12-10 15:01:02,699 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:614.25 Median:614.25 stddev:0.00 (0.0%) 15:01:02 INFO - 2015-12-10 15:01:02,699 DEBUG : BROWSER_OUTPUT: Values: 614.3 15:01:02 INFO - 2015-12-10 15:01:02,700 DEBUG : BROWSER_OUTPUT: 15:01:02 INFO - 2015-12-10 15:01:02,700 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 15:01:02 INFO - 2015-12-10 15:01:02,700 DEBUG : BROWSER_OUTPUT: Values: 4830.9 15:01:02 INFO - 2015-12-10 15:01:02,700 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:01:02 INFO - 2015-12-10 15:01:02,700 DEBUG : BROWSER_OUTPUT: 15:01:03 INFO - 2015-12-10 15:01:03,565 INFO : Browser exited with error code: 0 15:01:03 INFO - 2015-12-10 15:01:03,580 INFO : Completed test v8_7 (00:00:40) 15:01:03 INFO - 2015-12-10 15:01:03,706 INFO : Completed test suite (00:20:17) 15:01:03 INFO - 2015-12-10 15:01:03,706 DEBUG : Working with test: dromaeo_css 15:01:03 INFO - 2015-12-10 15:01:03,706 DEBUG : Generating results file: dromaeo_css 15:01:03 INFO - 2015-12-10 15:01:03,707 DEBUG : Working with test: kraken 15:01:03 INFO - 2015-12-10 15:01:03,707 DEBUG : Generating results file: kraken 15:01:03 INFO - 2015-12-10 15:01:03,708 INFO : javascript benchmark 15:01:03 INFO - 2015-12-10 15:01:03,708 DEBUG : Working with test: v8_7 15:01:03 INFO - 2015-12-10 15:01:03,708 DEBUG : Generating results file: v8_7 15:01:03 INFO - 2015-12-10 15:01:03,708 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:01:03 INFO - 2015-12-10 15:01:03,768 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 15:01:03 INFO - 2015-12-10 15:01:03,768 DEBUG : process_Request line: dromaeo_css 6238.39 graph.html#tests=[[72,132,35]] 15:01:03 INFO - 2015-12-10 15:01:03,768 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:01:03 INFO - 2015-12-10 15:01:03,801 DEBUG : process_Request line: kraken 1524.90 graph.html#tests=[[232,132,35]] 15:01:03 INFO - 2015-12-10 15:01:03,801 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:01:03 INFO - 2015-12-10 15:01:03,841 DEBUG : process_Request line: v8_7 19712.73 graph.html#tests=[[230,132,35]] 15:01:03 INFO - 2015-12-10 15:01:03,843 INFO : javascript benchmark 15:01:03 INFO - 2015-12-10 15:01:03,846 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2581.9930227211385, 2649.6290519327285, 2679.3971356444813, 2692.9461410771787, 2695.838249705018, 4433.490148632908, 4532.63738900888, 4584.472785629654, 4665.04366604846, 4672.0889426561835, 4531.071130418264, 4617.676762626617, 4619.74591397473, 4643.210654188788, 4837.975810120954, 4251.171021650764, 4314.762688052156, 4374.015846434559, 4438.42300500936, 4455.933161002571, 4380.5838445347645, 4422.292433210687, 4431.49037860647, 4456.309272062836, 4486.484054333744, 4159.168166366739, 4176.4570605821355, 4258.254805409041, 4264.552222016675, 4295.334223195378, 4172.144710334404, 4299.05420807425, 4301.204277208726, 4320.783960801948, 4344.391785150082, 4079.97960010201, 4256.042390462152, 4270.103278311558, 4295.055087880662, 4318.589733975267, 4473.664475164375, 4534.795934182936, 4550.226461501553, 4565.794539245742, 4580.6335493160805, 4985.227289770091, 5038.949610503884, 5041.72270525121, 5084.313617661605, 5084.339035925343, 4862.3922009748785, 5051.747412629354, 5062.443131255596, 5066.468020857794, 5069.366329208849, 4474.32885067236, 4534.274516077412, 4552.203364411214, 4563.315502674625, 4590.632749380042, 5110.66780659256, 5152.690838549699, 5154.53609175176, 5155.845324640191, 5158.871028224249, 4734.076855013308, 4945.975270123627, 4948.529889660476, 4949.356583644103, 4979.751012449363, 4869.123557759637, 4917.926231106536, 4922.655414121049, 4937.604991600663, 4987.451380348159, 4964.776585053609, 5031.4213865405945, 5036.496350365008, 5043.949560504421, 5087.0, 4833.564979151894, 5006.274090256892, 5030.119729047402, 5031.547160755549, 5083.440821509631, 4123.711340206157, 4155.252054630196, 4162.271602469556, 4208.894777630584, 4213.599708027732, 3658.487811706363, 3675.1363429594026, 3681.2821499807815, 3712.053426376257, 3715.7213209009433, 4366.737995720267, 4370.541093185233, 4381.737095774264, 4382.912341753147, 4414.050979039458, 4759.286107083896, 4899.902001959941, 4927.113119638428, 4933.555979961749, 4945.975270123627, 4351.564843515623, 4360.018995725936, 4361.258586040381, 4365.541618130114, 4387.122575484916, 4485.596296333346, 4492.707973981681, 4495.977520112378, 4507.504174540798, 4543.977280113579, 4581.450225972904, 4707.976460117815, 4708.317293992421, 4779.187538118528, 4803.855884323406, 4814.566688998007, 4881.219004959189, 4885.633577481632, 4921.950780492292, 4925.655204135676, 4667.696599721007, 4740.265258884879, 4746.098241334135, 4767.261074533453, 4787.54518320759, 4833.3958255218095, 4927.901441971212, 4950.77721502526, 4964.453910069961, 5002.499750025114, 4871.90256194867, 4923.335349727741, 4944.975275123601, 4945.77744001528, 4959.181735013683, 4850.369451971221, 4871.488493708252, 4876.487968763229, 4913.115639184981, 4916.3362946001835, 4618.399608050931, 4825.9758701206265, 4864.440589332272, 4888.340074089952, 4915.434725006527, 4602.079584083263, 4674.579287864109, 4719.7404142772475, 4725.8582242532775, 4732.195526760528, 4917.803287868445, 4934.259861020875, 4943.159662857395, 4947.529984651453, 4989.201727723546, 4550.954490455186, 4809.591184749335, 4826.903461930812, 4832.420109586872, 4861.319415281792], "unit": "ms", "name": "dojo.html", "value": 4575.509076779715}, {"lowerIsBetter": false, "replicates": [577.2351634084837, 585.3385674188166, 587.6063037764698, 594.4620118792488, 595.8331667133205, 26276.474470510577, 26449.206523804292, 34783.65216347836, 35309.11727206815, 35373.2925341493, 39222.60777392225, 39643.801780991125, 39644.0, 39651.80174099133, 39667.0, 6969.4424446044195, 7860.606969651523, 8026.558539280337, 8033.6384862681025, 8038.477498962578, 7089.397401220876, 10102.191824654046, 10329.53517091729, 10331.27681062326, 10332.58669653213, 10010.949945250264, 10112.797744045114, 10115.595376184981, 10117.038881306264, 10118.89881101187, 7150.785476435715, 7343.77968660941, 9942.304038717293, 10021.148202402768, 10251.538680759384, 9929.25530585209, 10082.89917100827, 10085.394876307371, 10086.9495652522, 10092.091711745905, 36743.265134697154, 37306.81346593249, 37318.0, 37410.62589374126, 37437.25125497502, 2768.2387343480505, 2776.281936217319, 2838.3188034871687, 2987.8954236601617, 3349.882754103595, 27945.0, 27972.300692482648, 28080.719192808014, 28118.718812811814, 28329.033935248877, 3364.9495257571157, 3532.1346270163976, 3559.2169722660974, 3570.535830342065, 3656.5063716398213, 214597.0, 216905.0, 217505.0, 217852.0, 218571.0, 52330.0, 53249.2012619811, 54713.72643136759, 55115.0, 55236.72381638066, 66576.0, 67498.31254218586, 67573.32426675671, 67655.0, 67672.0, 13766.587002389944, 13944.58166255014, 13946.442142314194, 13947.093438926437, 13954.720905582035, 9682.080202380763, 9693.854592181124, 9712.0, 9730.805383892424, 9779.266555008402, 19019.524511887037, 19249.51876203106, 19260.518487037654, 19262.903685481484, 19278.71081933772, 7631.818227235845, 7754.961225193951, 7784.8053798654355, 7822.765317040498, 7843.529388236724, 895.3732387328896, 932.5383934952242, 952.6475204174361, 970.9562220612728, 1001.3541265883464, 26117.73882261191, 26251.435992208488, 26537.601935970975, 26651.733482665313, 26770.5984410234, 874.9212570868652, 902.2466240688967, 923.9974627529072, 1004.3973615830589, 1024.144839059379, 13198.20810751358, 13814.140647621962, 13898.58304250874, 13909.443622254996, 13973.231472268919, 264839.0, 266707.0, 266807.0, 269047.0, 269281.0, 43829.34255986163, 44156.0, 44222.11555768867, 44235.0, 44244.55755442469, 1128.4696192789377, 1128.7686024364984, 1153.6250718516349, 1153.7750138723036, 1160.825876118589, 22734.886325568266, 22948.655770163794, 23251.418714532272, 23404.414889627213, 23475.530489389774, 36012.27975440529, 36599.26801463903, 39744.40383394309, 39988.0, 40080.0, 332362.0, 341777.0, 344037.0, 344125.0, 344729.0, 28413.289667758472, 28846.855765721037, 28864.278393040342, 28882.42235155243, 28923.276918077216, 37897.4315385275, 38857.80571097126, 39272.214555709295, 39360.6063939357, 39562.604373957045, 32774.67225327716, 33436.33127337488, 33679.66320336765, 34168.14579635429, 34370.48444273288, 32982.5052624206, 33079.50380744339, 33238.16904577405, 33537.66462335443, 33590.83204583961, 33236.83381583077, 33438.49842252417, 35659.10852228715, 36211.637883620824, 36375.0, 26978.603245306782, 30050.24874378158, 33821.0, 35349.29301414009, 35570.0, 23421.344442113248, 23552.52894942057, 23603.173888913807, 23630.17294394688, 23858.642120367862], "unit": "ms", "name": "ext.html", "value": 17332.42974053869}, {"lowerIsBetter": false, "replicates": [341.04677426592673, 342.38712704259376, 343.1969192090511, 343.7748274879953, 348.0376758263402, 12139.696507587314, 12460.314682692448, 14818.110913345194, 14972.0, 15314.999999999985, 12611.43248553815, 14659.486917957873, 15151.393944242218, 15595.220238988062, 15601.0, 4852.2721591761165, 4938.703677779345, 4991.32617096691, 5082.593392528607, 5093.134167191586, 3567.661072198137, 3664.7068234541307, 5067.138586440314, 5188.818391356303, 5234.7120908350025, 5146.125158723026, 5161.045206636784, 5221.582273418117, 5224.50367215114, 5229.529342359187, 5166.715830629314, 5176.352955880515, 5382.30030096085, 5796.2464879565805, 5801.50687191585, 5140.614453915971, 5144.022635699205, 5164.870878228036, 5166.044281807877, 5170.793168273264, 11757.235779674294, 11901.226420282654, 12251.816222756666, 12255.509779608805, 12257.0, 1736.7481715151232, 1742.6514697060638, 1748.4841971618403, 1820.0535721424785, 1862.748528948588, 9053.366264361497, 9161.679341223025, 9240.722778316662, 10921.890781092166, 11943.40282985856, 1675.689997350494, 1695.3981336625443, 1784.9375271865551, 1801.9909900450414, 1818.254515648591, 51517.0, 54032.45967540353, 54053.0, 54060.45939540594, 54116.18825717657, 9537.189338906132, 9632.47021413829, 9697.612095516242, 9722.368046076983, 9871.950640246752, 12337.259764414164, 12402.75194496105, 12445.315507647167, 12458.937705311597, 12491.063170262085, 6986.16166060076, 7072.115985501812, 7093.609851458116, 7122.145342558926, 7154.928450715426, 6777.762778302736, 6797.0823938767635, 6812.523123381316, 6819.556728812611, 6846.486513511507, 4217.536071032184, 4238.85164019264, 4240.936385954213, 4246.278132717445, 4265.210935976792, 1645.539249010279, 1695.788026496688, 1701.055913967735, 1730.1176400036072, 1751.6321572469924, 739.4860571902476, 812.4678335690132, 865.7359505350803, 894.6063731957918, 993.2550587059706, 15827.52517424479, 16012.11933343654, 16075.276612552463, 16238.863279570553, 16439.91780041092, 768.2125821033374, 786.1627366854282, 791.7941335252875, 816.0289255785597, 820.4175035724583, 8909.955450222707, 9059.59231834569, 9188.173064424234, 9257.398269112486, 9429.2928030398, 502919.7919217226, 515671.0, 523791.0, 528209.0, 529738.0, 70564.0, 70780.99999999897, 71559.28440715527, 72234.0, 72781.0, 1062.697131317571, 1069.267551727085, 1071.0574694268994, 1075.860138182047, 1079.7300674831292, 14499.827810801604, 14580.927095364455, 14780.260986950394, 14816.40734370613, 15037.548873533811, 33650.83174584111, 34226.48660270148, 34440.483392748625, 34505.0, 34900.127496812784, 44444.77777611091, 45268.54731452643, 45489.317660235785, 46167.0, 47869.0, 8642.351823613128, 8686.739397818075, 8727.956360218159, 8931.19619234272, 9248.398854074463, 15062.472813451477, 16023.198840058183, 16111.919440402722, 16260.918695406921, 16264.918675406547, 11099.944500277446, 11421.771564568828, 11833.704157396134, 13815.723685526435, 13945.0, 12547.874521254671, 13300.135491193041, 13306.46774129024, 13713.588592342247, 13738.450461981409, 13789.24159171215, 13928.930355348159, 13963.720725585228, 14044.438222470986, 14183.219922903927, 8774.692885748967, 8830.116988301119, 8883.33374996865, 8927.196552310323, 8941.46351218929, 9822.55798489084, 9912.405255684682, 10670.46647667598, 14246.501372451914, 14494.637634059232], "unit": "ms", "name": "jquery.html", "value": 8155.791606169757}, {"lowerIsBetter": false, "replicates": [1249.82502449657, 1644.7532870069492, 1670.690922179397, 1714.4942242038594, 1714.9485515434533, 5996.460318571328, 6205.0, 6825.65871706414, 6997.090378250833, 7023.2625574314725, 7028.578285302872, 7045.718171273143, 7094.077769889907, 7098.432125429966, 7113.146422429316, 2039.3677959832426, 2065.2255404223415, 2067.111142208857, 2067.8138967492923, 2068.8758674479577, 2087.8516815751277, 2101.1700378350542, 2128.4253251622054, 2176.4450065233345, 2181.9781802181933, 2091.801278878504, 2099.454141923103, 2101.4326131944367, 2127.6489379252403, 2128.9041993110345, 2073.3365323096614, 2096.0882016322794, 2098.58028394321, 2098.8635738676935, 2103.5897999890026, 2052.823877268607, 2087.3842216546154, 2110.8944552772455, 2113.228671534894, 2113.9577208455744, 6820.079289295931, 6882.139732533434, 6882.793516194522, 6898.206706228748, 6899.241083480813, 4124.484439445069, 4200.243956087903, 4203.07532342884, 4216.57834216579, 4231.449911511515, 2666.3603032997194, 2681.785457163422, 2684.5033668771143, 2693.5151672698908, 2700.9594856077174, 831.8876951611516, 842.6839935024366, 853.4537895746727, 871.111466304366, 880.286967556275, 9459.054094590554, 9474.0, 9487.383320084242, 9496.572654230577, 9509.286803489696, 3881.049142959993, 3895.8052097395016, 3946.1910308387287, 3977.184677141237, 3984.940225896614, 8008.0, 8034.839303213903, 8063.596820159086, 8095.5142691438705, 8096.987876515435, 4154.626083652486, 4157.64660003897, 4159.168166366739, 4164.895877603084, 4165.208610364081, 3311.1391038329725, 3407.9829600851835, 3794.753341032824, 3798.25933942884, 3872.3223435898603, 3493.63316851732, 3500.3524347995703, 3528.5060091587197, 3541.698955588752, 3544.379733546619, 1090.5637744902103, 1094.316052467208, 1097.1223021582862, 1101.487808169189, 1102.6636875752813, 1136.3863513702672, 1139.1114930354338, 1140.6977151054978, 1158.0619698044611, 1165.7493638867684, 6574.211094668574, 6618.8345291368105, 6653.168353955755, 6705.798826035227, 6720.361565651256, 407.2872473171949, 420.3547554503822, 424.26601978576616, 425.47666370364004, 426.1902385467574, 5167.560757335594, 5223.712695801692, 5261.789528418897, 5268.051750684837, 5278.815241466607, 8340.582970851434, 8348.499090054616, 8553.486790792573, 8587.355948303903, 8626.223639872442, 8498.490090594583, 8551.401401901807, 8559.57202139903, 8565.871511927326, 8566.48601083937, 6457.483401327882, 6557.278699343068, 6580.703868325937, 6640.601563906181, 6655.73377064912, 6317.684115794284, 6336.841578960563, 6356.078368636614, 6364.204474440695, 6390.87218255623, 7629.504082234637, 7643.235676432312, 7716.459847810824, 7749.690012399667, 7803.96098019529, 7131.429485641032, 7385.372243359375, 7394.075740532434, 7947.443678942419, 7968.442209045311, 5696.287964004499, 5804.042333015005, 5831.4168583141345, 6752.7298908045095, 6847.520673553003, 5915.822525324247, 5954.46409823118, 6434.549581529248, 6450.322716114741, 6465.547411681137, 6282.120503129474, 6302.401271879165, 6356.269029061532, 6364.140840986408, 6477.4170324671, 6313.2424109107205, 6315.273743519554, 6376.39424254695, 6446.355364463704, 6562.967185164043, 6454.548181627429, 6503.772367967098, 6539.247986481616, 6562.77030303937, 6569.901451478136, 5481.945180548143, 6057.0, 6099.359567245376, 6107.8778424430375, 6109.908351374644, 6163.96918015407, 6189.938100618936, 6196.318404975539, 6197.504199663926, 6198.566100372931], "unit": "ms", "name": "mootools.html", "value": 3982.5185438342237}, {"lowerIsBetter": false, "replicates": [309.8048229615342, 318.15847084461586, 320.6921355498721, 320.95667084943534, 323.19363188843823, 5217.34783152106, 5267.236250743645, 5274.894502109955, 5315.335583052119, 5326.7070311132875, 5228.686278823264, 5233.3981592116825, 5234.50272224139, 5235.083860324437, 5249.580033597313, 3899.7270191086636, 3985.083430810915, 4000.9599904001025, 4110.403991421242, 4111.177764447115, 4080.0819815541563, 4087.7532352632434, 4103.548609652936, 4115.341545352744, 4137.979310103446, 4091.9386209206887, 4096.836126554934, 4097.610726980932, 4100.118474527976, 4103.199876024177, 3913.119548101683, 3961.6038396160443, 4010.418489319047, 4034.3948407739076, 4050.5544390117066, 3591.8204089795404, 3599.406097993828, 3628.818559072036, 3628.872989445357, 3630.782153070798, 5073.873153171164, 5077.593792496628, 5085.23721441783, 5089.440161582223, 5098.056859481007, 4687.6249900007915, 4705.106029854317, 4706.717596944194, 4711.481737008926, 4720.95279047212, 5357.785688572452, 5501.367342755594, 5518.779248830042, 5525.502704756591, 5537.0, 3953.743006704555, 3956.0307724607655, 3958.960410395888, 3961.0, 3961.98019009906, 5793.623414478087, 5801.129830525413, 5802.535797136261, 5807.593468457209, 5811.970940145315, 4082.4488694026522, 4084.5302790179508, 4086.162336720965, 4088.9386659200136, 4090.202410529918, 3900.4929359183693, 4010.498687664042, 4017.397390391406, 4137.131202447459, 4142.420061191436, 4612.584867361954, 4624.075184963021, 4624.098300831306, 4628.0, 4633.559811817872, 5527.226188333637, 5545.390007099216, 5546.251256080458, 5550.69471179089, 5550.750216240279, 1405.276282714403, 1426.5720283914784, 1426.9571912842423, 1429.2925002124016, 1430.1347684650636, 960.5917485068958, 961.7643677299106, 968.8062387522383, 992.9921130053002, 993.9006099390003, 4866.902661946741, 4869.026194761062, 4877.926831097537, 4880.975595122001, 4888.291197776302, 5724.713764311768, 5737.3688894221605, 5741.224934633771, 5749.367569567345, 5756.079027355603, 4835.879103022453, 4862.222044472867, 4871.975640121776, 4882.048000639912, 4889.65772395936, 2869.239651492356, 2961.0820645599933, 3037.8481075946115, 3062.892798752033, 3096.922576935595, 5424.077906755861, 5425.484578964992, 5502.8349149525575, 5504.0, 5511.889762204733, 5960.403959604092, 5965.582409231399, 5969.611975221596, 5971.641701497924, 5972.790952316648, 5497.340319161646, 5497.780088796403, 5505.119180931192, 5510.559155267569, 5510.91733624004, 5649.12438572022, 5750.913736293875, 5795.855103622274, 5812.0, 5815.709214539341, 5639.6334238274385, 5679.091345384719, 5680.835428737181, 5683.976884160891, 5684.0, 5498.367687715964, 5500.037493438712, 5502.257195278587, 5504.119340905436, 5504.559635229252, 4004.619561141687, 4083.5303940047274, 4124.0, 4126.0, 4131.235721391552, 5728.054870946414, 5764.106563482667, 5766.192733017297, 5769.59612827098, 5771.047777116729, 5532.336119665666, 5539.667619942817, 5540.916886246629, 5543.9168412474655, 5547.611667183259, 5518.19986102021, 5529.640573362719, 5535.169724541351, 5539.41836107219, 5544.473275038865, 5278.1027225372545, 5410.323709536308, 5410.377806552139, 5423.810166644306, 5425.484578964992, 5564.721763911869, 5567.331920169606, 5567.7494512747835, 5567.832965011056, 5568.1091025435735, 5234.555062819551, 5326.067938110893, 5416.9729151353995, 5482.5613950883035, 5492.148716948879], "unit": "ms", "name": "prototype.html", "value": 4183.523081265052}, {"lowerIsBetter": false, "replicates": [792.3938187286725, 792.4650860669047, 801.6753214947948, 820.1388542030866, 827.1563005734151, 11131.666050018503, 11516.71208219795, 11533.135014873886, 11548.0, 11583.710407239823, 11685.29888206706, 11778.29330240184, 11822.0, 11842.171048026641, 11861.288322700622, 633.5185259203016, 634.0869148426275, 789.0255534415007, 806.3508875355336, 808.5431731071925, 813.3330668851544, 814.1573471457043, 821.6507984106761, 821.6754382019099, 822.4489591973393, 840.4915026408995, 850.7235148576707, 851.2296371783515, 851.2551517422255, 853.4409961475244, 663.3697986912429, 663.6814329122025, 840.6301227459898, 851.9787005324855, 855.3542075732782, 635.3836778325064, 635.5646382228142, 636.4399328590856, 636.5162476517879, 636.5862189576766, 12089.697757556043, 12201.572944946973, 12213.572524961584, 12255.080868934865, 12274.0, 10777.784444311148, 11500.88499115015, 11555.94222028893, 11888.702782430422, 12070.27578345302, 9482.19401350886, 9578.281628877861, 9590.37662551939, 9689.079537444002, 9786.804263914682, 3164.8892288769784, 3200.9679903200904, 3220.1949512621845, 3227.144806626246, 3280.934381312384, 39966.0, 40636.79681601573, 40689.186216275804, 40705.796471017755, 40740.0, 8489.235968762841, 8502.872456913152, 8641.092685268082, 8767.605457754416, 8817.647294108292, 15910.284037218353, 15939.203039848193, 15960.201989900459, 15970.121643309498, 15976.76034859478, 6269.529785266123, 6348.904766428507, 6362.331955144736, 6469.223693156851, 6470.09418681385, 3477.23500829817, 3535.4520049392386, 3550.2544465661986, 3554.9466757998653, 3559.5906470755676, 2772.085211880075, 2815.8732857021073, 2816.0, 2816.1270006298114, 2819.5488721804413, 463.51562617065247, 475.59811958894676, 480.9086273608003, 481.4703825791601, 481.94939531348706, 408.96114869087387, 420.46180888462817, 434.5697759218351, 439.4682434254524, 442.5242863921233, 6992.930070699228, 7013.229774239249, 7032.359983705815, 7143.678534465961, 7301.1968683444775, 427.40377173842313, 440.7906244533885, 553.8698405874616, 560.6776103740366, 564.5314389057073, 3264.1513206566465, 3383.7293016558615, 3394.3381040696827, 3419.9316013679586, 3449.6550344965804, 48348.0, 48945.75527122413, 49053.754731226116, 49073.263901041515, 49091.263631045564, 42374.36438453426, 42636.57363426388, 43224.351634725506, 43412.56587434148, 43499.0, 40090.398644020366, 40113.598864010986, 40270.59729402727, 40473.19053618911, 40900.59099408968, 7010.754623588354, 7026.789196324118, 7063.258357872555, 7130.964345178241, 7213.422926165789, 29837.0, 30539.38921221519, 30651.386972259985, 30667.386652266385, 30922.0, 35611.0, 36187.638123618424, 36234.27531449409, 37232.25535489329, 39985.600143998185, 8359.414840961075, 8886.60010299551, 8905.688300909436, 8930.86603700932, 8943.731688049369, 9509.809803804024, 9882.258830587878, 9912.653057142965, 10054.245931555017, 10109.545070471993, 9047.276217902683, 9064.818703625759, 9116.772080698036, 9122.087791220825, 9135.63457461694, 9561.952190239004, 9625.663101791404, 9648.0, 9679.322447428895, 9680.322377433793, 9493.762655933657, 9502.572384242587, 9521.761955951157, 9541.236701064037, 9649.372790768577, 7981.321587664881, 8460.323174145931, 8512.616932237941, 8516.914830851612, 8606.913930860612, 7904.225015438022, 8103.635336409758, 8262.132476089924, 8295.460795048302, 8306.501609903426], "unit": "ms", "name": "yui.html", "value": 5469.166552345095}], "name": "dromaeo_css", "value": 6238.3870421956735}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 114.0, 107.0, 112.0, 112.0, 112.0, 101.0, 113.0, 113.0, 121.0], "unit": "ms", "name": "ai-astar", "value": 111.5}, {"lowerIsBetter": true, "replicates": [161.0, 128.0, 150.0, 173.0, 129.0, 158.0, 150.0, 130.0, 178.0, 133.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.0}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 159.0, 160.0, 160.0, 160.0, 162.0, 161.0, 161.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [72.0, 75.0, 88.0, 91.0, 72.0, 72.0, 72.0, 105.0, 87.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 80.8}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 134.0, 93.0, 95.0, 96.0, 131.0, 94.0, 95.0, 138.0], "unit": "ms", "name": "audio-oscillator", "value": 106.7}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.0}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 71.0, 71.0, 72.0, 71.0, 71.0, 80.0, 69.0, 71.0], "unit": "ms", "name": "json-parse-financial", "value": 71.8}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 68.0, 68.0, 70.0, 68.0, 68.0, 68.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 85.0, 83.0, 88.0, 83.0, 84.0, 84.0, 83.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.0}, {"lowerIsBetter": true, "replicates": [124.0, 124.0, 128.0, 119.0, 125.0, 128.0, 139.0, 128.0, 120.0, 126.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.1}, {"lowerIsBetter": true, "replicates": [138.0, 141.0, 146.0, 161.0, 138.0, 154.0, 147.0, 148.0, 146.0, 133.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.2}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 68.0, 69.0, 71.0, 71.0, 70.0, 68.0, 70.0, 72.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.8}], "name": "kraken", "value": 1524.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.16817118020728], "unit": "score", "name": "Richards", "value": 211.17656399999993}, {"lowerIsBetter": false, "replicates": [186.77624206200971], "unit": "score", "name": "DeltaBlue", "value": 353.9957719999998}, {"lowerIsBetter": false, "replicates": [278.473962684489], "unit": "score", "name": "Encrypt", "value": 955.8559709999997}, {"lowerIsBetter": false, "replicates": [5133.333333333333], "unit": "score", "name": "Decrypt", "value": 51.85344155844158}, {"lowerIsBetter": false, "replicates": [2000.0], "unit": "score", "name": "RayTrace", "value": 369.9945}, {"lowerIsBetter": false, "replicates": [784.3137254901961], "unit": "score", "name": "Earley", "value": 849.7403250000002}, {"lowerIsBetter": false, "replicates": [12231.707317073171], "unit": "score", "name": "Boyer", "value": 54.4865064805583}, {"lowerIsBetter": false, "replicates": [27675.675675675677], "unit": "score", "name": "RegExp", "value": 32.91645019531249}, {"lowerIsBetter": false, "replicates": [614.2506142506143], "unit": "score", "name": "Splay", "value": 132.66734799999998}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19712.732477973084}]} 15:01:03 INFO - RETURN: dromaeo_css: 6238.39 15:01:03 INFO - RETURN: kraken: 1524.90 15:01:03 INFO - RETURN: v8_7: 19712.73 15:01:03 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19712.73"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1524.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6238.39"}}} 15:01:03 INFO - Return code: 0 15:01:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:01:03 INFO - # TBPL SUCCESS # 15:01:03 INFO - Running post-action listener: _resource_record_post_action 15:01:03 INFO - Running post-run listener: _resource_record_post_run 15:01:05 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 518926336; Read time: 12; Write time: 574968 15:01:05 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 249036800; Read time: 0; Write time: 404664 15:01:05 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 4096; Write bytes: 269070336; Read time: 12; Write time: 170272 15:01:05 INFO - Running post-run listener: _upload_blobber_files 15:01:05 INFO - Blob upload gear active. 15:01:05 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 15:01:05 INFO - Copying logs to upload dir... 15:01:05 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1268.242854 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-10 15:01:03.559141) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-10 15:01:03.562499) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1449787102.767408-465478612 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/Mvm8tJ1sQna5ejOTgStUAQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009976 build_url: 'https://queue.taskcluster.net/v1/task/Mvm8tJ1sQna5ejOTgStUAQ/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-10 15:01:03.614250) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 15:01:03.614603) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1449787102.767408-465478612 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 15:01:03.663951) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-10 15:01:03.664312) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-10 15:01:03.664663) ========= ========= Total master_lag: 0.24 =========