builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-001 starttime: 1449164771.5 results: success (0) buildid: 20151203084126 builduid: 8cf7e0fbfa004ce48ced91034b094cad revision: 15ded62d213cb2e01feebcd21af52be74a535983 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 09:46:11.504009) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 09:46:11.504451) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 09:46:11.504750) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1449164771.155881-944245847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004428 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 09:46:11.524474) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 09:46:11.524808) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 09:46:11.540239) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 09:46:11.540636) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1449164771.155881-944245847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 09:46:11.590441) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 09:46:11.590758) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 09:46:11.591203) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 09:46:11.591490) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1449164771.155881-944245847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-03 09:46:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.0M=0s 2015-12-03 09:46:12 (47.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.310216 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 09:46:11.913886) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 09:46:11.914210) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1449164771.155881-944245847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018865 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 09:46:11.965162) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-03 09:46:11.965525) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 15ded62d213cb2e01feebcd21af52be74a535983 --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 15ded62d213cb2e01feebcd21af52be74a535983 --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=b4e1481c633df10bed3f4cc0000001c7-1449164771.155881-944245847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-03 09:46:12,442 truncating revision to first 12 chars 2015-12-03 09:46:12,443 Setting DEBUG logging. 2015-12-03 09:46:12,443 attempt 1/10 2015-12-03 09:46:12,443 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/15ded62d213c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-03 09:46:13,761 unpacking tar archive at: fx-team-15ded62d213c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.620150 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-03 09:46:13.603976) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 09:46:13.604337) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 09:46:13.646235) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 09:46:13.646637) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 09:46:13.647122) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-03 09:46:13.647406) ========= /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=b4e1481c633df10bed3f4cc0000001c7-1449164771.155881-944245847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:46:14 INFO - MultiFileLogger online at 20151203 09:46:14 in /builds/slave/test 09:46:14 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 09:46:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:46:14 INFO - {'append_to_log': False, 09:46:14 INFO - 'base_work_dir': '/builds/slave/test', 09:46:14 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:46:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:46:14 INFO - 'branch': 'Fx-Team-Non-PGO', 09:46:14 INFO - 'buildbot_json_path': 'buildprops.json', 09:46:14 INFO - 'config_files': ('talos/linux_config.py',), 09:46:14 INFO - 'default_actions': ('clobber', 09:46:14 INFO - 'read-buildbot-config', 09:46:14 INFO - 'download-and-extract', 09:46:14 INFO - 'populate-webroot', 09:46:14 INFO - 'create-virtualenv', 09:46:14 INFO - 'install', 09:46:14 INFO - 'run-tests'), 09:46:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:46:14 INFO - 'download_minidump_stackwalk': True, 09:46:14 INFO - 'download_symbols': 'ondemand', 09:46:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:46:14 INFO - 'tooltool.py': '/tools/tooltool.py', 09:46:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:46:14 INFO - '/tools/misc-python/virtualenv.py')}, 09:46:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:46:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:46:14 INFO - 'installer_path': 'installer.exe', 09:46:14 INFO - 'log_level': 'info', 09:46:14 INFO - 'log_name': 'talos', 09:46:14 INFO - 'log_to_console': True, 09:46:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:46:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:46:14 INFO - 'opt_config_files': (), 09:46:14 INFO - 'pip_index': False, 09:46:14 INFO - 'sps_profile': False, 09:46:14 INFO - 'sps_profile_interval': 0, 09:46:14 INFO - 'suite': 'dromaeojs', 09:46:14 INFO - 'system_bits': '64', 09:46:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:46:14 INFO - 'title': 'talos-linux64-ix-001', 09:46:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:46:14 INFO - 'use_talos_json': True, 09:46:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:46:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:46:14 INFO - 'work_dir': 'build'} 09:46:14 INFO - ##### 09:46:14 INFO - ##### Running clobber step. 09:46:14 INFO - ##### 09:46:14 INFO - Running pre-action listener: _resource_record_pre_action 09:46:14 INFO - Running main action method: clobber 09:46:14 INFO - rmtree: /builds/slave/test/build 09:46:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:46:14 INFO - Running post-action listener: _resource_record_post_action 09:46:14 INFO - ##### 09:46:14 INFO - ##### Running read-buildbot-config step. 09:46:14 INFO - ##### 09:46:14 INFO - Running pre-action listener: _resource_record_pre_action 09:46:14 INFO - Running main action method: read_buildbot_config 09:46:14 INFO - Using buildbot properties: 09:46:14 INFO - { 09:46:14 INFO - "properties": { 09:46:14 INFO - "buildnumber": 2181, 09:46:14 INFO - "product": "firefox", 09:46:14 INFO - "script_repo_revision": "production", 09:46:14 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:46:14 INFO - "repository": "", 09:46:14 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:46:14 INFO - "buildid": "20151203084126", 09:46:14 INFO - "slavename": "talos-linux64-ix-001", 09:46:14 INFO - "pgo_build": "False", 09:46:14 INFO - "basedir": "/builds/slave/test", 09:46:14 INFO - "project": "", 09:46:14 INFO - "platform": "ubuntu64_hw", 09:46:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:46:14 INFO - "slavebuilddir": "test", 09:46:14 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:46:14 INFO - "branch": "fx-team", 09:46:14 INFO - "repo_path": "integration/fx-team", 09:46:14 INFO - "stage_platform": "linux64", 09:46:14 INFO - "builduid": "8cf7e0fbfa004ce48ced91034b094cad", 09:46:14 INFO - "revision": "15ded62d213cb2e01feebcd21af52be74a535983" 09:46:14 INFO - }, 09:46:14 INFO - "sourcestamp": { 09:46:14 INFO - "repository": "", 09:46:14 INFO - "hasPatch": false, 09:46:14 INFO - "project": "", 09:46:14 INFO - "branch": "fx-team-linux64-talos", 09:46:14 INFO - "changes": [ 09:46:14 INFO - { 09:46:14 INFO - "category": null, 09:46:14 INFO - "files": [ 09:46:14 INFO - { 09:46:14 INFO - "url": null, 09:46:14 INFO - "name": "https://queue.taskcluster.net/v1/task/QMvx9AlpRrKEkIELHqYFEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 09:46:14 INFO - } 09:46:14 INFO - ], 09:46:14 INFO - "repository": "", 09:46:14 INFO - "rev": "15ded62d213cb2e01feebcd21af52be74a535983", 09:46:14 INFO - "who": "mconley@mozilla.com", 09:46:14 INFO - "when": 1449163648, 09:46:14 INFO - "number": 6739799, 09:46:14 INFO - "comments": "Bug 1177310 - Don't flush windows synchronously on application shutdown. r=billm,feedback=ttaubert\n\nInstead of synchronously flushing the windows, we use AsyncShutdown to\nwait for all window flushes to finish.", 09:46:14 INFO - "project": "", 09:46:14 INFO - "at": "Thu 03 Dec 2015 09:27:28", 09:46:14 INFO - "branch": "fx-team-linux64-talos", 09:46:14 INFO - "revlink": "", 09:46:14 INFO - "properties": [ 09:46:14 INFO - [ 09:46:14 INFO - "buildid", 09:46:14 INFO - "20151203084126", 09:46:14 INFO - "Change" 09:46:14 INFO - ], 09:46:14 INFO - [ 09:46:14 INFO - "builduid", 09:46:14 INFO - "8cf7e0fbfa004ce48ced91034b094cad", 09:46:14 INFO - "Change" 09:46:14 INFO - ], 09:46:14 INFO - [ 09:46:14 INFO - "pgo_build", 09:46:14 INFO - "False", 09:46:14 INFO - "Change" 09:46:14 INFO - ] 09:46:14 INFO - ], 09:46:14 INFO - "revision": "15ded62d213cb2e01feebcd21af52be74a535983" 09:46:14 INFO - } 09:46:14 INFO - ], 09:46:14 INFO - "revision": "15ded62d213cb2e01feebcd21af52be74a535983" 09:46:14 INFO - } 09:46:14 INFO - } 09:46:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/QMvx9AlpRrKEkIELHqYFEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 09:46:14 INFO - Running post-action listener: _resource_record_post_action 09:46:14 INFO - ##### 09:46:14 INFO - ##### Running download-and-extract step. 09:46:14 INFO - ##### 09:46:14 INFO - Running pre-action listener: _resource_record_pre_action 09:46:14 INFO - Running main action method: download_and_extract 09:46:14 INFO - mkdir: /builds/slave/test/build/tests 09:46: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')]} 09:46:14 INFO - https://queue.taskcluster.net/v1/task/QMvx9AlpRrKEkIELHqYFEw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:46:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QMvx9AlpRrKEkIELHqYFEw/artifacts/public/build/test_packages.json 09:46:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QMvx9AlpRrKEkIELHqYFEw/artifacts/public/build/test_packages.json 09:46:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QMvx9AlpRrKEkIELHqYFEw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:46:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QMvx9AlpRrKEkIELHqYFEw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:46:15 INFO - Downloaded 1302 bytes. 09:46:15 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:46:15 INFO - Using the following test package requirements: 09:46:15 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:46:15 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:46:15 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:46:15 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:46:15 INFO - u'jsshell-linux-x86_64.zip'], 09:46:15 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:46:15 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:46:15 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:46:15 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:46:15 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:46:15 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:46:15 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:46:15 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:46:15 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:46:15 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:46:15 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:46:15 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:46:15 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:46:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:15 INFO - https://queue.taskcluster.net/v1/task/QMvx9AlpRrKEkIELHqYFEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:46:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QMvx9AlpRrKEkIELHqYFEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:46:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QMvx9AlpRrKEkIELHqYFEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:46:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QMvx9AlpRrKEkIELHqYFEw/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 09:46:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QMvx9AlpRrKEkIELHqYFEw/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 09:46:17 INFO - Downloaded 21788779 bytes. 09:46:17 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 09:46:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:46:17 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 09:46:18 INFO - Return code: 0 09:46:18 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 09:46:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:18 INFO - https://queue.taskcluster.net/v1/task/QMvx9AlpRrKEkIELHqYFEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:46:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QMvx9AlpRrKEkIELHqYFEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:46:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QMvx9AlpRrKEkIELHqYFEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:46:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QMvx9AlpRrKEkIELHqYFEw/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 09:46:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QMvx9AlpRrKEkIELHqYFEw/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 09:46:19 INFO - Downloaded 21788779 bytes. 09:46:19 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 09:46:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:46:19 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 09:46:20 INFO - Return code: 0 09:46: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')]} 09:46:20 INFO - https://queue.taskcluster.net/v1/task/QMvx9AlpRrKEkIELHqYFEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:46:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QMvx9AlpRrKEkIELHqYFEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:46:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QMvx9AlpRrKEkIELHqYFEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:46:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QMvx9AlpRrKEkIELHqYFEw/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 09:46:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QMvx9AlpRrKEkIELHqYFEw/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 09:46:21 INFO - Downloaded 11132001 bytes. 09:46:21 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 09:46:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:46:21 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 09:46:21 INFO - Return code: 0 09:46:21 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')]} 09:46:21 INFO - https://queue.taskcluster.net/v1/task/QMvx9AlpRrKEkIELHqYFEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:46:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QMvx9AlpRrKEkIELHqYFEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:46:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QMvx9AlpRrKEkIELHqYFEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:46:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QMvx9AlpRrKEkIELHqYFEw/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 09:46:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QMvx9AlpRrKEkIELHqYFEw/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 09:46:26 INFO - Downloaded 57680310 bytes. 09:46:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QMvx9AlpRrKEkIELHqYFEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:46:26 INFO - mkdir: /builds/slave/test/properties 09:46:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:46:26 INFO - Writing to file /builds/slave/test/properties/build_url 09:46:26 INFO - Contents: 09:46:26 INFO - build_url:https://queue.taskcluster.net/v1/task/QMvx9AlpRrKEkIELHqYFEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:46:26 INFO - Running post-action listener: _resource_record_post_action 09:46:26 INFO - Running post-action listener: set_extra_try_arguments 09:46:26 INFO - ##### 09:46:26 INFO - ##### Running populate-webroot step. 09:46:26 INFO - ##### 09:46:26 INFO - Running pre-action listener: _resource_record_pre_action 09:46:26 INFO - Running main action method: populate_webroot 09:46:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:46:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:46:26 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:46:26 INFO - '../fennec_ids.txt'], 09:46:26 INFO - 'tests': ['tcheck2']}, 09:46:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:46:26 INFO - '--tppagecycles', 09:46:26 INFO - '7'], 09:46:26 INFO - 'tests': ['tsvgm']}}, 09:46:26 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:46:26 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:46:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:46:26 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:46:26 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:46:26 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:46:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:46:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:26 INFO - 'talos_options': ['--e10s'], 09:46:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:46:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:26 INFO - 'tests': ['damp', 'tps']}, 09:46:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:26 INFO - 'talos_options': ['--e10s'], 09:46:26 INFO - 'tests': ['damp', 'tps']}, 09:46:26 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:46:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:46:26 INFO - 'other': {'tests': ['a11yr', 09:46:26 INFO - 'ts_paint', 09:46:26 INFO - 'tpaint', 09:46:26 INFO - 'sessionrestore', 09:46:26 INFO - 'sessionrestore_no_auto_restore']}, 09:46:26 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:46:26 INFO - 'tests': ['a11yr', 09:46:26 INFO - 'ts_paint', 09:46:26 INFO - 'tpaint', 09:46:26 INFO - 'sessionrestore', 09:46:26 INFO - 'sessionrestore_no_auto_restore']}, 09:46:26 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:46:26 INFO - 'tests': ['a11yr', 09:46:26 INFO - 'ts_paint', 09:46:26 INFO - 'tpaint', 09:46:26 INFO - 'sessionrestore', 09:46:26 INFO - 'sessionrestore_no_auto_restore']}, 09:46:26 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:46:26 INFO - 'tests': ['a11yr', 09:46:26 INFO - 'ts_paint', 09:46:26 INFO - 'tpaint', 09:46:26 INFO - 'sessionrestore', 09:46:26 INFO - 'sessionrestore_no_auto_restore']}, 09:46:26 INFO - 'other_l64': {'tests': ['a11yr', 09:46:26 INFO - 'ts_paint', 09:46:26 INFO - 'tpaint', 09:46:26 INFO - 'sessionrestore', 09:46:26 INFO - 'sessionrestore_no_auto_restore']}, 09:46:26 INFO - 'other_nol64': {'tests': ['a11yr', 09:46:26 INFO - 'ts_paint', 09:46:26 INFO - 'tpaint', 09:46:26 INFO - 'sessionrestore', 09:46:26 INFO - 'sessionrestore_no_auto_restore']}, 09:46:26 INFO - 'svgr': {'tests': ['tsvgx', 09:46:26 INFO - 'tsvgr_opacity', 09:46:26 INFO - 'tart', 09:46:26 INFO - 'tscrollx', 09:46:26 INFO - 'cart']}, 09:46:26 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:46:26 INFO - 'tests': ['tsvgx', 09:46:26 INFO - 'tsvgr_opacity', 09:46:26 INFO - 'tart', 09:46:26 INFO - 'tscrollx', 09:46:26 INFO - 'cart']}, 09:46:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:26 INFO - 'tests': ['tp5o']}, 09:46:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:26 INFO - 'talos_options': ['--e10s'], 09:46:26 INFO - 'tests': ['tp5o']}, 09:46:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:26 INFO - 'talos_options': ['--xperf_path', 09:46:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:46:26 INFO - 'tests': ['tp5n']}, 09:46:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:26 INFO - 'talos_options': ['--e10s', 09:46:26 INFO - '--xperf_path', 09:46:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:46:26 INFO - 'tests': ['tp5n']}}, 09:46:26 INFO - 'talos.zip': {'path': '', 09:46:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:46:26 INFO - Running post-action listener: _resource_record_post_action 09:46:26 INFO - ##### 09:46:26 INFO - ##### Running create-virtualenv step. 09:46:26 INFO - ##### 09:46:26 INFO - Running pre-action listener: _resource_record_pre_action 09:46:26 INFO - Running main action method: create_virtualenv 09:46:26 INFO - Creating virtualenv /builds/slave/test/build/venv 09:46:26 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 09:46:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:46:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:46:26 INFO - Using real prefix '/usr' 09:46:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:46:26 INFO - Installing distribute.............................................................................................................................................................................................done. 09:46:28 INFO - Installing pip.................done. 09:46:28 INFO - Return code: 0 09:46:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:46:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7a02f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cd6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d650b0>, '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 0x1d65fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d66440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1449164771.155881-944245847', '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 09:46:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:46:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:46:28 INFO - Using env: {'DISPLAY': ':0', 09:46:28 INFO - 'HOME': '/home/cltbld', 09:46:28 INFO - 'LANG': 'en_US.UTF-8', 09:46:28 INFO - 'LANGUAGE': 'en_US:en', 09:46:28 INFO - 'LOGNAME': 'cltbld', 09:46:28 INFO - 'MAIL': '/var/mail/cltbld', 09:46:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:28 INFO - 'MOZ_NO_REMOTE': '1', 09:46:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:28 INFO - 'NO_EM_RESTART': '1', 09:46:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:28 INFO - 'PWD': '/builds/slave/test', 09:46:28 INFO - 'SHELL': '/bin/bash', 09:46:28 INFO - 'SHLVL': '1', 09:46:28 INFO - 'TERM': 'linux', 09:46:28 INFO - 'TMOUT': '86400', 09:46:28 INFO - 'USER': 'cltbld', 09:46:28 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1449164771.155881-944245847', 09:46:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:28 INFO - '_': '/tools/buildbot/bin/python'} 09:46:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:29 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 09:46:29 INFO - Cleaning up... 09:46:29 INFO - Return code: 0 09:46:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:46:29 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')]} 09:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:29 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')]} 09:46:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:29 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 0x7fb7a02f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cd6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d650b0>, '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 0x1d65fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d66440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1449164771.155881-944245847', '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 09:46:29 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 09:46:29 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 09:46:29 INFO - Using env: {'DISPLAY': ':0', 09:46:29 INFO - 'HOME': '/home/cltbld', 09:46:29 INFO - 'LANG': 'en_US.UTF-8', 09:46:29 INFO - 'LANGUAGE': 'en_US:en', 09:46:29 INFO - 'LOGNAME': 'cltbld', 09:46:29 INFO - 'MAIL': '/var/mail/cltbld', 09:46:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:29 INFO - 'MOZ_NO_REMOTE': '1', 09:46:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:29 INFO - 'NO_EM_RESTART': '1', 09:46:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:29 INFO - 'PWD': '/builds/slave/test', 09:46:29 INFO - 'SHELL': '/bin/bash', 09:46:29 INFO - 'SHLVL': '1', 09:46:29 INFO - 'TERM': 'linux', 09:46:29 INFO - 'TMOUT': '86400', 09:46:29 INFO - 'USER': 'cltbld', 09:46:29 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1449164771.155881-944245847', 09:46:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:29 INFO - '_': '/tools/buildbot/bin/python'} 09:46:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:29 INFO - Downloading/unpacking psutil>=0.7.1 09:46: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 09:46: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 09:46: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 09:46: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 09:46: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 09:46: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 09:46:30 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 09:46:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:46:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:46:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:46:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:46:31 INFO - Installing collected packages: psutil 09:46:31 INFO - Running setup.py install for psutil 09:46:31 INFO - building 'psutil._psutil_linux' extension 09:46:31 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 09:46:31 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 09:46:31 INFO - building 'psutil._psutil_posix' extension 09:46:31 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 09:46:31 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 09:46:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:46:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:46:31 INFO - Successfully installed psutil 09:46:31 INFO - Cleaning up... 09:46:31 INFO - Return code: 0 09:46:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:46:31 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')]} 09:46:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:31 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')]} 09:46:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:31 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 0x7fb7a02f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cd6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d650b0>, '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 0x1d65fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d66440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1449164771.155881-944245847', '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 09:46:31 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 09:46:31 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 09:46:31 INFO - Using env: {'DISPLAY': ':0', 09:46:31 INFO - 'HOME': '/home/cltbld', 09:46:31 INFO - 'LANG': 'en_US.UTF-8', 09:46:31 INFO - 'LANGUAGE': 'en_US:en', 09:46:31 INFO - 'LOGNAME': 'cltbld', 09:46:31 INFO - 'MAIL': '/var/mail/cltbld', 09:46:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:31 INFO - 'MOZ_NO_REMOTE': '1', 09:46:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:31 INFO - 'NO_EM_RESTART': '1', 09:46:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:31 INFO - 'PWD': '/builds/slave/test', 09:46:31 INFO - 'SHELL': '/bin/bash', 09:46:31 INFO - 'SHLVL': '1', 09:46:31 INFO - 'TERM': 'linux', 09:46:31 INFO - 'TMOUT': '86400', 09:46:31 INFO - 'USER': 'cltbld', 09:46:31 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1449164771.155881-944245847', 09:46:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:31 INFO - '_': '/tools/buildbot/bin/python'} 09:46:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:46:31 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 09:46:31 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 09:46:31 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 09:46:31 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 09:46:31 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 09:46:31 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 09:46:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:46:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:46:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:46:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:46:33 INFO - Installing collected packages: mozsystemmonitor 09:46:33 INFO - Running setup.py install for mozsystemmonitor 09:46:33 INFO - Successfully installed mozsystemmonitor 09:46:33 INFO - Cleaning up... 09:46:33 INFO - Return code: 0 09:46:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:46:33 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')]} 09:46:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:33 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')]} 09:46:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:33 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 0x7fb7a02f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cd6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d650b0>, '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 0x1d65fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d66440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1449164771.155881-944245847', '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 09:46:33 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 09:46:33 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 09:46:33 INFO - Using env: {'DISPLAY': ':0', 09:46:33 INFO - 'HOME': '/home/cltbld', 09:46:33 INFO - 'LANG': 'en_US.UTF-8', 09:46:33 INFO - 'LANGUAGE': 'en_US:en', 09:46:33 INFO - 'LOGNAME': 'cltbld', 09:46:33 INFO - 'MAIL': '/var/mail/cltbld', 09:46:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:33 INFO - 'MOZ_NO_REMOTE': '1', 09:46:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:33 INFO - 'NO_EM_RESTART': '1', 09:46:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:33 INFO - 'PWD': '/builds/slave/test', 09:46:33 INFO - 'SHELL': '/bin/bash', 09:46:33 INFO - 'SHLVL': '1', 09:46:33 INFO - 'TERM': 'linux', 09:46:33 INFO - 'TMOUT': '86400', 09:46:33 INFO - 'USER': 'cltbld', 09:46:33 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1449164771.155881-944245847', 09:46:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:33 INFO - '_': '/tools/buildbot/bin/python'} 09:46:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:33 INFO - Downloading/unpacking blobuploader==1.2.4 09:46:33 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 09:46:33 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 09:46:33 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 09:46:33 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 09:46:33 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 09:46:33 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 09:46:35 INFO - Downloading blobuploader-1.2.4.tar.gz 09:46:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:46:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:46:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:46:35 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 09:46:35 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 09:46:35 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 09:46:35 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 09:46:35 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 09:46:35 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 09:46:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:46:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:46:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:46:36 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 09:46:36 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 09:46:36 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 09:46:36 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 09:46:36 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 09:46:36 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 09:46:36 INFO - Downloading docopt-0.6.1.tar.gz 09:46:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:46:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:46:36 INFO - Installing collected packages: blobuploader, requests, docopt 09:46:36 INFO - Running setup.py install for blobuploader 09:46:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:46:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:46:36 INFO - Running setup.py install for requests 09:46:36 INFO - Running setup.py install for docopt 09:46:36 INFO - Successfully installed blobuploader requests docopt 09:46:36 INFO - Cleaning up... 09:46:36 INFO - Return code: 0 09:46:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:46:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:36 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 0x7fb7a02f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cd6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d650b0>, '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 0x1d65fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d66440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1449164771.155881-944245847', '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 09:46:36 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 09:46:36 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 09:46:36 INFO - Using env: {'DISPLAY': ':0', 09:46:36 INFO - 'HOME': '/home/cltbld', 09:46:36 INFO - 'LANG': 'en_US.UTF-8', 09:46:36 INFO - 'LANGUAGE': 'en_US:en', 09:46:36 INFO - 'LOGNAME': 'cltbld', 09:46:36 INFO - 'MAIL': '/var/mail/cltbld', 09:46:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:36 INFO - 'MOZ_NO_REMOTE': '1', 09:46:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:36 INFO - 'NO_EM_RESTART': '1', 09:46:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:36 INFO - 'PWD': '/builds/slave/test', 09:46:36 INFO - 'SHELL': '/bin/bash', 09:46:36 INFO - 'SHLVL': '1', 09:46:36 INFO - 'TERM': 'linux', 09:46:36 INFO - 'TMOUT': '86400', 09:46:36 INFO - 'USER': 'cltbld', 09:46:36 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1449164771.155881-944245847', 09:46:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:36 INFO - '_': '/tools/buildbot/bin/python'} 09:46:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:46:37 INFO - Running setup.py (path:/tmp/pip-JSeWeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:46:37 INFO - Running setup.py (path:/tmp/pip-_b2E4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:46:37 INFO - Running setup.py (path:/tmp/pip-O8rw_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:46:37 INFO - Running setup.py (path:/tmp/pip-HYMUMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:46:37 INFO - Running setup.py (path:/tmp/pip-AbuWWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:46:37 INFO - Running setup.py (path:/tmp/pip-rXR3mR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:46:37 INFO - Running setup.py (path:/tmp/pip-YEgkwP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:46:37 INFO - Running setup.py (path:/tmp/pip-ENmiPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:46:37 INFO - Running setup.py (path:/tmp/pip-5rEl9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:46:37 INFO - Running setup.py (path:/tmp/pip-imbAPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:46:37 INFO - Running setup.py (path:/tmp/pip-XxgTZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:46:37 INFO - Running setup.py (path:/tmp/pip-85AKFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:46:37 INFO - Running setup.py (path:/tmp/pip-55HtpZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:46:38 INFO - Running setup.py (path:/tmp/pip-g836QU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:46:38 INFO - Running setup.py (path:/tmp/pip-7LR1IN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:46:38 INFO - Running setup.py (path:/tmp/pip-doikZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:46:38 INFO - Running setup.py (path:/tmp/pip-9G7eHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:46:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:46:38 INFO - Running setup.py install for manifestparser 09:46:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:46:38 INFO - Running setup.py install for mozcrash 09:46:38 INFO - Running setup.py install for mozdebug 09:46:38 INFO - Running setup.py install for mozdevice 09:46:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:46:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:46:38 INFO - Running setup.py install for mozfile 09:46:38 INFO - Running setup.py install for mozhttpd 09:46:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:46:38 INFO - Running setup.py install for mozinfo 09:46:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:46:39 INFO - Running setup.py install for mozInstall 09:46:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:46:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:46:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:46:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:46:39 INFO - Running setup.py install for mozleak 09:46:39 INFO - Running setup.py install for mozlog 09:46:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:46:39 INFO - Running setup.py install for moznetwork 09:46:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:46:39 INFO - Running setup.py install for mozprocess 09:46:39 INFO - Running setup.py install for mozprofile 09:46:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:46:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:46:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:46:39 INFO - Running setup.py install for mozrunner 09:46:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:46:39 INFO - Running setup.py install for mozscreenshot 09:46:39 INFO - Running setup.py install for moztest 09:46:39 INFO - Running setup.py install for mozversion 09:46:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:46:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:46:40 INFO - Cleaning up... 09:46:40 INFO - Return code: 0 09:46:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:46:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:40 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 0x7fb7a02f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cd6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d650b0>, '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 0x1d65fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d66440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1449164771.155881-944245847', '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 09:46:40 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 09:46:40 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 09:46:40 INFO - Using env: {'DISPLAY': ':0', 09:46:40 INFO - 'HOME': '/home/cltbld', 09:46:40 INFO - 'LANG': 'en_US.UTF-8', 09:46:40 INFO - 'LANGUAGE': 'en_US:en', 09:46:40 INFO - 'LOGNAME': 'cltbld', 09:46:40 INFO - 'MAIL': '/var/mail/cltbld', 09:46:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:40 INFO - 'MOZ_NO_REMOTE': '1', 09:46:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:40 INFO - 'NO_EM_RESTART': '1', 09:46:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:40 INFO - 'PWD': '/builds/slave/test', 09:46:40 INFO - 'SHELL': '/bin/bash', 09:46:40 INFO - 'SHLVL': '1', 09:46:40 INFO - 'TERM': 'linux', 09:46:40 INFO - 'TMOUT': '86400', 09:46:40 INFO - 'USER': 'cltbld', 09:46:40 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1449164771.155881-944245847', 09:46:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:40 INFO - '_': '/tools/buildbot/bin/python'} 09:46:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:46:40 INFO - Running setup.py (path:/tmp/pip-GMZg6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:46:40 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)) 09:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:46:40 INFO - Running setup.py (path:/tmp/pip-43XkQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:46:40 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)) 09:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:46:40 INFO - Running setup.py (path:/tmp/pip-xrmL4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:46:40 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)) 09:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:46:40 INFO - Running setup.py (path:/tmp/pip-eISnOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:46:40 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)) 09:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:46:40 INFO - Running setup.py (path:/tmp/pip-SvoKj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:46:40 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)) 09:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:46:40 INFO - Running setup.py (path:/tmp/pip-nyM3SF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:46:40 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)) 09:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:46:40 INFO - Running setup.py (path:/tmp/pip-6ZHfec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:46:40 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)) 09:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:46:40 INFO - Running setup.py (path:/tmp/pip-AhjvF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:46:40 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)) 09:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:46:40 INFO - Running setup.py (path:/tmp/pip-eKgZdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:46:40 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)) 09:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:46:40 INFO - Running setup.py (path:/tmp/pip-YUcbUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:46:40 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)) 09:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:46:40 INFO - Running setup.py (path:/tmp/pip-bFQfdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:46:41 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)) 09:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:46:41 INFO - Running setup.py (path:/tmp/pip-Y0nazT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:46:41 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)) 09:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:46:41 INFO - Running setup.py (path:/tmp/pip-3X52fm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:46:41 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)) 09:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:46:41 INFO - Running setup.py (path:/tmp/pip-DkXh_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:46:41 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)) 09:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:46:41 INFO - Running setup.py (path:/tmp/pip-3Z452Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:46:41 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)) 09:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:46:41 INFO - Running setup.py (path:/tmp/pip-nsOYxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:46:41 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)) 09:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:46:41 INFO - Running setup.py (path:/tmp/pip-pxZ7gt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:46:41 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)) 09:46:41 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)) 09:46:41 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)) 09:46:41 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)) 09:46:41 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)) 09:46:41 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)) 09:46:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:46:41 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 09:46:41 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 09:46:41 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 09:46:41 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 09:46:41 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 09:46:41 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 09:46:43 INFO - Downloading blessings-1.5.1.tar.gz 09:46:43 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 09:46:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:46:43 INFO - Installing collected packages: blessings 09:46:43 INFO - Running setup.py install for blessings 09:46:43 INFO - Successfully installed blessings 09:46:43 INFO - Cleaning up... 09:46:43 INFO - Return code: 0 09:46:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:46:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:46:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:46:43 INFO - Reading from file tmpfile_stdout 09:46:43 INFO - Current package versions: 09:46:43 INFO - argparse == 1.2.1 09:46:43 INFO - blessings == 1.5.1 09:46:43 INFO - blobuploader == 1.2.4 09:46:43 INFO - docopt == 0.6.1 09:46:43 INFO - manifestparser == 1.1 09:46:43 INFO - mozInstall == 1.12 09:46:43 INFO - mozcrash == 0.16 09:46:43 INFO - mozdebug == 0.1 09:46:43 INFO - mozdevice == 0.47 09:46:43 INFO - mozfile == 1.2 09:46:43 INFO - mozhttpd == 0.7 09:46:43 INFO - mozinfo == 0.9 09:46:43 INFO - mozleak == 0.1 09:46:43 INFO - mozlog == 3.1 09:46:43 INFO - moznetwork == 0.27 09:46:43 INFO - mozprocess == 0.22 09:46:43 INFO - mozprofile == 0.27 09:46:43 INFO - mozrunner == 6.11 09:46:43 INFO - mozscreenshot == 0.1 09:46:43 INFO - mozsystemmonitor == 0.0 09:46:43 INFO - moztest == 0.7 09:46:43 INFO - mozversion == 1.4 09:46:43 INFO - psutil == 3.1.1 09:46:43 INFO - requests == 1.2.3 09:46:43 INFO - wsgiref == 0.1.2 09:46:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:46:43 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')]} 09:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:43 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')]} 09:46:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:43 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 0x7fb7a02f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cd6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d650b0>, '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 0x1d65fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d66440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1449164771.155881-944245847', '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 09:46:43 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 09:46:43 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 09:46:43 INFO - Using env: {'DISPLAY': ':0', 09:46:43 INFO - 'HOME': '/home/cltbld', 09:46:43 INFO - 'LANG': 'en_US.UTF-8', 09:46:43 INFO - 'LANGUAGE': 'en_US:en', 09:46:43 INFO - 'LOGNAME': 'cltbld', 09:46:43 INFO - 'MAIL': '/var/mail/cltbld', 09:46:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:43 INFO - 'MOZ_NO_REMOTE': '1', 09:46:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:43 INFO - 'NO_EM_RESTART': '1', 09:46:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:43 INFO - 'PWD': '/builds/slave/test', 09:46:43 INFO - 'SHELL': '/bin/bash', 09:46:43 INFO - 'SHLVL': '1', 09:46:43 INFO - 'TERM': 'linux', 09:46:43 INFO - 'TMOUT': '86400', 09:46:43 INFO - 'USER': 'cltbld', 09:46:43 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1449164771.155881-944245847', 09:46:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:43 INFO - '_': '/tools/buildbot/bin/python'} 09:46:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:43 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)) 09:46:43 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)) 09:46:43 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)) 09:46:43 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)) 09:46:43 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)) 09:46:43 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)) 09:46:43 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)) 09:46:43 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)) 09:46:43 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)) 09:46:43 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)) 09:46:43 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)) 09:46:43 INFO - Cleaning up... 09:46:43 INFO - Return code: 0 09:46:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:46:43 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')]} 09:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:43 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')]} 09:46:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:43 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 0x7fb7a02f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cd6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d650b0>, '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 0x1d65fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d66440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1449164771.155881-944245847', '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 09:46:43 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 09:46:43 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 09:46:43 INFO - Using env: {'DISPLAY': ':0', 09:46:43 INFO - 'HOME': '/home/cltbld', 09:46:43 INFO - 'LANG': 'en_US.UTF-8', 09:46:43 INFO - 'LANGUAGE': 'en_US:en', 09:46:43 INFO - 'LOGNAME': 'cltbld', 09:46:43 INFO - 'MAIL': '/var/mail/cltbld', 09:46:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:43 INFO - 'MOZ_NO_REMOTE': '1', 09:46:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:43 INFO - 'NO_EM_RESTART': '1', 09:46:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:43 INFO - 'PWD': '/builds/slave/test', 09:46:43 INFO - 'SHELL': '/bin/bash', 09:46:43 INFO - 'SHLVL': '1', 09:46:43 INFO - 'TERM': 'linux', 09:46:43 INFO - 'TMOUT': '86400', 09:46:43 INFO - 'USER': 'cltbld', 09:46:43 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1449164771.155881-944245847', 09:46:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:43 INFO - '_': '/tools/buildbot/bin/python'} 09:46:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:44 INFO - Downloading/unpacking jsonschema 09:46:44 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 09:46:44 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 09:46:44 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 09:46:44 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 09:46:44 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 09:46:44 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 09:46:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:46:45 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 09:46:45 INFO - Downloading/unpacking functools32 (from jsonschema) 09:46:45 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 09:46:45 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 09:46:45 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 09:46:45 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 09:46:45 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 09:46:45 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 09:46:45 INFO - Downloading functools32-3.2.3-2.tar.gz 09:46:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 09:46:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:46:46 INFO - warning: no files found matching '*.txt' 09:46:46 INFO - no previously-included directories found matching 'build' 09:46:46 INFO - no previously-included directories found matching 'dist' 09:46:46 INFO - no previously-included directories found matching '.git*' 09:46:46 INFO - Installing collected packages: jsonschema, functools32 09:46:46 INFO - Running setup.py install for functools32 09:46:46 INFO - warning: no files found matching '*.txt' 09:46:46 INFO - no previously-included directories found matching 'build' 09:46:46 INFO - no previously-included directories found matching 'dist' 09:46:46 INFO - no previously-included directories found matching '.git*' 09:46:46 INFO - Successfully installed jsonschema functools32 09:46:46 INFO - Cleaning up... 09:46:46 INFO - Return code: 0 09:46:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:46:46 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')]} 09:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:46 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')]} 09:46:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:46 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 0x7fb7a02f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cd6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d650b0>, '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 0x1d65fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d66440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1449164771.155881-944245847', '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 09:46:46 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 09:46:46 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 09:46:46 INFO - Using env: {'DISPLAY': ':0', 09:46:46 INFO - 'HOME': '/home/cltbld', 09:46:46 INFO - 'LANG': 'en_US.UTF-8', 09:46:46 INFO - 'LANGUAGE': 'en_US:en', 09:46:46 INFO - 'LOGNAME': 'cltbld', 09:46:46 INFO - 'MAIL': '/var/mail/cltbld', 09:46:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:46 INFO - 'MOZ_NO_REMOTE': '1', 09:46:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:46 INFO - 'NO_EM_RESTART': '1', 09:46:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:46 INFO - 'PWD': '/builds/slave/test', 09:46:46 INFO - 'SHELL': '/bin/bash', 09:46:46 INFO - 'SHLVL': '1', 09:46:46 INFO - 'TERM': 'linux', 09:46:46 INFO - 'TMOUT': '86400', 09:46:46 INFO - 'USER': 'cltbld', 09:46:46 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1449164771.155881-944245847', 09:46:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:46 INFO - '_': '/tools/buildbot/bin/python'} 09:46:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:46 INFO - Downloading/unpacking flake8 09:46:46 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 09:46:46 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 09:46:46 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 09:46:46 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 09:46:46 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 09:46:46 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 09:46:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:46:48 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 09:46:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:46:48 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 09:46:48 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 09:46:48 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 09:46:48 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 09:46:48 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 09:46:48 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 09:46:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:46:48 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 09:46:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:46:48 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 09:46:48 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 09:46:48 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 09:46:48 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 09:46:48 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 09:46:48 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 09:46:48 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 09:46:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:46:48 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 09:46:48 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 09:46:48 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 09:46:48 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 09:46:48 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 09:46:48 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 09:46:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 09:46:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:46:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:46:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:46:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:46:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:46:48 INFO - no previously-included directories found matching 'docs/_build' 09:46:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:46:48 INFO - Running setup.py install for pep8 09:46:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:46:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:46:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:46:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:46:48 INFO - no previously-included directories found matching 'docs/_build' 09:46:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:46:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:46:48 INFO - Cleaning up... 09:46:49 INFO - Return code: 0 09:46:49 INFO - Running post-action listener: _resource_record_post_action 09:46:49 INFO - Running post-action listener: _start_resource_monitoring 09:46:49 INFO - Starting resource monitoring. 09:46:49 INFO - ##### 09:46:49 INFO - ##### Running install step. 09:46:49 INFO - ##### 09:46:49 INFO - Running pre-action listener: _resource_record_pre_action 09:46:49 INFO - Running main action method: install 09:46:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:46:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:46:49 INFO - Reading from file tmpfile_stdout 09:46:49 INFO - Detecting whether we're running mozinstall >=1.0... 09:46:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:46:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:46:49 INFO - Reading from file tmpfile_stdout 09:46:49 INFO - Output received: 09:46:49 INFO - Usage: mozinstall [options] installer 09:46:49 INFO - Options: 09:46:49 INFO - -h, --help show this help message and exit 09:46:49 INFO - -d DEST, --destination=DEST 09:46:49 INFO - Directory to install application into. [default: 09:46:49 INFO - "/builds/slave/test"] 09:46:49 INFO - --app=APP Application being installed. [default: firefox] 09:46:49 INFO - mkdir: /builds/slave/test/build/application 09:46:49 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'] 09:46:49 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 09:47:04 INFO - Reading from file tmpfile_stdout 09:47:04 INFO - Output received: 09:47:04 INFO - /builds/slave/test/build/application/firefox/firefox 09:47:04 INFO - Running post-action listener: _resource_record_post_action 09:47:04 INFO - ##### 09:47:04 INFO - ##### Running run-tests step. 09:47:04 INFO - ##### 09:47:04 INFO - Running pre-action listener: _resource_record_pre_action 09:47:04 INFO - Running main action method: run_tests 09:47:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:47:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:47:04 INFO - Python 2.7.3 09:47:04 INFO - Return code: 0 09:47:04 INFO - grabbing minidump binary from tooltool 09:47:04 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')]} 09:47:04 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 0x1d650b0>, '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 0x1d65fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d66440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:47:04 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 09:47:04 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 09:47:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:47:04 INFO - Return code: 0 09:47:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:47:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:47:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:47:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:47:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:47:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:47:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:47:05 INFO - Return code: 0 09:47:05 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/QMvx9AlpRrKEkIELHqYFEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost'] in /builds/slave/test/build 09:47:05 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/QMvx9AlpRrKEkIELHqYFEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost 09:47:05 INFO - Using env: {'DISPLAY': ':0', 09:47:05 INFO - 'HOME': '/home/cltbld', 09:47:05 INFO - 'LANG': 'en_US.UTF-8', 09:47:05 INFO - 'LANGUAGE': 'en_US:en', 09:47:05 INFO - 'LOGNAME': 'cltbld', 09:47:05 INFO - 'MAIL': '/var/mail/cltbld', 09:47:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:47:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:47:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:05 INFO - 'MOZ_NO_REMOTE': '1', 09:47:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:47:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:47:05 INFO - 'NO_EM_RESTART': '1', 09:47:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:47:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:05 INFO - 'PWD': '/builds/slave/test', 09:47:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:47:05 INFO - 'SHELL': '/bin/bash', 09:47:05 INFO - 'SHLVL': '1', 09:47:05 INFO - 'TERM': 'linux', 09:47:05 INFO - 'TMOUT': '86400', 09:47:05 INFO - 'USER': 'cltbld', 09:47:05 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1449164771.155881-944245847', 09:47:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:05 INFO - '_': '/tools/buildbot/bin/python'} 09:47:05 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/QMvx9AlpRrKEkIELHqYFEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost'] with output_timeout 3600 09:47:05 INFO - mozversion INFO | application_buildid: 20151203084126 09:47:05 INFO - mozversion INFO | application_changeset: 15ded62d213cb2e01feebcd21af52be74a535983 09:47:05 INFO - mozversion INFO | application_display_name: Nightly 09:47:05 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:47:05 INFO - mozversion INFO | application_name: Firefox 09:47:05 INFO - mozversion INFO | application_remotingname: firefox 09:47:05 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 09:47:05 INFO - mozversion INFO | application_vendor: Mozilla 09:47:05 INFO - mozversion INFO | application_version: 45.0a1 09:47:05 INFO - mozversion INFO | platform_buildid: 20151203084126 09:47:05 INFO - mozversion INFO | platform_changeset: 15ded62d213cb2e01feebcd21af52be74a535983 09:47:05 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 09:47:05 INFO - mozversion INFO | platform_version: 45.0a1 09:47:05 INFO - 2015-12-03 09:47:05,300 DEBUG : using testdate: 1449164825 09:47:05 INFO - 2015-12-03 09:47:05,301 DEBUG : actual date: 1449164825 09:47:05 INFO - 2015-12-03 09:47:05,310 INFO : starting webserver on 'localhost:57023' 09:47:05 INFO - 2015-12-03 09:47:05,311 INFO : Starting test suite talos-linux64-ix-001 09:47:05 INFO - 2015-12-03 09:47:05,311 INFO : Starting test dromaeo_css 09:47:05 INFO - 2015-12-03 09:47:05,311 DEBUG : operating with platform_type : linux_ 09:47:05 INFO - 2015-12-03 09:47:05,312 INFO : Initialising browser for dromaeo_css test... 09:47:05 INFO - 2015-12-03 09:47:05,324 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS0o3id/profile http://localhost:57023/getInfo.html 09:47:10 INFO - 2015-12-03 09:47:10,011 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:47:10 INFO - 2015-12-03 09:47:10,011 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:47:10 INFO - 2015-12-03 09:47:10,011 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:47:10 INFO - 2015-12-03 09:47:10,011 DEBUG : BROWSER_OUTPUT: __metrics 09:47:10 INFO - 2015-12-03 09:47:10,099 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] 09:47:10 INFO - 2015-12-03 09:47:10,163 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] 09:47:11 INFO - 2015-12-03 09:47:11,094 INFO : Browser initialized. 09:47:11 INFO - 2015-12-03 09:47:11,095 INFO : Running cycle 1/1 for dromaeo_css test... 09:47:11 INFO - 2015-12-03 09:47:11,095 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS0o3id/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:47:23 INFO - 2015-12-03 09:47:23,143 DEBUG : BROWSER_OUTPUT: RSS: Main: 143687680 09:47:23 INFO - 2015-12-03 09:47:23,144 DEBUG : BROWSER_OUTPUT: 09:48:14 INFO - 2015-12-03 09:48:14,490 DEBUG : BROWSER_OUTPUT: 1449164894488 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] 09:50:26 INFO - 2015-12-03 09:50:26,618 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57023/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57023/tests/dromaeo/cssquery-ext.html) 09:50:27 INFO - 2015-12-03 09:50:27,790 DEBUG : BROWSER_OUTPUT: RSS: Main: 237973504 09:50:27 INFO - 2015-12-03 09:50:27,790 DEBUG : BROWSER_OUTPUT: 09:53:30 INFO - 2015-12-03 09:53:30,352 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57023/tests/dromaeo/cssquery-ext.html (next: http://localhost:57023/tests/dromaeo/cssquery-jquery.html) 09:53:30 INFO - 2015-12-03 09:53:30,934 DEBUG : BROWSER_OUTPUT: RSS: Main: 218525696 09:53:30 INFO - 2015-12-03 09:53:30,935 DEBUG : BROWSER_OUTPUT: 09:56:32 INFO - 2015-12-03 09:56:32,945 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57023/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57023/tests/dromaeo/cssquery-mootools.html) 09:56:33 INFO - 2015-12-03 09:56:33,519 DEBUG : BROWSER_OUTPUT: RSS: Main: 222306304 09:56:33 INFO - 2015-12-03 09:56:33,519 DEBUG : BROWSER_OUTPUT: 09:59:35 INFO - 2015-12-03 09:59:35,371 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57023/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57023/tests/dromaeo/cssquery-prototype.html) 09:59:35 INFO - 2015-12-03 09:59:35,957 DEBUG : BROWSER_OUTPUT: RSS: Main: 206823424 09:59:35 INFO - 2015-12-03 09:59:35,957 DEBUG : BROWSER_OUTPUT: 10:02:38 INFO - 2015-12-03 10:02:38,797 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57023/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57023/tests/dromaeo/cssquery-yui.html) 10:02:39 INFO - 2015-12-03 10:02:39,383 DEBUG : BROWSER_OUTPUT: RSS: Main: 207175680 10:02:39 INFO - 2015-12-03 10:02:39,383 DEBUG : BROWSER_OUTPUT: 10:05:41 INFO - 2015-12-03 10:05:41,875 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57023/tests/dromaeo/cssquery-yui.html (next: http://localhost:57023/tests/dromaeo/cssquery-dojo.html) 10:05:42 INFO - 2015-12-03 10:05:42,121 DEBUG : BROWSER_OUTPUT: RSS: Main: 252571648 10:05:42 INFO - 2015-12-03 10:05:42,121 DEBUG : BROWSER_OUTPUT: 10:05:42 INFO - 2015-12-03 10:05:42,123 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:05:42 INFO - 2015-12-03 10:05:42,123 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:05:42 INFO - 2015-12-03 10:05:42,123 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:05:42 INFO - 2015-12-03 10:05:42,123 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:05:42 INFO - 2015-12-03 10:05:42,125 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2573.691157061153;2687.046098634986;2693.474772419379;2700.891964321427;2722.441899410621;4546.56807603278;4636.791344389502;4678.345031695561;4698.530146985304;4711.175544279755;4561.292999585061;4596.954030459694;4634.2353511670535;4638.768061596915;4749.240121580548;4311.353297005443;4330.826766929319;4333.848315308965;4336.913261734763;4359.891002724926;4189.183109293689;4427.114577084596;4429.667774916878;4462.9065878859565;4477.171723231213;4197.895052623693;4227.450431443893;4237.724547904407;4320.222359975203;4350.521442641307;4328.069465065026;4348.782560871944;4355.0201204729;4380.693351465398;4386.4736231652405;4101.815418306183;4284.914301713949;4285.550017248175;4295.3771703102875;4338.327559228324;4437.689361744679;4445.422095127613;4541.6366690665;4660.464046634646;4686.179918514246;4998.4751601081725;5015.874603134915;5024.648274620778;5032.6477146599755;5064.417591976933;4840.419149702023;5031.698098114125;5043.344365232533;5048.242763585455;5072.442031376546;4608.216603177468;4644.373009643688;4662.487126416126;4716;4720.834770783006;5145.125328694131;5145.922811157836;5153.974230128901;5156.92264616031;5216.817411390583;4946.431160416598;4961.4294356148785;4962.255661650781;4968.205087186105;5015.272785446163;4687.601553867891;4786.2820576913045;4792.041591681677;4795.017021510582;4928.728919909439;4973;4992.90014199714;5000.599952003831;5004.799808007711;5014.197728363444;4952.876178095505;4961.206207006934;4961.231009193581;4969.602431805447;5021.397432308073;3974.841006359771;4127.174565086994;4132.876013719593;4165.291900376943;4202.432671589297;3608.855645774192;3656;3701.555813302421;3703.129764505339;3715.925681486355;4298.161858437637;4327.415798867176;4336.241157797373;4336.956630433719;4375.431193944767;4785.377900872864;4885.706857588556;5014.949850501521;5071.518205770446;5122.410922743858;4222.556631553643;4231.407602935591;4245.3207486802585;4289.034967132433;4339.284018137035;4411.250087485135;4414;4417.801198946056;4427.512973572904;4464.955350446519;4754.453237877619;4755.191617424977;4761.357216775829;4798.880027999328;4813.831515897067;4733.5503127202865;4848.61211103118;4850.975745121252;4911.435184953633;5032.471590482946;4718.197906355859;4753.0256297458245;4762.190427627243;4765.523447655207;4805.8558243252755;4923;4931.556159945622;4936.062148191832;4941.65408421407;4973.52751488608;4863.294822250825;4936.136176169084;5000.2499625056535;5004.449510553909;5038.118329292286;4906.656534042726;4917.434495033117;4929.457759646508;4931.112399768076;4933.235348520985;4903.26451032348;4943.480934501969;4949.57928576075;4950.480199578992;4975.179095449355;4517.322401639781;4609.7464639443815;4611.123886461562;4679.578837904605;4880.633952453509;4904.362432883702;4906.975465122651;4935.629827763004;4945.381827271591;4945.579625731709;4795.784189711401;4798.520147985174;4802.351682522954;4802.423709154924;4847.321375007572 10:05:42 INFO - 2015-12-03 10:05:42,126 DEBUG : BROWSER_OUTPUT: |1;ext.html;558.9385167631561;569.7578529125124;575.8445219790659;585.467224825409;592.1088761414071;27720.306992325175;36159.63840361599;36859;37076.443853342156;37114.62885371145;39281.60718392815;39718.40422393666;39849.800750996204;39908;39949.60050399495;6737.663116844163;6826.69279882404;7836.8040798980055;8001.599920004006;8004.479708818908;10098.040686134806;10364.948175259113;10368.377897326147;10368.688939331794;10371.274010819208;9984.35101718386;10080.747981300452;10087.344322619007;10087.394756314645;10095.747606309827;7030.648467576626;7167.928320716778;7178.318059784312;7178.4616153788675;9881.802363952716;6882.380585747307;10064.446455444948;10322;10327.225458090674;10329.225308101923;36250.63749362499;36665.81667091647;36776.632233677585;36784;36786.448203276974;2663.600459931026;2753.972460275412;2788.3308006078596;2870.5407134858533;3312.751543634213;26491.602625960626;26783;26927.461450770876;26989.865050674816;27673.584896226574;3390.6609339066144;3399.5750531183603;3422.931541369159;3496.912577185565;3534.434490481536;211029;213816;213963;214269;214606;53602.731986339815;53961.73019134879;54015;54030.459695403326;54081.72959135179;53399;54530;57978.71010645004;63261.367386325546;64874.351256487775;12844.422001009976;12918.67703307406;12919.612411627666;13002.479900803863;13012.739745205043;9798.363106398061;9870.111689947938;9875.901240987498;9877.308588398742;9882.061204185591;18846.81153188478;19015.71476427827;19020.524486887938;19037.80962190388;19067.332643357695;7518.248175182547;7657.23427657241;7740.961295193601;7828.491148075357;7853.41099417546;812.3866480806953;869.9739007829776;918.025597065503;927.5825878354767;966.5843687214565;25771.226863194133;26235.34411639686;26236.73763262381;26308.342291442485;26352.20943371702;908.8500397434349;921.2721949659827;1002.8896821349646;1031.1235449867552;1037.4501514197486;13486.595402137951;13517.526886558922;13639.522616708367;13808.585742427744;13822.654433639038;253617;256441;257919;257925;259036;44274.778626106665;44760.77619611881;44768.10463790706;44818;44876.3268550972;1012.2155329619603;1097.1551905033239;1110.905573026302;1170.3329102411715;1199.8500187476566;23592.88203558971;24119.758802412452;24334.26997190087;25183;26588.335291617863;36426.27147456983;36740.08149796276;36754;36822.26355472822;36916.63083369132;301677;307856;308474;319647;320812;28906;28921.710782891903;28984.710152898202;29014.984475543253;29481.705182947895;37349.62650373462;38039;38396.6160338393;38669.6133038666;38943.221135577696;32622.673773261962;35728.28543429169;36306.81846590856;38135;38526.6147338523;33222.667773321955;33761.15597110092;33894.66105338915;34092.488612671325;34219.14452138716;33436.164095897795;33649.83175084109;33809.154771129935;33846.83076584601;33968.66031339754;29056.273593159494;29895.175480133872;30647.693523065376;30667.53998690066;30804.691953080182;23706.288811335686;24348.391290217885;24375.75624243735;24623.261302160965;24752.752472475044 10:05:42 INFO - 2015-12-03 10:05:42,127 DEBUG : BROWSER_OUTPUT: |2;jquery.html;323.6359096016981;325.9967400325997;326.12153993000317;328.6565539011734;329.5402912936452;12479.25124492531;12931.41808618612;14963;15409.614759631015;16481.42315018973;12181.390930453486;13903.235322057308;14080.929595352034;14093.083949543272;14113.717725645482;4883.218685010399;4913.312136300912;5038.647294689373;5040.672356296847;5042.495750424947;3395.9151021224543;3487.2676737885076;4960.131976904046;4997.30037794709;5059.949400506003;5162.767675454595;5176.5858731301405;5194;5211.45279745627;5212.087884620177;5063.696178229299;5132.101882170624;5195.1687729963405;5204.115300398904;5206.271122042917;4986.750662466899;5008.974955125237;5019.272205530177;5021.5229553192385;5025.698458092526;11453.141014423869;16949.66100677992;17161.399351022654;17547.649047019117;17625.559361016076;1705.7867766529184;1819.045001374276;1840.8343249107645;1862.37610400516;1873.7283093951437;8901.777455563599;9727.756806079833;10203.285769996104;12062.758744825054;12323.445444955;1688.8902221355572;1707.4109432245855;1714.322842477227;1760.6038641305731;1821.7358483019889;55480.72259638676;57763;57892.42107578913;58381.41618583845;58529.707351463396;9674.274429417821;9817.950910245403;9827;9883.258755593359;9900.306978511435;12377.381130943417;12569.183003104768;12642.115051946459;12651.873481265253;12654.493820247088;6863.142107236596;6887.896681549781;6890.896636550456;6913.239543650195;6940.687669054904;6487.935120648827;6491.091247225392;6527.510436717265;6543.770968016097;6560.048792924999;4084.7957602119777;4143.357779544175;4144.295469770146;4173.561776013536;4175.269327867611;1553.495114087926;1616.2403670274953;1626.341331760639;1655.5778276539406;1672.7741754863182;783.4868161354322;844.7127976488024;913.5523593439167;928.071928071928;945.4043952310001;15573.610659733597;15772.252610641472;15999.520553760425;16000.599985000468;16256.75614865778;731.6926890705917;813.3371302388534;820.5651004967258;902.3683421604903;902.8058967322057;8126.39052071097;8340.791480213044;8361.122569166568;8971.724539397961;9000.729978100668;407903;432255;434658;436677;443540;66435;67377.32622673809;67753.66123169352;68555.65722171457;69099.30900691029;872.5375550958129;932.4265576670434;956.502618638318;971.4511301114848;971.7522031881825;13561.796573051215;13902.721945561234;14342.713145737236;14388.928055359656;14473.855261447672;29189.270268243465;29190;29851.25371865634;29981.70018299789;30830;37708.43437348497;38051.23897522089;38527.229455411296;38920.41619375768;40329;8584.356173287153;8762.824743505222;8831.69089081879;9056.184943355129;9104.726858194264;10327.896721032694;10583.153347732008;11389.715257118638;15726.135062571211;16398.590035249214;12609.684757881127;12661.430235639602;13139.868601314247;13638.454461821813;13691;12412.937935310265;13076.869231307564;13531.255780932142;13587.252701101534;13941.790873136708;13421.731565368833;13633.25017124028;13718.725625487235;14176.787348189991;14338.49815256461;8944.776380590538;8946;9005.774855628662;9149.176574108362;9167.587458564247;9378.718638440858;13000.08999370035;13069.869301306866;13099.738005240033;13421.26183059902 10:05:42 INFO - 2015-12-03 10:05:42,128 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1436.4038923846604;1581.2568092996291;1642.5236681362405;1647.8764092693052;1671.9749203761946;6021.608595441298;6221.564490485668;6650.201975762903;6825.3857152856235;6862.656867156635;7019.5086343955945;7039.296070392971;7093.929060709392;7102.928970710292;7105.644717764104;2034.9999999999964;2072.823809976154;2073.2639912830955;2073.35725924963;2074.481379655086;2036.9185232590753;2085.124247815921;2086.478380404899;2088.665813469845;2091.7803630618796;2024.2712623455545;2041.224334752792;2041.6937459381063;2061.309461330456;2061.608294424062;2049.733534640495;2067.410787925434;2072.0986370928695;2072.316135675231;2073.502359433725;1945.8346040586566;1947.1140631012854;1999.7600287965392;2008.608321377332;2016.0625309231132;6002.399760024006;6840.931590684079;6917.066196063568;6919.411849992756;6930.653467326664;3576.660217279354;4040.1717647882406;4126.319157339036;4139.317012692902;4140.751554906685;2563.653906722587;2600.4409052053898;2600.6359109724654;2631.3947792007943;2631.513170063525;864.6800683747053;867.4188293843077;1596.5370042687723;1607.1482114479345;1607.887447878649;9450.19673327768;9530.999245079305;9543.904560954372;9554.952225238829;9555.092266234697;3784.508013958168;3826.253880493277;3842.2507611015585;3871.1676989447406;3899.220155968761;7487.288707572772;7518.135414427302;7518.473706840468;7523.3981281497345;7523.510971786816;4102.3026085565525;4107.116969851496;4110.034141976633;4112.074783173762;4125.319322311845;3751.249750050001;3781.697464202857;3782.3569993101237;3790.981045094812;3797.1266608680157;3139.6703346148784;3158.684131586823;3161.636411812671;3183.283761153722;3187.5378070179695;921.203159267229;930.8464103422995;958.5973890965811;961.4808003677936;972.1348000279756;1109.450821843193;1125.5610311978335;1136.8237923121928;1138.481990694232;1152.6945359479744;6374.713137908805;6464.676766161673;6464.676766161767;6503.317151699098;6506.967465162644;401.2436557089848;401.3417994488982;403.884892805549;404.87448890843933;405.3231104056233;4570.223062079388;5041.46235398207;5110;5115.104856650071;5125.026245013435;7182.3535881770895;8260.710875119463;8328.708495202638;8349.03986041613;8351.958240208882;8182.83634327322;8224.671013159526;8353.874691879626;8370.162983701703;8393.118722534167;6343.27052388972;6551.868962620721;6551.901721474182;6588.439982601532;6602.768903088465;6587.308332625005;6663.400293973566;6663.900041499478;6666.100076489612;6684;7164.641767911479;7444.627768611656;7446.367058799846;7447;7471.775846724607;7662.501937374052;7959.243871832166;7975.92024079775;8067.193280671886;8069.193080691884;6632.270450250372;6655.700493477708;6724.125863637696;6767.729290828312;6778.694958726967;6833.453323734188;6859.348361905611;6864.485163612849;6876.759313424006;6881.827954301182;6250;6295.96852015737;6379.585326953918;6390.009548519987;6508.479321654161;6142.170806941006;6273.466755325666;6292.905606415999;6434.806955791334;6508.967455162694;6291.465225455888;6296.937030629819;6299.275583307795;6303.243610766737;6332;5892.499137573354;5903.026000709835;5966.76132954677;5982.760689572368;5994.0409534474275;6008.849778755566;6025.548083893813;6067.575269731076;6068.393160683896;6070.2108725865355 10:05:42 INFO - 2015-12-03 10:05:42,129 DEBUG : BROWSER_OUTPUT: |4;prototype.html;290.6076796324961;293.55966050923615;297.7201430655184;299.67485278472844;301.0636919181347;5149.201873709576;5217.843464696056;5222.503862133091;5244.4493328200515;5332.040232758102;5177.508136727005;5178.896422071556;5215.295935048767;5217.843464696056;5224.973875130619;4099.897502562445;4102.241085399196;4104.404861295118;4119.155573107506;4123.60825721556;4103.343465045593;4110.321796903508;4114.423980642712;4116.135611521584;4116.588341165874;3886;4054.1688953764406;4071.42999980003;4076.2866498362814;4079.9592004080023;3997.060690737674;4021.7586944783407;4023.9396409054034;4028.315186418316;4033.9394909076386;3493.91265218369;3494.6505349465106;3495.3358861816173;3499.212677147647;3499.7725147865563;5068.949310506885;5074.391073071218;5083.974580127113;5088.109580823341;5093.0577843099145;4621.537846215385;4621.69958952667;4625.537446255381;4626.097910907374;4627.514111018329;5353.9732301338245;5488.91766623501;5490.615656904019;5494.972525137388;5495;3792.6965842732516;3795.658390744846;3796.5823759386444;3798.164403831153;3798.373268410709;5470.480304371078;5609.4390560943575;5705.115707065412;5789.334226563915;5797.072468405035;3771.6610603236004;3869.858391774433;3879.767213967171;3901.668358189586;3910.3743401056263;3950.051987522974;3952.6837852972267;3955.5451123120633;3959.425883246913;3960;4322.762248076386;4473.731576105444;4481.014176881081;4573.222552166139;4621.4223222097235;5519.089350257163;5524.66851988882;5531.446855314436;5535.142052981794;5540;1382.2397681275459;1404.5926681262524;1405.4729476446332;1405.9156450612995;1406.6131813751301;932.9766755831158;935.5275585829113;935.8362286599818;958.5255298627225;960.3325688646463;4804.375431193992;4818.253170758538;4823.541763532458;4825.855224343275;4827.058723548945;5716.1997320375185;5721.914171287434;5724.8282551523525;5726.198332233491;5727;4805.9759701201965;4808.0383923215495;4831.396075490564;4833.371661683958;4837.4920633333695;2732.5491293936675;2924.6490421149174;3054.083774867531;3080.830554319534;3085.6605773364913;5301.416844147141;5311;5317;5369.167778994262;5461.208124821958;5888.911666325009;5951.166836642873;5955.642661440327;5958.582899197101;5972.283326000907;5460.754266058037;5472.398036216013;5472.616916815785;5478.096114141122;5479.561635069264;5780.248567686174;5787.768489260551;5788.768449261982;5798.420157984167;5800.912986305125;5557.610967232416;5641.153826925994;5668.659880407189;5669.7165141741925;5677.091665333527;5452.809151679672;5464.508194262536;5467.5625949923115;5468.617196796186;5471.753771080391;3927.332353499855;3965.167314863911;3969.0871099646665;3970.622790834866;3971.2057588483;5301.522862942354;5503.944960550503;5785.479306862402;5788.218590490398;5796.913046304225;5406.4052954175795;5474.835754927359;5495.477929596842;5502.422245664147;5503.422140675171;5481.616286859881;5570.415106413769;5576.88462307532;5583.804566840141;5590.385057643574;5460.071787796005;5460.290162278879;5463.207834863843;5467.835964921059;5471.972640136773;5500.4499550044675;5587.497125258747;5603.943960560342;5612.859678507906;5615.8876822464135;5469.589780766379;5477.3427188737605;5492.890142197054;5493.725313734377;5494.692229263799 10:05:42 INFO - 2015-12-03 10:05:42,130 DEBUG : BROWSER_OUTPUT: |5;yui.html;611.0528680545154;624.7906951171358;690.9550879192852;701.3792793377859;736.8010637127979;11968.82046769298;12244.938775306122;12261.632151035472;13424.060315777899;13721.588352349421;13178.670533236675;13198.340082995835;13252.933735331333;13257.93371033146;13305.401256943436;625.2902955145919;632.0140580694109;779.12737733738;781.8631739445602;797.2665148063767;778.0391216847189;781.6756046240803;785.4972817396842;786.1902240692096;786.8111653203247;821.5645707774859;825.0182283083112;825.145973916996;825.3026192867018;825.8885050518163;647.0391468669022;653.3597074866634;814.8736945773414;830.983380332396;831.2311112221171;611.9816405507842;613.2334581772784;613.6686189457688;613.7360934798035;613.9938600613981;11091.72270693231;11121.55513779448;11127.944360278228;11187.160962927732;11223.158263130215;9852.90147098527;10240.94879525605;10291.53688084038;10855.131589472901;11268.830967535494;8848.690295839615;9145.679901203426;9381.390209636353;9503.382280151836;9584.185344245747;3135.843207839599;3181.3955348483946;3181.7136457718684;3186.713195812388;3209.518572214163;38243.617563824286;38288.234235315416;38465.42301865474;38539;38558.61441385578;8405.159484051546;8710.172533609297;8712.607932642919;8812;8933.59798809055;14968.326425310886;15005.924970375296;15060;15307.234638268043;16175.272112754954;5849.736761845727;5940.31686356066;6121.877562448726;6168.629882207082;6353.142325786052;3488.930221395558;3497.3387640870383;3501.1597216667815;3504.281622267429;3528.558930133733;2648.9867550662125;2672.706002339741;2678.049292501173;2683.7987150963754;2684.6107314439296;461.21593291404747;461.6376144726441;463.5133110234308;476.5234765234765;476.6663335665048;422.53943201909453;427.7690047374445;458.94263217097864;559.3735016781231;563.2452513631753;6874.725010999604;7060.364567188875;7065.081539399948;7122.323379278961;7258.927410725825;537.2639483907072;539.8677324055632;540.7755781350695;567.1662655895826;571.1005166862209;3277.901662950115;3292.9704671702093;3403.2512847173584;3404.8297585120645;3766.962330376661;50033.49966500361;50789.23816142761;50897;51097.744511277204;51900;42053.78973105115;42224.366634500504;42326;42773.57226427696;42926.35610465846;41097;41302.586974129874;41337.1732565347;41380;42248.57751422508;7459.664315105942;7544.321011109027;7647.158812530728;7819.335356494762;7845.450818442654;32388.83805580957;32654.795164103693;33087.83456082704;33092;33214.833925830215;37334;37453.43819842759;37532.437013445364;40870.59129408787;40876.707945666465;10245.692629221136;10385.065344119066;10406;10515.421651809223;10581.735456613646;11296;11313.151513636345;11315.20793544444;11340.886591133984;11600.361980091177;10332.276740628384;10384.221183411426;10449.686509404426;10501.264911456125;10509.78980420372;10309.432981185806;10664.893351066701;11003.449827508754;11072.667819965414;11360.091192704398;7776.339011183886;8914.777130571787;10076.193904487476;10213.387196768217;10887.129029677766;8993.685221017233;9158;9166.266698663958;9198.264138869008;9212.124848139416;8632;9185.035571265189;9274.860877086714;9296.349255552317;9298 10:05:42 INFO - 2015-12-03 10:05:42,130 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:05:42 INFO - 2015-12-03 10:05:42,130 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:05:42 INFO - 2015-12-03 10:05:42,130 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,990 10:05:42 INFO - 2015-12-03 10:05:42,130 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:05:42 INFO - 2015-12-03 10:05:42,131 DEBUG : BROWSER_OUTPUT: __startTimestamp1449165942122__endTimestamp 10:05:42 INFO - 2015-12-03 10:05:42,131 DEBUG : BROWSER_OUTPUT: 10:05:42 INFO - 2015-12-03 10:05:42,131 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:05:42 INFO - 2015-12-03 10:05:42,131 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:05:42 INFO - 2015-12-03 10:05:42,131 DEBUG : BROWSER_OUTPUT: 10:05:42 INFO - 2015-12-03 10:05:42,131 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4610.17 Median:4753.03 stddev:480.16 (10.1%) stddev-sans-first:454.28 10:05:42 INFO - 2015-12-03 10:05:42,131 DEBUG : BROWSER_OUTPUT: Values: 2573.7 2687.0 2693.5 2700.9 2722.4 4546.6 4636.8 4678.3 4698.5 4711.2 4561.3 4597.0 4634.2 4638.8 4749.2 4311.4 4330.8 4333.8 4336.9 4359.9 4189.2 4427.1 4429.7 4462.9 4477.2 4197.9 4227.5 4237.7 4320.2 4350.5 4328.1 4348.8 4355.0 4380.7 4386.5 4101.8 4284.9 4285.6 4295.4 4338.3 4437.7 4445.4 4541.6 4660.5 4686.2 4998.5 5015.9 5024.6 5032.6 5064.4 4840.4 5031.7 5043.3 5048.2 5072.4 4608.2 4644.4 4662.5 4716.0 4720.8 5145.1 5145.9 5154.0 5156.9 5216.8 4946.4 4961.4 4962.3 4968.2 5015.3 4687.6 4786.3 4792.0 4795.0 4928.7 4973.0 4992.9 5000.6 5004.8 5014.2 4952.9 4961.2 4961.2 4969.6 5021.4 3974.8 4127.2 4132.9 4165.3 4202.4 3608.9 3656.0 3701.6 3703.1 3715.9 4298.2 4327.4 4336.2 4337.0 4375.4 4785.4 4885.7 5014.9 5071.5 5122.4 4222.6 4231.4 4245.3 4289.0 4339.3 4411.3 4414.0 4417.8 4427.5 4465.0 4754.5 4755.2 4761.4 4798.9 4813.8 4733.6 4848.6 4851.0 4911.4 5032.5 4718.2 4753.0 4762.2 4765.5 4805.9 4923.0 4931.6 4936.1 4941.7 4973.5 4863.3 4936.1 5000.2 5004.4 5038.1 4906.7 4917.4 4929.5 4931.1 4933.2 4903.3 4943.5 4949.6 4950.5 4975.2 4517.3 4609.7 4611.1 4679.6 4880.6 4904.4 4907.0 4935.6 4945.4 4945.6 4795.8 4798.5 4802.4 4802.4 4847.3 10:05:42 INFO - 2015-12-03 10:05:42,131 DEBUG : BROWSER_OUTPUT: 10:05:42 INFO - 2015-12-03 10:05:42,132 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41935.08 Median:33705.49 stddev:68951.14 (204.6%) stddev-sans-first:69074.58 10:05:42 INFO - 2015-12-03 10:05:42,132 DEBUG : BROWSER_OUTPUT: Values: 558.9 569.8 575.8 585.5 592.1 27720.3 36159.6 36859.0 37076.4 37114.6 39281.6 39718.4 39849.8 39908.0 39949.6 6737.7 6826.7 7836.8 8001.6 8004.5 10098.0 10364.9 10368.4 10368.7 10371.3 9984.4 10080.7 10087.3 10087.4 10095.7 7030.6 7167.9 7178.3 7178.5 9881.8 6882.4 10064.4 10322.0 10327.2 10329.2 36250.6 36665.8 36776.6 36784.0 36786.4 2663.6 2754.0 2788.3 2870.5 3312.8 26491.6 26783.0 26927.5 26989.9 27673.6 3390.7 3399.6 3422.9 3496.9 3534.4 211029.0 213816.0 213963.0 214269.0 214606.0 53602.7 53961.7 54015.0 54030.5 54081.7 53399.0 54530.0 57978.7 63261.4 64874.4 12844.4 12918.7 12919.6 13002.5 13012.7 9798.4 9870.1 9875.9 9877.3 9882.1 18846.8 19015.7 19020.5 19037.8 19067.3 7518.2 7657.2 7741.0 7828.5 7853.4 812.4 870.0 918.0 927.6 966.6 25771.2 26235.3 26236.7 26308.3 26352.2 908.9 921.3 1002.9 1031.1 1037.5 13486.6 13517.5 13639.5 13808.6 13822.7 253617.0 256441.0 257919.0 257925.0 259036.0 44274.8 44760.8 44768.1 44818.0 44876.3 1012.2 1097.2 1110.9 1170.3 1199.9 23592.9 24119.8 24334.3 25183.0 26588.3 36426.3 36740.1 36754.0 36822.3 36916.6 301677.0 307856.0 308474.0 319647.0 320812.0 28906.0 28921.7 28984.7 29015.0 29481.7 37349.6 38039.0 38396.6 38669.6 38943.2 32622.7 35728.3 36306.8 38135.0 38526.6 33222.7 33761.2 33894.7 34092.5 34219.1 33436.2 33649.8 33809.2 33846.8 33968.7 29056.3 29895.2 30647.7 30667.5 30804.7 23706.3 24348.4 24375.8 24623.3 24752.8 10:05:42 INFO - 2015-12-03 10:05:42,132 DEBUG : BROWSER_OUTPUT: 10:05:42 INFO - 2015-12-03 10:05:42,132 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24302.13 Median:4114.08 stddev:70473.33 (1713.0%) stddev-sans-first:70648.03 10:05:42 INFO - 2015-12-03 10:05:42,133 DEBUG : BROWSER_OUTPUT: Values: 323.6 326.0 326.1 328.7 329.5 12479.3 12931.4 14963.0 15409.6 16481.4 12181.4 13903.2 14080.9 14093.1 14113.7 4883.2 4913.3 5038.6 5040.7 5042.5 3395.9 3487.3 4960.1 4997.3 5059.9 5162.8 5176.6 5194.0 5211.5 5212.1 5063.7 5132.1 5195.2 5204.1 5206.3 4986.8 5009.0 5019.3 5021.5 5025.7 11453.1 16949.7 17161.4 17547.6 17625.6 1705.8 1819.0 1840.8 1862.4 1873.7 8901.8 9727.8 10203.3 12062.8 12323.4 1688.9 1707.4 1714.3 1760.6 1821.7 55480.7 57763.0 57892.4 58381.4 58529.7 9674.3 9818.0 9827.0 9883.3 9900.3 12377.4 12569.2 12642.1 12651.9 12654.5 6863.1 6887.9 6890.9 6913.2 6940.7 6487.9 6491.1 6527.5 6543.8 6560.0 4084.8 4143.4 4144.3 4173.6 4175.3 1553.5 1616.2 1626.3 1655.6 1672.8 783.5 844.7 913.6 928.1 945.4 15573.6 15772.3 15999.5 16000.6 16256.8 731.7 813.3 820.6 902.4 902.8 8126.4 8340.8 8361.1 8971.7 9000.7 407903.0 432255.0 434658.0 436677.0 443540.0 66435.0 67377.3 67753.7 68555.7 69099.3 872.5 932.4 956.5 971.5 971.8 13561.8 13902.7 14342.7 14388.9 14473.9 29189.3 29190.0 29851.3 29981.7 30830.0 37708.4 38051.2 38527.2 38920.4 40329.0 8584.4 8762.8 8831.7 9056.2 9104.7 10327.9 10583.2 11389.7 15726.1 16398.6 12609.7 12661.4 13139.9 13638.5 13691.0 12412.9 13076.9 13531.3 13587.3 13941.8 13421.7 13633.3 13718.7 14176.8 14338.5 8944.8 8946.0 9005.8 9149.2 9167.6 9378.7 13000.1 13069.9 13099.7 13421.3 10:05:42 INFO - 2015-12-03 10:05:42,133 DEBUG : BROWSER_OUTPUT: 10:05:42 INFO - 2015-12-03 10:05:42,134 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4873.39 Median:6181.87 stddev:2520.40 (40.8%) stddev-sans-first:2514.24 10:05:42 INFO - 2015-12-03 10:05:42,134 DEBUG : BROWSER_OUTPUT: Values: 1436.4 1581.3 1642.5 1647.9 1672.0 6021.6 6221.6 6650.2 6825.4 6862.7 7019.5 7039.3 7093.9 7102.9 7105.6 2035.0 2072.8 2073.3 2073.4 2074.5 2036.9 2085.1 2086.5 2088.7 2091.8 2024.3 2041.2 2041.7 2061.3 2061.6 2049.7 2067.4 2072.1 2072.3 2073.5 1945.8 1947.1 1999.8 2008.6 2016.1 6002.4 6840.9 6917.1 6919.4 6930.7 3576.7 4040.2 4126.3 4139.3 4140.8 2563.7 2600.4 2600.6 2631.4 2631.5 864.7 867.4 1596.5 1607.1 1607.9 9450.2 9531.0 9543.9 9555.0 9555.1 3784.5 3826.3 3842.3 3871.2 3899.2 7487.3 7518.1 7518.5 7523.4 7523.5 4102.3 4107.1 4110.0 4112.1 4125.3 3751.2 3781.7 3782.4 3791.0 3797.1 3139.7 3158.7 3161.6 3183.3 3187.5 921.2 930.8 958.6 961.5 972.1 1109.5 1125.6 1136.8 1138.5 1152.7 6374.7 6464.7 6464.7 6503.3 6507.0 401.2 401.3 403.9 404.9 405.3 4570.2 5041.5 5110.0 5115.1 5125.0 7182.4 8260.7 8328.7 8349.0 8352.0 8182.8 8224.7 8353.9 8370.2 8393.1 6343.3 6551.9 6551.9 6588.4 6602.8 6587.3 6663.4 6663.9 6666.1 6684.0 7164.6 7444.6 7446.4 7447.0 7471.8 7662.5 7959.2 7975.9 8067.2 8069.2 6632.3 6655.7 6724.1 6767.7 6778.7 6833.5 6859.3 6864.5 6876.8 6881.8 6250.0 6296.0 6379.6 6390.0 6508.5 6142.2 6273.5 6292.9 6434.8 6509.0 6291.5 6296.9 6299.3 6303.2 6332.0 5892.5 5903.0 5966.8 5982.8 5994.0 6008.8 6025.5 6067.6 6068.4 6070.2 10:05:42 INFO - 2015-12-03 10:05:42,134 DEBUG : BROWSER_OUTPUT: 10:05:42 INFO - 2015-12-03 10:05:42,134 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4569.94 Median:5220.17 stddev:1357.60 (26.0%) stddev-sans-first:1322.87 10:05:42 INFO - 2015-12-03 10:05:42,134 DEBUG : BROWSER_OUTPUT: Values: 290.6 293.6 297.7 299.7 301.1 5149.2 5217.8 5222.5 5244.4 5332.0 5177.5 5178.9 5215.3 5217.8 5225.0 4099.9 4102.2 4104.4 4119.2 4123.6 4103.3 4110.3 4114.4 4116.1 4116.6 3886.0 4054.2 4071.4 4076.3 4080.0 3997.1 4021.8 4023.9 4028.3 4033.9 3493.9 3494.7 3495.3 3499.2 3499.8 5068.9 5074.4 5084.0 5088.1 5093.1 4621.5 4621.7 4625.5 4626.1 4627.5 5354.0 5488.9 5490.6 5495.0 5495.0 3792.7 3795.7 3796.6 3798.2 3798.4 5470.5 5609.4 5705.1 5789.3 5797.1 3771.7 3869.9 3879.8 3901.7 3910.4 3950.1 3952.7 3955.5 3959.4 3960.0 4322.8 4473.7 4481.0 4573.2 4621.4 5519.1 5524.7 5531.4 5535.1 5540.0 1382.2 1404.6 1405.5 1405.9 1406.6 933.0 935.5 935.8 958.5 960.3 4804.4 4818.3 4823.5 4825.9 4827.1 5716.2 5721.9 5724.8 5726.2 5727.0 4806.0 4808.0 4831.4 4833.4 4837.5 2732.5 2924.6 3054.1 3080.8 3085.7 5301.4 5311.0 5317.0 5369.2 5461.2 5888.9 5951.2 5955.6 5958.6 5972.3 5460.8 5472.4 5472.6 5478.1 5479.6 5780.2 5787.8 5788.8 5798.4 5800.9 5557.6 5641.2 5668.7 5669.7 5677.1 5452.8 5464.5 5467.6 5468.6 5471.8 3927.3 3965.2 3969.1 3970.6 3971.2 5301.5 5503.9 5785.5 5788.2 5796.9 5406.4 5474.8 5495.5 5502.4 5503.4 5481.6 5570.4 5576.9 5583.8 5590.4 5460.1 5460.3 5463.2 5467.8 5472.0 5500.4 5587.5 5603.9 5612.9 5615.9 5469.6 5477.3 5492.9 5493.7 5494.7 10:05:42 INFO - 2015-12-03 10:05:42,134 DEBUG : BROWSER_OUTPUT: 10:05:42 INFO - 2015-12-03 10:05:42,134 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12121.89 Median:21376.88 stddev:13763.97 (64.4%) stddev-sans-first:13775.43 10:05:42 INFO - 2015-12-03 10:05:42,135 DEBUG : BROWSER_OUTPUT: Values: 611.1 624.8 691.0 701.4 736.8 11968.8 12244.9 12261.6 13424.1 13721.6 13178.7 13198.3 13252.9 13257.9 13305.4 625.3 632.0 779.1 781.9 797.3 778.0 781.7 785.5 786.2 786.8 821.6 825.0 825.1 825.3 825.9 647.0 653.4 814.9 831.0 831.2 612.0 613.2 613.7 613.7 614.0 11091.7 11121.6 11127.9 11187.2 11223.2 9852.9 10240.9 10291.5 10855.1 11268.8 8848.7 9145.7 9381.4 9503.4 9584.2 3135.8 3181.4 3181.7 3186.7 3209.5 38243.6 38288.2 38465.4 38539.0 38558.6 8405.2 8710.2 8712.6 8812.0 8933.6 14968.3 15005.9 15060.0 15307.2 16175.3 5849.7 5940.3 6121.9 6168.6 6353.1 3488.9 3497.3 3501.2 3504.3 3528.6 2649.0 2672.7 2678.0 2683.8 2684.6 461.2 461.6 463.5 476.5 476.7 422.5 427.8 458.9 559.4 563.2 6874.7 7060.4 7065.1 7122.3 7258.9 537.3 539.9 540.8 567.2 571.1 3277.9 3293.0 3403.3 3404.8 3767.0 50033.5 50789.2 50897.0 51097.7 51900.0 42053.8 42224.4 42326.0 42773.6 42926.4 41097.0 41302.6 41337.2 41380.0 42248.6 7459.7 7544.3 7647.2 7819.3 7845.5 32388.8 32654.8 33087.8 33092.0 33214.8 37334.0 37453.4 37532.4 40870.6 40876.7 10245.7 10385.1 10406.0 10515.4 10581.7 11296.0 11313.2 11315.2 11340.9 11600.4 10332.3 10384.2 10449.7 10501.3 10509.8 10309.4 10664.9 11003.4 11072.7 11360.1 7776.3 8914.8 10076.2 10213.4 10887.1 8993.7 9158.0 9166.3 9198.3 9212.1 8632.0 9185.0 9274.9 9296.3 9298.0 10:05:42 INFO - 2015-12-03 10:05:42,136 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:05:42 INFO - 2015-12-03 10:05:42,136 DEBUG : BROWSER_OUTPUT: 10:05:42 INFO - 2015-12-03 10:05:42,885 INFO : Browser exited with error code: 0 10:05:42 INFO - 2015-12-03 10:05:42,909 INFO : Completed test dromaeo_css (00:18:37) 10:05:42 INFO - 2015-12-03 10:05:42,909 INFO : Starting test kraken 10:05:42 INFO - 2015-12-03 10:05:42,909 DEBUG : operating with platform_type : linux_ 10:05:42 INFO - 2015-12-03 10:05:42,909 INFO : Initialising browser for kraken test... 10:05:42 INFO - 2015-12-03 10:05:42,915 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplp5YN6/profile http://localhost:57023/getInfo.html 10:05:47 INFO - 2015-12-03 10:05:47,676 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:05:47 INFO - 2015-12-03 10:05:47,676 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:05:47 INFO - 2015-12-03 10:05:47,676 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:05:47 INFO - 2015-12-03 10:05:47,677 DEBUG : BROWSER_OUTPUT: __metrics 10:05:47 INFO - 2015-12-03 10:05:47,774 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:05:47 INFO - 2015-12-03 10:05:47,834 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:05:47 ERROR - 2015-12-03 10:05:47,854 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 10:05:48 INFO - 2015-12-03 10:05:48,736 INFO : Browser initialized. 10:05:48 INFO - 2015-12-03 10:05:48,737 INFO : Running cycle 1/1 for kraken test... 10:05:48 INFO - 2015-12-03 10:05:48,737 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplp5YN6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:06:00 INFO - 2015-12-03 10:06:00,780 DEBUG : BROWSER_OUTPUT: RSS: Main: 142581760 10:06:00 INFO - 2015-12-03 10:06:00,780 DEBUG : BROWSER_OUTPUT: 10:06:03 INFO - 2015-12-03 10:06:03,401 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57023/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57023/tests/kraken/driver.html?testName=audio-beat-detection) 10:06:03 INFO - 2015-12-03 10:06:03,987 DEBUG : BROWSER_OUTPUT: RSS: Main: 182091776 10:06:03 INFO - 2015-12-03 10:06:03,987 DEBUG : BROWSER_OUTPUT: 10:06:06 INFO - 2015-12-03 10:06:06,752 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57023/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57023/tests/kraken/driver.html?testName=audio-dft) 10:06:07 INFO - 2015-12-03 10:06:07,333 DEBUG : BROWSER_OUTPUT: RSS: Main: 170868736 10:06:07 INFO - 2015-12-03 10:06:07,334 DEBUG : BROWSER_OUTPUT: 10:06:10 INFO - 2015-12-03 10:06:10,341 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57023/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57023/tests/kraken/driver.html?testName=audio-fft) 10:06:10 INFO - 2015-12-03 10:06:10,914 DEBUG : BROWSER_OUTPUT: RSS: Main: 154726400 10:06:10 INFO - 2015-12-03 10:06:10,914 DEBUG : BROWSER_OUTPUT: 10:06:12 INFO - 2015-12-03 10:06:12,951 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57023/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57023/tests/kraken/driver.html?testName=audio-oscillator) 10:06:13 INFO - 2015-12-03 10:06:13,524 DEBUG : BROWSER_OUTPUT: RSS: Main: 156516352 10:06:13 INFO - 2015-12-03 10:06:13,524 DEBUG : BROWSER_OUTPUT: 10:06:15 INFO - 2015-12-03 10:06:15,778 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57023/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57023/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:06:16 INFO - 2015-12-03 10:06:16,343 DEBUG : BROWSER_OUTPUT: RSS: Main: 158113792 10:06:16 INFO - 2015-12-03 10:06:16,343 DEBUG : BROWSER_OUTPUT: 10:06:19 INFO - 2015-12-03 10:06:19,327 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57023/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57023/tests/kraken/driver.html?testName=imaging-darkroom) 10:06:19 INFO - 2015-12-03 10:06:19,909 DEBUG : BROWSER_OUTPUT: RSS: Main: 157663232 10:06:19 INFO - 2015-12-03 10:06:19,909 DEBUG : BROWSER_OUTPUT: 10:06:23 INFO - 2015-12-03 10:06:23,320 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57023/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57023/tests/kraken/driver.html?testName=imaging-desaturate) 10:06:23 INFO - 2015-12-03 10:06:23,902 DEBUG : BROWSER_OUTPUT: RSS: Main: 158253056 10:06:23 INFO - 2015-12-03 10:06:23,902 DEBUG : BROWSER_OUTPUT: 10:06:26 INFO - 2015-12-03 10:06:26,789 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57023/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57023/tests/kraken/driver.html?testName=json-parse-financial) 10:06:27 INFO - 2015-12-03 10:06:27,370 DEBUG : BROWSER_OUTPUT: RSS: Main: 159334400 10:06:27 INFO - 2015-12-03 10:06:27,370 DEBUG : BROWSER_OUTPUT: 10:06:29 INFO - 2015-12-03 10:06:29,140 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57023/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57023/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:06:29 INFO - 2015-12-03 10:06:29,705 DEBUG : BROWSER_OUTPUT: RSS: Main: 170893312 10:06:29 INFO - 2015-12-03 10:06:29,705 DEBUG : BROWSER_OUTPUT: 10:06:31 INFO - 2015-12-03 10:06:31,589 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57023/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57023/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:06:32 INFO - 2015-12-03 10:06:32,191 DEBUG : BROWSER_OUTPUT: RSS: Main: 168579072 10:06:32 INFO - 2015-12-03 10:06:32,192 DEBUG : BROWSER_OUTPUT: 10:06:34 INFO - 2015-12-03 10:06:34,312 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57023/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57023/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:06:34 INFO - 2015-12-03 10:06:34,894 DEBUG : BROWSER_OUTPUT: RSS: Main: 180342784 10:06:34 INFO - 2015-12-03 10:06:34,894 DEBUG : BROWSER_OUTPUT: 10:06:37 INFO - 2015-12-03 10:06:37,415 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57023/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57023/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:06:38 INFO - 2015-12-03 10:06:38,000 DEBUG : BROWSER_OUTPUT: RSS: Main: 187097088 10:06:38 INFO - 2015-12-03 10:06:38,001 DEBUG : BROWSER_OUTPUT: 10:06:40 INFO - 2015-12-03 10:06:40,566 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57023/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57023/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:06:41 INFO - 2015-12-03 10:06:41,151 DEBUG : BROWSER_OUTPUT: RSS: Main: 186580992 10:06:41 INFO - 2015-12-03 10:06:41,152 DEBUG : BROWSER_OUTPUT: 10:06:42 INFO - 2015-12-03 10:06:42,906 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57023/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57023/tests/kraken/driver.html?testName=ai-astar) 10:06:43 INFO - 2015-12-03 10:06:43,156 DEBUG : BROWSER_OUTPUT: RSS: Main: 242790400 10:06:43 INFO - 2015-12-03 10:06:43,156 DEBUG : BROWSER_OUTPUT: 10:06:43 INFO - 2015-12-03 10:06:43,157 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:06:43 INFO - 2015-12-03 10:06:43,158 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:06:43 INFO - 2015-12-03 10:06:43,158 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:06:43 INFO - 2015-12-03 10:06:43,159 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:06:43 INFO - 2015-12-03 10:06:43,159 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;113;106;111;113;112;103;116;112;104 10:06:43 INFO - 2015-12-03 10:06:43,159 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;135;174;182;130;156;162;130;175;129 10:06:43 INFO - 2015-12-03 10:06:43,159 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;164;161;161;162;162;162;162;161 10:06:43 INFO - 2015-12-03 10:06:43,159 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;93;97;73;73;72;101;91;75 10:06:43 INFO - 2015-12-03 10:06:43,160 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;95;131;94;95;95;128;95;95;132 10:06:43 INFO - 2015-12-03 10:06:43,160 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;110;110;111;109;110;110;110 10:06:43 INFO - 2015-12-03 10:06:43,160 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;147;147;146;146;147;146;147;146 10:06:43 INFO - 2015-12-03 10:06:43,160 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;95;96;96;96;95;95 10:06:43 INFO - 2015-12-03 10:06:43,161 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;72;71;70;71;72;71;80;69;71 10:06:43 INFO - 2015-12-03 10:06:43,161 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;68;69;69;68;68;68;69 10:06:43 INFO - 2015-12-03 10:06:43,161 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;86;87;86;84;84;86;85;85;85 10:06:43 INFO - 2015-12-03 10:06:43,161 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;121;122;118;132;121;124;130;125;130 10:06:43 INFO - 2015-12-03 10:06:43,161 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;139;144;151;136;134;151;146;143;133 10:06:43 INFO - 2015-12-03 10:06:43,162 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;69;68;68;69;68;69;68;68;68 10:06:43 INFO - 2015-12-03 10:06:43,162 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:06:43 INFO - 2015-12-03 10:06:43,162 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:06:43 INFO - 2015-12-03 10:06:43,162 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1003 10:06:43 INFO - 2015-12-03 10:06:43,163 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:06:43 INFO - 2015-12-03 10:06:43,163 DEBUG : BROWSER_OUTPUT: __startTimestamp1449166003156__endTimestamp 10:06:43 INFO - 2015-12-03 10:06:43,163 DEBUG : BROWSER_OUTPUT: 10:06:43 INFO - 2015-12-03 10:06:43,167 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:06:43 INFO - 2015-12-03 10:06:43,167 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:06:43 INFO - 2015-12-03 10:06:43,167 DEBUG : BROWSER_OUTPUT: 10:06:43 INFO - 2015-12-03 10:06:43,167 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.00 Median:112.00 stddev:4.27 (3.8%) stddev-sans-first:4.53 10:06:43 INFO - 2015-12-03 10:06:43,167 DEBUG : BROWSER_OUTPUT: Values: 110.0 113.0 106.0 111.0 113.0 112.0 103.0 116.0 112.0 104.0 10:06:43 INFO - 2015-12-03 10:06:43,168 DEBUG : BROWSER_OUTPUT: 10:06:43 INFO - 2015-12-03 10:06:43,168 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:152.90 Median:159.00 stddev:20.61 (13.0%) stddev-sans-first:21.83 10:06:43 INFO - 2015-12-03 10:06:43,168 DEBUG : BROWSER_OUTPUT: Values: 156.0 135.0 174.0 182.0 130.0 156.0 162.0 130.0 175.0 129.0 10:06:43 INFO - 2015-12-03 10:06:43,168 DEBUG : BROWSER_OUTPUT: 10:06:43 INFO - 2015-12-03 10:06:43,169 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 10:06:43 INFO - 2015-12-03 10:06:43,169 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 164.0 161.0 161.0 162.0 162.0 162.0 162.0 161.0 10:06:43 INFO - 2015-12-03 10:06:43,169 DEBUG : BROWSER_OUTPUT: 10:06:43 INFO - 2015-12-03 10:06:43,169 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.90 Median:74.00 stddev:12.01 (16.2%) stddev-sans-first:12.20 10:06:43 INFO - 2015-12-03 10:06:43,169 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 93.0 97.0 73.0 73.0 72.0 101.0 91.0 75.0 10:06:43 INFO - 2015-12-03 10:06:43,169 DEBUG : BROWSER_OUTPUT: 10:06:43 INFO - 2015-12-03 10:06:43,169 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.40 Median:95.00 stddev:17.24 (18.1%) stddev-sans-first:17.78 10:06:43 INFO - 2015-12-03 10:06:43,169 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 131.0 94.0 95.0 95.0 128.0 95.0 95.0 132.0 10:06:43 INFO - 2015-12-03 10:06:43,170 DEBUG : BROWSER_OUTPUT: 10:06:43 INFO - 2015-12-03 10:06:43,170 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 10:06:43 INFO - 2015-12-03 10:06:43,170 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 110.0 110.0 111.0 109.0 110.0 110.0 110.0 10:06:43 INFO - 2015-12-03 10:06:43,170 DEBUG : BROWSER_OUTPUT: 10:06:43 INFO - 2015-12-03 10:06:43,170 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 10:06:43 INFO - 2015-12-03 10:06:43,170 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 147.0 147.0 146.0 146.0 147.0 146.0 147.0 146.0 10:06:43 INFO - 2015-12-03 10:06:43,170 DEBUG : BROWSER_OUTPUT: 10:06:43 INFO - 2015-12-03 10:06:43,170 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 10:06:43 INFO - 2015-12-03 10:06:43,170 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 95.0 10:06:43 INFO - 2015-12-03 10:06:43,171 DEBUG : BROWSER_OUTPUT: 10:06:43 INFO - 2015-12-03 10:06:43,171 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.90 Median:71.50 stddev:3.00 (4.2%) stddev-sans-first:3.18 10:06:43 INFO - 2015-12-03 10:06:43,171 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 71.0 70.0 71.0 72.0 71.0 80.0 69.0 71.0 10:06:43 INFO - 2015-12-03 10:06:43,171 DEBUG : BROWSER_OUTPUT: 10:06:43 INFO - 2015-12-03 10:06:43,171 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 10:06:43 INFO - 2015-12-03 10:06:43,171 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 68.0 69.0 69.0 68.0 68.0 68.0 69.0 10:06:43 INFO - 2015-12-03 10:06:43,171 DEBUG : BROWSER_OUTPUT: 10:06:43 INFO - 2015-12-03 10:06:43,171 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:85.50 stddev:0.95 (1.1%) stddev-sans-first:1.00 10:06:43 INFO - 2015-12-03 10:06:43,172 DEBUG : BROWSER_OUTPUT: Values: 85.0 86.0 87.0 86.0 84.0 84.0 86.0 85.0 85.0 85.0 10:06:43 INFO - 2015-12-03 10:06:43,172 DEBUG : BROWSER_OUTPUT: 10:06:43 INFO - 2015-12-03 10:06:43,172 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.50 Median:124.50 stddev:4.67 (3.8%) stddev-sans-first:4.87 10:06:43 INFO - 2015-12-03 10:06:43,172 DEBUG : BROWSER_OUTPUT: Values: 122.0 121.0 122.0 118.0 132.0 121.0 124.0 130.0 125.0 130.0 10:06:43 INFO - 2015-12-03 10:06:43,172 DEBUG : BROWSER_OUTPUT: 10:06:43 INFO - 2015-12-03 10:06:43,172 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.20 Median:143.50 stddev:6.80 (4.7%) stddev-sans-first:6.83 10:06:43 INFO - 2015-12-03 10:06:43,172 DEBUG : BROWSER_OUTPUT: Values: 135.0 139.0 144.0 151.0 136.0 134.0 151.0 146.0 143.0 133.0 10:06:43 INFO - 2015-12-03 10:06:43,172 DEBUG : BROWSER_OUTPUT: 10:06:43 INFO - 2015-12-03 10:06:43,172 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 10:06:43 INFO - 2015-12-03 10:06:43,173 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 68.0 69.0 68.0 69.0 68.0 68.0 68.0 10:06:43 INFO - 2015-12-03 10:06:43,173 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:06:43 INFO - 2015-12-03 10:06:43,173 DEBUG : BROWSER_OUTPUT: 10:06:43 INFO - 2015-12-03 10:06:43,989 INFO : Browser exited with error code: 0 10:06:44 INFO - 2015-12-03 10:06:44,046 INFO : Completed test kraken (00:01:01) 10:06:44 INFO - 2015-12-03 10:06:44,046 INFO : Starting test v8_7 10:06:44 INFO - 2015-12-03 10:06:44,046 DEBUG : operating with platform_type : linux_ 10:06:44 INFO - 2015-12-03 10:06:44,046 INFO : Initialising browser for v8_7 test... 10:06:44 INFO - 2015-12-03 10:06:44,052 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvlRH_c/profile http://localhost:57023/getInfo.html 10:06:48 INFO - 2015-12-03 10:06:48,875 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:06:48 INFO - 2015-12-03 10:06:48,875 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:06:48 INFO - 2015-12-03 10:06:48,875 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:06:48 INFO - 2015-12-03 10:06:48,875 DEBUG : BROWSER_OUTPUT: __metrics 10:06:48 INFO - 2015-12-03 10:06:48,963 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:06:49 INFO - 2015-12-03 10:06:49,024 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:06:49 INFO - 2015-12-03 10:06:49,923 INFO : Browser initialized. 10:06:49 INFO - 2015-12-03 10:06:49,924 INFO : Running cycle 1/1 for v8_7 test... 10:06:49 INFO - 2015-12-03 10:06:49,924 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvlRH_c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:07:01 INFO - 2015-12-03 10:07:01,881 DEBUG : BROWSER_OUTPUT: RSS: Main: 143704064 10:07:01 INFO - 2015-12-03 10:07:01,881 DEBUG : BROWSER_OUTPUT: 10:07:23 INFO - 2015-12-03 10:07:23,319 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57023/tests/v8_7/run.html (next: http://localhost:57023/tests/v8_7/run.html) 10:07:23 INFO - 2015-12-03 10:07:23,569 DEBUG : BROWSER_OUTPUT: RSS: Main: 459718656 10:07:23 INFO - 2015-12-03 10:07:23,569 DEBUG : BROWSER_OUTPUT: 10:07:23 INFO - 2015-12-03 10:07:23,569 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:07:23 INFO - 2015-12-03 10:07:23,569 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:07:23 INFO - 2015-12-03 10:07:23,570 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:07:23 INFO - 2015-12-03 10:07:23,570 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:07:23 INFO - 2015-12-03 10:07:23,570 DEBUG : BROWSER_OUTPUT: |0;Richards;167.0843776106934 10:07:23 INFO - 2015-12-03 10:07:23,570 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.70649738610905 10:07:23 INFO - 2015-12-03 10:07:23,570 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.85495971103086 10:07:23 INFO - 2015-12-03 10:07:23,570 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5186.5284974093265 10:07:23 INFO - 2015-12-03 10:07:23,570 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2079.002079002079 10:07:23 INFO - 2015-12-03 10:07:23,571 DEBUG : BROWSER_OUTPUT: |5;Earley;790.5138339920949 10:07:23 INFO - 2015-12-03 10:07:23,571 DEBUG : BROWSER_OUTPUT: |6;Boyer;12011.904761904761 10:07:23 INFO - 2015-12-03 10:07:23,571 DEBUG : BROWSER_OUTPUT: |7;RegExp;26736.842105263157 10:07:23 INFO - 2015-12-03 10:07:23,571 DEBUG : BROWSER_OUTPUT: |8;Splay;609.7560975609756 10:07:23 INFO - 2015-12-03 10:07:23,571 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 10:07:23 INFO - 2015-12-03 10:07:23,571 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:07:23 INFO - 2015-12-03 10:07:23,572 DEBUG : BROWSER_OUTPUT: __startTimestamp1449166043568__endTimestamp 10:07:23 INFO - 2015-12-03 10:07:23,572 DEBUG : BROWSER_OUTPUT: 10:07:23 INFO - 2015-12-03 10:07:23,572 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:07:23 INFO - 2015-12-03 10:07:23,572 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:07:23 INFO - 2015-12-03 10:07:23,572 DEBUG : BROWSER_OUTPUT: 10:07:23 INFO - 2015-12-03 10:07:23,572 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.08 Median:167.08 stddev:0.00 (0.0%) 10:07:23 INFO - 2015-12-03 10:07:23,574 DEBUG : BROWSER_OUTPUT: Values: 167.1 10:07:23 INFO - 2015-12-03 10:07:23,574 DEBUG : BROWSER_OUTPUT: 10:07:23 INFO - 2015-12-03 10:07:23,574 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.71 Median:186.71 stddev:0.00 (0.0%) 10:07:23 INFO - 2015-12-03 10:07:23,574 DEBUG : BROWSER_OUTPUT: Values: 186.7 10:07:23 INFO - 2015-12-03 10:07:23,574 DEBUG : BROWSER_OUTPUT: 10:07:23 INFO - 2015-12-03 10:07:23,574 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.85 Median:277.85 stddev:0.00 (0.0%) 10:07:23 INFO - 2015-12-03 10:07:23,574 DEBUG : BROWSER_OUTPUT: Values: 277.9 10:07:23 INFO - 2015-12-03 10:07:23,574 DEBUG : BROWSER_OUTPUT: 10:07:23 INFO - 2015-12-03 10:07:23,574 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 10:07:23 INFO - 2015-12-03 10:07:23,574 DEBUG : BROWSER_OUTPUT: Values: 5186.5 10:07:23 INFO - 2015-12-03 10:07:23,574 DEBUG : BROWSER_OUTPUT: 10:07:23 INFO - 2015-12-03 10:07:23,574 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2079.00 Median:2079.00 stddev:0.00 (0.0%) 10:07:23 INFO - 2015-12-03 10:07:23,574 DEBUG : BROWSER_OUTPUT: Values: 2079.0 10:07:23 INFO - 2015-12-03 10:07:23,574 DEBUG : BROWSER_OUTPUT: 10:07:23 INFO - 2015-12-03 10:07:23,575 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:790.51 Median:790.51 stddev:0.00 (0.0%) 10:07:23 INFO - 2015-12-03 10:07:23,575 DEBUG : BROWSER_OUTPUT: Values: 790.5 10:07:23 INFO - 2015-12-03 10:07:23,575 DEBUG : BROWSER_OUTPUT: 10:07:23 INFO - 2015-12-03 10:07:23,575 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12011.90 Median:12011.90 stddev:0.00 (0.0%) 10:07:23 INFO - 2015-12-03 10:07:23,575 DEBUG : BROWSER_OUTPUT: Values: 12011.9 10:07:23 INFO - 2015-12-03 10:07:23,575 DEBUG : BROWSER_OUTPUT: 10:07:23 INFO - 2015-12-03 10:07:23,575 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26736.84 Median:26736.84 stddev:0.00 (0.0%) 10:07:23 INFO - 2015-12-03 10:07:23,575 DEBUG : BROWSER_OUTPUT: Values: 26736.8 10:07:23 INFO - 2015-12-03 10:07:23,575 DEBUG : BROWSER_OUTPUT: 10:07:23 INFO - 2015-12-03 10:07:23,575 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:609.76 Median:609.76 stddev:0.00 (0.0%) 10:07:23 INFO - 2015-12-03 10:07:23,575 DEBUG : BROWSER_OUTPUT: Values: 609.8 10:07:23 INFO - 2015-12-03 10:07:23,575 DEBUG : BROWSER_OUTPUT: 10:07:23 INFO - 2015-12-03 10:07:23,575 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 10:07:23 INFO - 2015-12-03 10:07:23,575 DEBUG : BROWSER_OUTPUT: Values: 4830.9 10:07:23 INFO - 2015-12-03 10:07:23,576 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:07:23 INFO - 2015-12-03 10:07:23,576 DEBUG : BROWSER_OUTPUT: 10:07:24 INFO - 2015-12-03 10:07:24,461 INFO : Browser exited with error code: 0 10:07:24 INFO - 2015-12-03 10:07:24,478 INFO : Completed test v8_7 (00:00:40) 10:07:24 INFO - 2015-12-03 10:07:24,555 INFO : Completed test suite (00:20:19) 10:07:24 INFO - 2015-12-03 10:07:24,555 DEBUG : Working with test: dromaeo_css 10:07:24 INFO - 2015-12-03 10:07:24,556 DEBUG : Generating results file: dromaeo_css 10:07:24 INFO - 2015-12-03 10:07:24,557 DEBUG : Working with test: kraken 10:07:24 INFO - 2015-12-03 10:07:24,557 DEBUG : Generating results file: kraken 10:07:24 INFO - 2015-12-03 10:07:24,557 INFO : javascript benchmark 10:07:24 INFO - 2015-12-03 10:07:24,557 DEBUG : Working with test: v8_7 10:07:24 INFO - 2015-12-03 10:07:24,557 DEBUG : Generating results file: v8_7 10:07:24 INFO - 2015-12-03 10:07:24,558 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:07:24 INFO - 2015-12-03 10:07:24,622 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 10:07:24 INFO - 2015-12-03 10:07:24,623 DEBUG : process_Request line: dromaeo_css 6202.85 graph.html#tests=[[72,132,35]] 10:07:24 INFO - 2015-12-03 10:07:24,623 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:07:24 INFO - 2015-12-03 10:07:24,660 DEBUG : process_Request line: kraken 1523.40 graph.html#tests=[[232,132,35]] 10:07:24 INFO - 2015-12-03 10:07:24,660 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:07:24 INFO - 2015-12-03 10:07:24,701 DEBUG : process_Request line: v8_7 19722.82 graph.html#tests=[[230,132,35]] 10:07:24 INFO - 2015-12-03 10:07:24,703 INFO : javascript benchmark 10:07:24 INFO - 2015-12-03 10:07:24,707 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2573.691157061153, 2687.046098634986, 2693.474772419379, 2700.891964321427, 2722.441899410621, 4546.56807603278, 4636.791344389502, 4678.345031695561, 4698.530146985304, 4711.175544279755, 4561.292999585061, 4596.954030459694, 4634.2353511670535, 4638.768061596915, 4749.240121580548, 4311.353297005443, 4330.826766929319, 4333.848315308965, 4336.913261734763, 4359.891002724926, 4189.183109293689, 4427.114577084596, 4429.667774916878, 4462.9065878859565, 4477.171723231213, 4197.895052623693, 4227.450431443893, 4237.724547904407, 4320.222359975203, 4350.521442641307, 4328.069465065026, 4348.782560871944, 4355.0201204729, 4380.693351465398, 4386.4736231652405, 4101.815418306183, 4284.914301713949, 4285.550017248175, 4295.3771703102875, 4338.327559228324, 4437.689361744679, 4445.422095127613, 4541.6366690665, 4660.464046634646, 4686.179918514246, 4998.4751601081725, 5015.874603134915, 5024.648274620778, 5032.6477146599755, 5064.417591976933, 4840.419149702023, 5031.698098114125, 5043.344365232533, 5048.242763585455, 5072.442031376546, 4608.216603177468, 4644.373009643688, 4662.487126416126, 4716.0, 4720.834770783006, 5145.125328694131, 5145.922811157836, 5153.974230128901, 5156.92264616031, 5216.817411390583, 4946.431160416598, 4961.4294356148785, 4962.255661650781, 4968.205087186105, 5015.272785446163, 4687.601553867891, 4786.2820576913045, 4792.041591681677, 4795.017021510582, 4928.728919909439, 4973.0, 4992.90014199714, 5000.599952003831, 5004.799808007711, 5014.197728363444, 4952.876178095505, 4961.206207006934, 4961.231009193581, 4969.602431805447, 5021.397432308073, 3974.841006359771, 4127.174565086994, 4132.876013719593, 4165.291900376943, 4202.432671589297, 3608.855645774192, 3656.0, 3701.555813302421, 3703.129764505339, 3715.925681486355, 4298.161858437637, 4327.415798867176, 4336.241157797373, 4336.956630433719, 4375.431193944767, 4785.377900872864, 4885.706857588556, 5014.949850501521, 5071.518205770446, 5122.410922743858, 4222.556631553643, 4231.407602935591, 4245.3207486802585, 4289.034967132433, 4339.284018137035, 4411.250087485135, 4414.0, 4417.801198946056, 4427.512973572904, 4464.955350446519, 4754.453237877619, 4755.191617424977, 4761.357216775829, 4798.880027999328, 4813.831515897067, 4733.5503127202865, 4848.61211103118, 4850.975745121252, 4911.435184953633, 5032.471590482946, 4718.197906355859, 4753.0256297458245, 4762.190427627243, 4765.523447655207, 4805.8558243252755, 4923.0, 4931.556159945622, 4936.062148191832, 4941.65408421407, 4973.52751488608, 4863.294822250825, 4936.136176169084, 5000.2499625056535, 5004.449510553909, 5038.118329292286, 4906.656534042726, 4917.434495033117, 4929.457759646508, 4931.112399768076, 4933.235348520985, 4903.26451032348, 4943.480934501969, 4949.57928576075, 4950.480199578992, 4975.179095449355, 4517.322401639781, 4609.7464639443815, 4611.123886461562, 4679.578837904605, 4880.633952453509, 4904.362432883702, 4906.975465122651, 4935.629827763004, 4945.381827271591, 4945.579625731709, 4795.784189711401, 4798.520147985174, 4802.351682522954, 4802.423709154924, 4847.321375007572], "unit": "ms", "name": "dojo.html", "value": 4580.429940560307}, {"lowerIsBetter": false, "replicates": [558.9385167631561, 569.7578529125124, 575.8445219790659, 585.467224825409, 592.1088761414071, 27720.306992325175, 36159.63840361599, 36859.0, 37076.443853342156, 37114.62885371145, 39281.60718392815, 39718.40422393666, 39849.800750996204, 39908.0, 39949.60050399495, 6737.663116844163, 6826.69279882404, 7836.8040798980055, 8001.599920004006, 8004.479708818908, 10098.040686134806, 10364.948175259113, 10368.377897326147, 10368.688939331794, 10371.274010819208, 9984.35101718386, 10080.747981300452, 10087.344322619007, 10087.394756314645, 10095.747606309827, 7030.648467576626, 7167.928320716778, 7178.318059784312, 7178.4616153788675, 9881.802363952716, 6882.380585747307, 10064.446455444948, 10322.0, 10327.225458090674, 10329.225308101923, 36250.63749362499, 36665.81667091647, 36776.632233677585, 36784.0, 36786.448203276974, 2663.600459931026, 2753.972460275412, 2788.3308006078596, 2870.5407134858533, 3312.751543634213, 26491.602625960626, 26783.0, 26927.461450770876, 26989.865050674816, 27673.584896226574, 3390.6609339066144, 3399.5750531183603, 3422.931541369159, 3496.912577185565, 3534.434490481536, 211029.0, 213816.0, 213963.0, 214269.0, 214606.0, 53602.731986339815, 53961.73019134879, 54015.0, 54030.459695403326, 54081.72959135179, 53399.0, 54530.0, 57978.71010645004, 63261.367386325546, 64874.351256487775, 12844.422001009976, 12918.67703307406, 12919.612411627666, 13002.479900803863, 13012.739745205043, 9798.363106398061, 9870.111689947938, 9875.901240987498, 9877.308588398742, 9882.061204185591, 18846.81153188478, 19015.71476427827, 19020.524486887938, 19037.80962190388, 19067.332643357695, 7518.248175182547, 7657.23427657241, 7740.961295193601, 7828.491148075357, 7853.41099417546, 812.3866480806953, 869.9739007829776, 918.025597065503, 927.5825878354767, 966.5843687214565, 25771.226863194133, 26235.34411639686, 26236.73763262381, 26308.342291442485, 26352.20943371702, 908.8500397434349, 921.2721949659827, 1002.8896821349646, 1031.1235449867552, 1037.4501514197486, 13486.595402137951, 13517.526886558922, 13639.522616708367, 13808.585742427744, 13822.654433639038, 253617.0, 256441.0, 257919.0, 257925.0, 259036.0, 44274.778626106665, 44760.77619611881, 44768.10463790706, 44818.0, 44876.3268550972, 1012.2155329619603, 1097.1551905033239, 1110.905573026302, 1170.3329102411715, 1199.8500187476566, 23592.88203558971, 24119.758802412452, 24334.26997190087, 25183.0, 26588.335291617863, 36426.27147456983, 36740.08149796276, 36754.0, 36822.26355472822, 36916.63083369132, 301677.0, 307856.0, 308474.0, 319647.0, 320812.0, 28906.0, 28921.710782891903, 28984.710152898202, 29014.984475543253, 29481.705182947895, 37349.62650373462, 38039.0, 38396.6160338393, 38669.6133038666, 38943.221135577696, 32622.673773261962, 35728.28543429169, 36306.81846590856, 38135.0, 38526.6147338523, 33222.667773321955, 33761.15597110092, 33894.66105338915, 34092.488612671325, 34219.14452138716, 33436.164095897795, 33649.83175084109, 33809.154771129935, 33846.83076584601, 33968.66031339754, 29056.273593159494, 29895.175480133872, 30647.693523065376, 30667.53998690066, 30804.691953080182, 23706.288811335686, 24348.391290217885, 24375.75624243735, 24623.261302160965, 24752.752472475044], "unit": "ms", "name": "ext.html", "value": 17056.767931315193}, {"lowerIsBetter": false, "replicates": [323.6359096016981, 325.9967400325997, 326.12153993000317, 328.6565539011734, 329.5402912936452, 12479.25124492531, 12931.41808618612, 14963.0, 15409.614759631015, 16481.42315018973, 12181.390930453486, 13903.235322057308, 14080.929595352034, 14093.083949543272, 14113.717725645482, 4883.218685010399, 4913.312136300912, 5038.647294689373, 5040.672356296847, 5042.495750424947, 3395.9151021224543, 3487.2676737885076, 4960.131976904046, 4997.30037794709, 5059.949400506003, 5162.767675454595, 5176.5858731301405, 5194.0, 5211.45279745627, 5212.087884620177, 5063.696178229299, 5132.101882170624, 5195.1687729963405, 5204.115300398904, 5206.271122042917, 4986.750662466899, 5008.974955125237, 5019.272205530177, 5021.5229553192385, 5025.698458092526, 11453.141014423869, 16949.66100677992, 17161.399351022654, 17547.649047019117, 17625.559361016076, 1705.7867766529184, 1819.045001374276, 1840.8343249107645, 1862.37610400516, 1873.7283093951437, 8901.777455563599, 9727.756806079833, 10203.285769996104, 12062.758744825054, 12323.445444955, 1688.8902221355572, 1707.4109432245855, 1714.322842477227, 1760.6038641305731, 1821.7358483019889, 55480.72259638676, 57763.0, 57892.42107578913, 58381.41618583845, 58529.707351463396, 9674.274429417821, 9817.950910245403, 9827.0, 9883.258755593359, 9900.306978511435, 12377.381130943417, 12569.183003104768, 12642.115051946459, 12651.873481265253, 12654.493820247088, 6863.142107236596, 6887.896681549781, 6890.896636550456, 6913.239543650195, 6940.687669054904, 6487.935120648827, 6491.091247225392, 6527.510436717265, 6543.770968016097, 6560.048792924999, 4084.7957602119777, 4143.357779544175, 4144.295469770146, 4173.561776013536, 4175.269327867611, 1553.495114087926, 1616.2403670274953, 1626.341331760639, 1655.5778276539406, 1672.7741754863182, 783.4868161354322, 844.7127976488024, 913.5523593439167, 928.071928071928, 945.4043952310001, 15573.610659733597, 15772.252610641472, 15999.520553760425, 16000.599985000468, 16256.75614865778, 731.6926890705917, 813.3371302388534, 820.5651004967258, 902.3683421604903, 902.8058967322057, 8126.39052071097, 8340.791480213044, 8361.122569166568, 8971.724539397961, 9000.729978100668, 407903.0, 432255.0, 434658.0, 436677.0, 443540.0, 66435.0, 67377.32622673809, 67753.66123169352, 68555.65722171457, 69099.30900691029, 872.5375550958129, 932.4265576670434, 956.502618638318, 971.4511301114848, 971.7522031881825, 13561.796573051215, 13902.721945561234, 14342.713145737236, 14388.928055359656, 14473.855261447672, 29189.270268243465, 29190.0, 29851.25371865634, 29981.70018299789, 30830.0, 37708.43437348497, 38051.23897522089, 38527.229455411296, 38920.41619375768, 40329.0, 8584.356173287153, 8762.824743505222, 8831.69089081879, 9056.184943355129, 9104.726858194264, 10327.896721032694, 10583.153347732008, 11389.715257118638, 15726.135062571211, 16398.590035249214, 12609.684757881127, 12661.430235639602, 13139.868601314247, 13638.454461821813, 13691.0, 12412.937935310265, 13076.869231307564, 13531.255780932142, 13587.252701101534, 13941.790873136708, 13421.731565368833, 13633.25017124028, 13718.725625487235, 14176.787348189991, 14338.49815256461, 8944.776380590538, 8946.0, 9005.774855628662, 9149.176574108362, 9167.587458564247, 9378.718638440858, 13000.08999370035, 13069.869301306866, 13099.738005240033, 13421.26183059902], "unit": "ms", "name": "jquery.html", "value": 7991.760015441611}, {"lowerIsBetter": false, "replicates": [1436.4038923846604, 1581.2568092996291, 1642.5236681362405, 1647.8764092693052, 1671.9749203761946, 6021.608595441298, 6221.564490485668, 6650.201975762903, 6825.3857152856235, 6862.656867156635, 7019.5086343955945, 7039.296070392971, 7093.929060709392, 7102.928970710292, 7105.644717764104, 2034.9999999999964, 2072.823809976154, 2073.2639912830955, 2073.35725924963, 2074.481379655086, 2036.9185232590753, 2085.124247815921, 2086.478380404899, 2088.665813469845, 2091.7803630618796, 2024.2712623455545, 2041.224334752792, 2041.6937459381063, 2061.309461330456, 2061.608294424062, 2049.733534640495, 2067.410787925434, 2072.0986370928695, 2072.316135675231, 2073.502359433725, 1945.8346040586566, 1947.1140631012854, 1999.7600287965392, 2008.608321377332, 2016.0625309231132, 6002.399760024006, 6840.931590684079, 6917.066196063568, 6919.411849992756, 6930.653467326664, 3576.660217279354, 4040.1717647882406, 4126.319157339036, 4139.317012692902, 4140.751554906685, 2563.653906722587, 2600.4409052053898, 2600.6359109724654, 2631.3947792007943, 2631.513170063525, 864.6800683747053, 867.4188293843077, 1596.5370042687723, 1607.1482114479345, 1607.887447878649, 9450.19673327768, 9530.999245079305, 9543.904560954372, 9554.952225238829, 9555.092266234697, 3784.508013958168, 3826.253880493277, 3842.2507611015585, 3871.1676989447406, 3899.220155968761, 7487.288707572772, 7518.135414427302, 7518.473706840468, 7523.3981281497345, 7523.510971786816, 4102.3026085565525, 4107.116969851496, 4110.034141976633, 4112.074783173762, 4125.319322311845, 3751.249750050001, 3781.697464202857, 3782.3569993101237, 3790.981045094812, 3797.1266608680157, 3139.6703346148784, 3158.684131586823, 3161.636411812671, 3183.283761153722, 3187.5378070179695, 921.203159267229, 930.8464103422995, 958.5973890965811, 961.4808003677936, 972.1348000279756, 1109.450821843193, 1125.5610311978335, 1136.8237923121928, 1138.481990694232, 1152.6945359479744, 6374.713137908805, 6464.676766161673, 6464.676766161767, 6503.317151699098, 6506.967465162644, 401.2436557089848, 401.3417994488982, 403.884892805549, 404.87448890843933, 405.3231104056233, 4570.223062079388, 5041.46235398207, 5110.0, 5115.104856650071, 5125.026245013435, 7182.3535881770895, 8260.710875119463, 8328.708495202638, 8349.03986041613, 8351.958240208882, 8182.83634327322, 8224.671013159526, 8353.874691879626, 8370.162983701703, 8393.118722534167, 6343.27052388972, 6551.868962620721, 6551.901721474182, 6588.439982601532, 6602.768903088465, 6587.308332625005, 6663.400293973566, 6663.900041499478, 6666.100076489612, 6684.0, 7164.641767911479, 7444.627768611656, 7446.367058799846, 7447.0, 7471.775846724607, 7662.501937374052, 7959.243871832166, 7975.92024079775, 8067.193280671886, 8069.193080691884, 6632.270450250372, 6655.700493477708, 6724.125863637696, 6767.729290828312, 6778.694958726967, 6833.453323734188, 6859.348361905611, 6864.485163612849, 6876.759313424006, 6881.827954301182, 6250.0, 6295.96852015737, 6379.585326953918, 6390.009548519987, 6508.479321654161, 6142.170806941006, 6273.466755325666, 6292.905606415999, 6434.806955791334, 6508.967455162694, 6291.465225455888, 6296.937030629819, 6299.275583307795, 6303.243610766737, 6332.0, 5892.499137573354, 5903.026000709835, 5966.76132954677, 5982.760689572368, 5994.0409534474275, 6008.849778755566, 6025.548083893813, 6067.575269731076, 6068.393160683896, 6070.2108725865355], "unit": "ms", "name": "mootools.html", "value": 3961.648321346203}, {"lowerIsBetter": false, "replicates": [290.6076796324961, 293.55966050923615, 297.7201430655184, 299.67485278472844, 301.0636919181347, 5149.201873709576, 5217.843464696056, 5222.503862133091, 5244.4493328200515, 5332.040232758102, 5177.508136727005, 5178.896422071556, 5215.295935048767, 5217.843464696056, 5224.973875130619, 4099.897502562445, 4102.241085399196, 4104.404861295118, 4119.155573107506, 4123.60825721556, 4103.343465045593, 4110.321796903508, 4114.423980642712, 4116.135611521584, 4116.588341165874, 3886.0, 4054.1688953764406, 4071.42999980003, 4076.2866498362814, 4079.9592004080023, 3997.060690737674, 4021.7586944783407, 4023.9396409054034, 4028.315186418316, 4033.9394909076386, 3493.91265218369, 3494.6505349465106, 3495.3358861816173, 3499.212677147647, 3499.7725147865563, 5068.949310506885, 5074.391073071218, 5083.974580127113, 5088.109580823341, 5093.0577843099145, 4621.537846215385, 4621.69958952667, 4625.537446255381, 4626.097910907374, 4627.514111018329, 5353.9732301338245, 5488.91766623501, 5490.615656904019, 5494.972525137388, 5495.0, 3792.6965842732516, 3795.658390744846, 3796.5823759386444, 3798.164403831153, 3798.373268410709, 5470.480304371078, 5609.4390560943575, 5705.115707065412, 5789.334226563915, 5797.072468405035, 3771.6610603236004, 3869.858391774433, 3879.767213967171, 3901.668358189586, 3910.3743401056263, 3950.051987522974, 3952.6837852972267, 3955.5451123120633, 3959.425883246913, 3960.0, 4322.762248076386, 4473.731576105444, 4481.014176881081, 4573.222552166139, 4621.4223222097235, 5519.089350257163, 5524.66851988882, 5531.446855314436, 5535.142052981794, 5540.0, 1382.2397681275459, 1404.5926681262524, 1405.4729476446332, 1405.9156450612995, 1406.6131813751301, 932.9766755831158, 935.5275585829113, 935.8362286599818, 958.5255298627225, 960.3325688646463, 4804.375431193992, 4818.253170758538, 4823.541763532458, 4825.855224343275, 4827.058723548945, 5716.1997320375185, 5721.914171287434, 5724.8282551523525, 5726.198332233491, 5727.0, 4805.9759701201965, 4808.0383923215495, 4831.396075490564, 4833.371661683958, 4837.4920633333695, 2732.5491293936675, 2924.6490421149174, 3054.083774867531, 3080.830554319534, 3085.6605773364913, 5301.416844147141, 5311.0, 5317.0, 5369.167778994262, 5461.208124821958, 5888.911666325009, 5951.166836642873, 5955.642661440327, 5958.582899197101, 5972.283326000907, 5460.754266058037, 5472.398036216013, 5472.616916815785, 5478.096114141122, 5479.561635069264, 5780.248567686174, 5787.768489260551, 5788.768449261982, 5798.420157984167, 5800.912986305125, 5557.610967232416, 5641.153826925994, 5668.659880407189, 5669.7165141741925, 5677.091665333527, 5452.809151679672, 5464.508194262536, 5467.5625949923115, 5468.617196796186, 5471.753771080391, 3927.332353499855, 3965.167314863911, 3969.0871099646665, 3970.622790834866, 3971.2057588483, 5301.522862942354, 5503.944960550503, 5785.479306862402, 5788.218590490398, 5796.913046304225, 5406.4052954175795, 5474.835754927359, 5495.477929596842, 5502.422245664147, 5503.422140675171, 5481.616286859881, 5570.415106413769, 5576.88462307532, 5583.804566840141, 5590.385057643574, 5460.071787796005, 5460.290162278879, 5463.207834863843, 5467.835964921059, 5471.972640136773, 5500.4499550044675, 5587.497125258747, 5603.943960560342, 5612.859678507906, 5615.8876822464135, 5469.589780766379, 5477.3427188737605, 5492.890142197054, 5493.725313734377, 5494.692229263799], "unit": "ms", "name": "prototype.html", "value": 4131.541546176407}, {"lowerIsBetter": false, "replicates": [611.0528680545154, 624.7906951171358, 690.9550879192852, 701.3792793377859, 736.8010637127979, 11968.82046769298, 12244.938775306122, 12261.632151035472, 13424.060315777899, 13721.588352349421, 13178.670533236675, 13198.340082995835, 13252.933735331333, 13257.93371033146, 13305.401256943436, 625.2902955145919, 632.0140580694109, 779.12737733738, 781.8631739445602, 797.2665148063767, 778.0391216847189, 781.6756046240803, 785.4972817396842, 786.1902240692096, 786.8111653203247, 821.5645707774859, 825.0182283083112, 825.145973916996, 825.3026192867018, 825.8885050518163, 647.0391468669022, 653.3597074866634, 814.8736945773414, 830.983380332396, 831.2311112221171, 611.9816405507842, 613.2334581772784, 613.6686189457688, 613.7360934798035, 613.9938600613981, 11091.72270693231, 11121.55513779448, 11127.944360278228, 11187.160962927732, 11223.158263130215, 9852.90147098527, 10240.94879525605, 10291.53688084038, 10855.131589472901, 11268.830967535494, 8848.690295839615, 9145.679901203426, 9381.390209636353, 9503.382280151836, 9584.185344245747, 3135.843207839599, 3181.3955348483946, 3181.7136457718684, 3186.713195812388, 3209.518572214163, 38243.617563824286, 38288.234235315416, 38465.42301865474, 38539.0, 38558.61441385578, 8405.159484051546, 8710.172533609297, 8712.607932642919, 8812.0, 8933.59798809055, 14968.326425310886, 15005.924970375296, 15060.0, 15307.234638268043, 16175.272112754954, 5849.736761845727, 5940.31686356066, 6121.877562448726, 6168.629882207082, 6353.142325786052, 3488.930221395558, 3497.3387640870383, 3501.1597216667815, 3504.281622267429, 3528.558930133733, 2648.9867550662125, 2672.706002339741, 2678.049292501173, 2683.7987150963754, 2684.6107314439296, 461.21593291404747, 461.6376144726441, 463.5133110234308, 476.5234765234765, 476.6663335665048, 422.53943201909453, 427.7690047374445, 458.94263217097864, 559.3735016781231, 563.2452513631753, 6874.725010999604, 7060.364567188875, 7065.081539399948, 7122.323379278961, 7258.927410725825, 537.2639483907072, 539.8677324055632, 540.7755781350695, 567.1662655895826, 571.1005166862209, 3277.901662950115, 3292.9704671702093, 3403.2512847173584, 3404.8297585120645, 3766.962330376661, 50033.49966500361, 50789.23816142761, 50897.0, 51097.744511277204, 51900.0, 42053.78973105115, 42224.366634500504, 42326.0, 42773.57226427696, 42926.35610465846, 41097.0, 41302.586974129874, 41337.1732565347, 41380.0, 42248.57751422508, 7459.664315105942, 7544.321011109027, 7647.158812530728, 7819.335356494762, 7845.450818442654, 32388.83805580957, 32654.795164103693, 33087.83456082704, 33092.0, 33214.833925830215, 37334.0, 37453.43819842759, 37532.437013445364, 40870.59129408787, 40876.707945666465, 10245.692629221136, 10385.065344119066, 10406.0, 10515.421651809223, 10581.735456613646, 11296.0, 11313.151513636345, 11315.20793544444, 11340.886591133984, 11600.361980091177, 10332.276740628384, 10384.221183411426, 10449.686509404426, 10501.264911456125, 10509.78980420372, 10309.432981185806, 10664.893351066701, 11003.449827508754, 11072.667819965414, 11360.091192704398, 7776.339011183886, 8914.777130571787, 10076.193904487476, 10213.387196768217, 10887.129029677766, 8993.685221017233, 9158.0, 9166.266698663958, 9198.264138869008, 9212.124848139416, 8632.0, 9185.035571265189, 9274.860877086714, 9296.349255552317, 9298.0], "unit": "ms", "name": "yui.html", "value": 5572.7407046987355}], "name": "dromaeo_css", "value": 6202.854317095139}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 113.0, 106.0, 111.0, 113.0, 112.0, 103.0, 116.0, 112.0, 104.0], "unit": "ms", "name": "ai-astar", "value": 110.0}, {"lowerIsBetter": true, "replicates": [156.0, 135.0, 174.0, 182.0, 130.0, 156.0, 162.0, 130.0, 175.0, 129.0], "unit": "ms", "name": "audio-beat-detection", "value": 152.9}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 164.0, 161.0, 161.0, 162.0, 162.0, 162.0, 162.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.8}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 93.0, 97.0, 73.0, 73.0, 72.0, 101.0, 91.0, 75.0], "unit": "ms", "name": "audio-fft", "value": 81.9}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 131.0, 94.0, 95.0, 95.0, 128.0, 95.0, 95.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 105.4}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 110.0, 111.0, 109.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 71.0, 70.0, 71.0, 72.0, 71.0, 80.0, 69.0, 71.0], "unit": "ms", "name": "json-parse-financial", "value": 71.9}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 69.0, 69.0, 68.0, 68.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 87.0, 86.0, 84.0, 84.0, 86.0, 85.0, 85.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.3}, {"lowerIsBetter": true, "replicates": [122.0, 121.0, 122.0, 118.0, 132.0, 121.0, 124.0, 130.0, 125.0, 130.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.5}, {"lowerIsBetter": true, "replicates": [135.0, 139.0, 144.0, 151.0, 136.0, 134.0, 151.0, 146.0, 143.0, 133.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 141.2}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 69.0, 68.0, 69.0, 68.0, 68.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.3}], "name": "kraken", "value": 1523.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.0843776106934], "unit": "score", "name": "Richards", "value": 211.28247000000007}, {"lowerIsBetter": false, "replicates": [186.70649738610905], "unit": "score", "name": "DeltaBlue", "value": 354.12800799999997}, {"lowerIsBetter": false, "replicates": [277.85495971103086], "unit": "score", "name": "Encrypt", "value": 957.9854189999998}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [2079.002079002079], "unit": "score", "name": "RayTrace", "value": 355.9347089999998}, {"lowerIsBetter": false, "replicates": [790.5138339920949], "unit": "score", "name": "Earley", "value": 843.0756950000003}, {"lowerIsBetter": false, "replicates": [12011.904761904761], "unit": "score", "name": "Boyer", "value": 55.483540138751295}, {"lowerIsBetter": false, "replicates": [26736.842105263157], "unit": "score", "name": "RegExp", "value": 34.07227362204725}, {"lowerIsBetter": false, "replicates": [609.7560975609756], "unit": "score", "name": "Splay", "value": 133.64524}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19722.822434594604}]} 10:07:24 INFO - RETURN: dromaeo_css: 6202.85 10:07:24 INFO - RETURN: kraken: 1523.40 10:07:24 INFO - RETURN: v8_7: 19722.82 10:07:24 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19722.82"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1523.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6202.85"}}} 10:07:24 INFO - Return code: 0 10:07:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:07:24 ERROR - # TBPL SUCCESS # 10:07:24 INFO - Running post-action listener: _resource_record_post_action 10:07:24 INFO - Running post-run listener: _resource_record_post_run 10:07:25 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 0; Write bytes: 511127552; Read time: 0; Write time: 623484 10:07:25 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 242507776; Read time: 0; Write time: 352200 10:07:25 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 0; Write bytes: 268619776; Read time: 0; Write time: 271284 10:07:25 INFO - Running post-run listener: _upload_blobber_files 10:07:25 INFO - Blob upload gear active. 10:07:25 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:07:25 INFO - Copying logs to upload dir... 10:07:25 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1271.886594 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-03 10:07:25.562168) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 10:07:25.565638) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1449164771.155881-944245847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/QMvx9AlpRrKEkIELHqYFEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010015 build_url: 'https://queue.taskcluster.net/v1/task/QMvx9AlpRrKEkIELHqYFEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 10:07:25.617602) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 10:07:25.617935) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1449164771.155881-944245847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004632 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 10:07:25.668145) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 10:07:25.668560) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 10:07:25.668948) ========= ========= Total master_lag: 0.24 =========