builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-059 starttime: 1449325062.42 results: success (0) buildid: 20151205054030 builduid: a5b0c22cea994e4e9db49838c1dbb4f5 revision: 22d7d0b39c38a48fbb86c5c961404ae75403e4d4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-05 06:17:42.422138) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-05 06:17:42.422564) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-05 06:17:42.422886) ========= 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=5752742a61d0f534093fa7a9000001cb-1449324501.32155-1669891038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005044 basedir: '/builds/slave/test' ========= master_lag: 0.08 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-05 06:17:42.510649) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-05 06:17:42.511011) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-05 06:17:42.572756) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 06:17:42.573096) ========= 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=5752742a61d0f534093fa7a9000001cb-1449324501.32155-1669891038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022101 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 06:17:42.624711) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-05 06:17:42.625364) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-05 06:17:42.626181) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 06:17:42.626861) ========= 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=5752742a61d0f534093fa7a9000001cb-1449324501.32155-1669891038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-05 06:17:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.8M=0s 2015-12-05 06:17:42 (42.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.224110 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 06:17:42.864949) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 06:17:42.865345) ========= 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=5752742a61d0f534093fa7a9000001cb-1449324501.32155-1669891038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.048560 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 06:17:42.925823) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 06:17:42.926597) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 22d7d0b39c38a48fbb86c5c961404ae75403e4d4 --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 22d7d0b39c38a48fbb86c5c961404ae75403e4d4 --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=5752742a61d0f534093fa7a9000001cb-1449324501.32155-1669891038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-05 06:17:42,995 truncating revision to first 12 chars 2015-12-05 06:17:42,995 Setting DEBUG logging. 2015-12-05 06:17:42,995 attempt 1/10 2015-12-05 06:17:42,995 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/22d7d0b39c38?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-05 06:17:43,275 unpacking tar archive at: fx-team-22d7d0b39c38/testing/mozharness/ program finished with exit code 0 elapsedTime=0.567558 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 06:17:43.507783) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-05 06:17:43.508166) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-05 06:17:43.515934) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-05 06:17:43.516225) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-05 06:17:43.516655) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2015-12-05 06:17:43.516976) ========= /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=5752742a61d0f534093fa7a9000001cb-1449324501.32155-1669891038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:17:43 INFO - MultiFileLogger online at 20151205 06:17:43 in /builds/slave/test 06:17:43 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 06:17:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:17:43 INFO - {'append_to_log': False, 06:17:43 INFO - 'base_work_dir': '/builds/slave/test', 06:17:43 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:17:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:17:43 INFO - 'branch': 'Fx-Team-Non-PGO', 06:17:43 INFO - 'buildbot_json_path': 'buildprops.json', 06:17:43 INFO - 'config_files': ('talos/linux_config.py',), 06:17:43 INFO - 'default_actions': ('clobber', 06:17:43 INFO - 'read-buildbot-config', 06:17:43 INFO - 'download-and-extract', 06:17:43 INFO - 'populate-webroot', 06:17:43 INFO - 'create-virtualenv', 06:17:43 INFO - 'install', 06:17:43 INFO - 'run-tests'), 06:17:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:17:43 INFO - 'download_minidump_stackwalk': True, 06:17:43 INFO - 'download_symbols': 'ondemand', 06:17:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:17:43 INFO - 'tooltool.py': '/tools/tooltool.py', 06:17:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:17:43 INFO - '/tools/misc-python/virtualenv.py')}, 06:17:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:17:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:17:43 INFO - 'installer_path': 'installer.exe', 06:17:43 INFO - 'log_level': 'info', 06:17:43 INFO - 'log_name': 'talos', 06:17:43 INFO - 'log_to_console': True, 06:17:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:17:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:17:43 INFO - 'opt_config_files': (), 06:17:43 INFO - 'pip_index': False, 06:17:43 INFO - 'sps_profile': False, 06:17:43 INFO - 'sps_profile_interval': 0, 06:17:43 INFO - 'suite': 'dromaeojs', 06:17:43 INFO - 'system_bits': '64', 06:17:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:17:43 INFO - 'title': 'talos-linux64-ix-059', 06:17:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:17:43 INFO - 'use_talos_json': True, 06:17:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:17:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:17:43 INFO - 'work_dir': 'build'} 06:17:43 INFO - ##### 06:17:43 INFO - ##### Running clobber step. 06:17:43 INFO - ##### 06:17:43 INFO - Running pre-action listener: _resource_record_pre_action 06:17:43 INFO - Running main action method: clobber 06:17:43 INFO - rmtree: /builds/slave/test/build 06:17:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:17:48 INFO - Running post-action listener: _resource_record_post_action 06:17:48 INFO - ##### 06:17:48 INFO - ##### Running read-buildbot-config step. 06:17:48 INFO - ##### 06:17:48 INFO - Running pre-action listener: _resource_record_pre_action 06:17:48 INFO - Running main action method: read_buildbot_config 06:17:48 INFO - Using buildbot properties: 06:17:48 INFO - { 06:17:48 INFO - "properties": { 06:17:48 INFO - "buildnumber": 991, 06:17:48 INFO - "product": "firefox", 06:17:48 INFO - "script_repo_revision": "production", 06:17:48 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:17:48 INFO - "repository": "", 06:17:48 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 06:17:48 INFO - "buildid": "20151205054030", 06:17:48 INFO - "slavename": "talos-linux64-ix-059", 06:17:48 INFO - "pgo_build": "False", 06:17:48 INFO - "basedir": "/builds/slave/test", 06:17:48 INFO - "project": "", 06:17:48 INFO - "platform": "ubuntu64_hw", 06:17:48 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:17:48 INFO - "slavebuilddir": "test", 06:17:48 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:17:48 INFO - "branch": "fx-team", 06:17:48 INFO - "repo_path": "integration/fx-team", 06:17:48 INFO - "stage_platform": "linux64", 06:17:48 INFO - "builduid": "a5b0c22cea994e4e9db49838c1dbb4f5", 06:17:48 INFO - "revision": "22d7d0b39c38a48fbb86c5c961404ae75403e4d4" 06:17:48 INFO - }, 06:17:48 INFO - "sourcestamp": { 06:17:48 INFO - "repository": "", 06:17:48 INFO - "hasPatch": false, 06:17:48 INFO - "project": "", 06:17:48 INFO - "branch": "fx-team-linux64-talos", 06:17:48 INFO - "changes": [ 06:17:48 INFO - { 06:17:48 INFO - "category": null, 06:17:48 INFO - "files": [ 06:17:48 INFO - { 06:17:48 INFO - "url": null, 06:17:48 INFO - "name": "https://queue.taskcluster.net/v1/task/y70DRBpJRk-EjNPBEYg8PQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 06:17:48 INFO - } 06:17:48 INFO - ], 06:17:48 INFO - "repository": "", 06:17:48 INFO - "rev": "22d7d0b39c38a48fbb86c5c961404ae75403e4d4", 06:17:48 INFO - "who": "mak77@bonardo.net", 06:17:48 INFO - "when": 1449325005, 06:17:48 INFO - "number": 6772700, 06:17:48 INFO - "comments": "Bug 1225540 - follow-up: add alert_emails to urlbar histograms. rs=vladan", 06:17:48 INFO - "project": "", 06:17:48 INFO - "at": "Sat 05 Dec 2015 06:16:45", 06:17:48 INFO - "branch": "fx-team-linux64-talos", 06:17:48 INFO - "revlink": "", 06:17:48 INFO - "properties": [ 06:17:48 INFO - [ 06:17:48 INFO - "buildid", 06:17:48 INFO - "20151205054030", 06:17:48 INFO - "Change" 06:17:48 INFO - ], 06:17:48 INFO - [ 06:17:48 INFO - "builduid", 06:17:48 INFO - "a5b0c22cea994e4e9db49838c1dbb4f5", 06:17:48 INFO - "Change" 06:17:48 INFO - ], 06:17:48 INFO - [ 06:17:48 INFO - "pgo_build", 06:17:48 INFO - "False", 06:17:48 INFO - "Change" 06:17:48 INFO - ] 06:17:48 INFO - ], 06:17:48 INFO - "revision": "22d7d0b39c38a48fbb86c5c961404ae75403e4d4" 06:17:48 INFO - } 06:17:48 INFO - ], 06:17:48 INFO - "revision": "22d7d0b39c38a48fbb86c5c961404ae75403e4d4" 06:17:48 INFO - } 06:17:48 INFO - } 06:17:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/y70DRBpJRk-EjNPBEYg8PQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 06:17:48 INFO - Running post-action listener: _resource_record_post_action 06:17:48 INFO - ##### 06:17:48 INFO - ##### Running download-and-extract step. 06:17:48 INFO - ##### 06:17:48 INFO - Running pre-action listener: _resource_record_pre_action 06:17:48 INFO - Running main action method: download_and_extract 06:17:48 INFO - mkdir: /builds/slave/test/build/tests 06:17:48 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')]} 06:17:48 INFO - https://queue.taskcluster.net/v1/task/y70DRBpJRk-EjNPBEYg8PQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:17:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y70DRBpJRk-EjNPBEYg8PQ/artifacts/public/build/test_packages.json 06:17:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y70DRBpJRk-EjNPBEYg8PQ/artifacts/public/build/test_packages.json 06:17:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y70DRBpJRk-EjNPBEYg8PQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 06:17:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y70DRBpJRk-EjNPBEYg8PQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 06:17:50 INFO - Downloaded 1302 bytes. 06:17:50 INFO - Reading from file /builds/slave/test/build/test_packages.json 06:17:50 INFO - Using the following test package requirements: 06:17:50 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:17:50 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:17:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:17:50 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:17:50 INFO - u'jsshell-linux-x86_64.zip'], 06:17:50 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:17:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:17:50 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:17:50 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:17:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:17:50 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:17:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:17:50 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:17:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:17:50 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:17:50 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:17:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:17:50 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:17:50 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')]} 06:17:50 INFO - https://queue.taskcluster.net/v1/task/y70DRBpJRk-EjNPBEYg8PQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:17:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y70DRBpJRk-EjNPBEYg8PQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:17:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y70DRBpJRk-EjNPBEYg8PQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:17:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y70DRBpJRk-EjNPBEYg8PQ/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 06:17:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y70DRBpJRk-EjNPBEYg8PQ/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 06:17:51 INFO - Downloaded 21849117 bytes. 06:17:51 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 06:17:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:17:51 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 06:17:52 INFO - Return code: 0 06:17:52 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 06:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:52 INFO - https://queue.taskcluster.net/v1/task/y70DRBpJRk-EjNPBEYg8PQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:17:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y70DRBpJRk-EjNPBEYg8PQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:17:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y70DRBpJRk-EjNPBEYg8PQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:17:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y70DRBpJRk-EjNPBEYg8PQ/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 06:17:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y70DRBpJRk-EjNPBEYg8PQ/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 06:17:53 INFO - Downloaded 21849117 bytes. 06:17:53 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 06:17:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:17:53 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 06:17:55 INFO - Return code: 0 06:17:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:55 INFO - https://queue.taskcluster.net/v1/task/y70DRBpJRk-EjNPBEYg8PQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:17:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y70DRBpJRk-EjNPBEYg8PQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:17:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y70DRBpJRk-EjNPBEYg8PQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:17:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y70DRBpJRk-EjNPBEYg8PQ/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 06:17:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y70DRBpJRk-EjNPBEYg8PQ/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 06:17:55 INFO - Downloaded 11132001 bytes. 06:17:55 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 06:17:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:17:55 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 06:17:56 INFO - Return code: 0 06:17:56 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')]} 06:17:56 INFO - https://queue.taskcluster.net/v1/task/y70DRBpJRk-EjNPBEYg8PQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:17:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y70DRBpJRk-EjNPBEYg8PQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:17:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y70DRBpJRk-EjNPBEYg8PQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:17:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y70DRBpJRk-EjNPBEYg8PQ/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 06:17:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y70DRBpJRk-EjNPBEYg8PQ/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 06:17:57 INFO - Downloaded 57707654 bytes. 06:17:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/y70DRBpJRk-EjNPBEYg8PQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:17:57 INFO - mkdir: /builds/slave/test/properties 06:17:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:17:57 INFO - Writing to file /builds/slave/test/properties/build_url 06:17:57 INFO - Contents: 06:17:57 INFO - build_url:https://queue.taskcluster.net/v1/task/y70DRBpJRk-EjNPBEYg8PQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:17:57 INFO - Running post-action listener: _resource_record_post_action 06:17:57 INFO - Running post-action listener: set_extra_try_arguments 06:17:57 INFO - ##### 06:17:57 INFO - ##### Running populate-webroot step. 06:17:57 INFO - ##### 06:17:57 INFO - Running pre-action listener: _resource_record_pre_action 06:17:57 INFO - Running main action method: populate_webroot 06:17:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:17:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:17:57 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 06:17:57 INFO - '../fennec_ids.txt'], 06:17:57 INFO - 'tests': ['tcheck2']}, 06:17:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:17:57 INFO - '--tppagecycles', 06:17:57 INFO - '7'], 06:17:57 INFO - 'tests': ['tsvgm']}}, 06:17:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:17:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:17:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:17:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:17:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:17:57 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:17:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:17:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:17:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:17:57 INFO - 'talos_options': ['--e10s'], 06:17:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:17:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:17:57 INFO - 'tests': ['damp', 'tps']}, 06:17:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:17:57 INFO - 'talos_options': ['--e10s'], 06:17:57 INFO - 'tests': ['damp', 'tps']}, 06:17:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:17:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:17:57 INFO - 'other': {'tests': ['a11yr', 06:17:57 INFO - 'ts_paint', 06:17:57 INFO - 'tpaint', 06:17:57 INFO - 'sessionrestore', 06:17:57 INFO - 'sessionrestore_no_auto_restore']}, 06:17:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:17:57 INFO - 'tests': ['a11yr', 06:17:57 INFO - 'ts_paint', 06:17:57 INFO - 'tpaint', 06:17:57 INFO - 'sessionrestore', 06:17:57 INFO - 'sessionrestore_no_auto_restore']}, 06:17:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:17:57 INFO - 'tests': ['a11yr', 06:17:57 INFO - 'ts_paint', 06:17:57 INFO - 'tpaint', 06:17:57 INFO - 'sessionrestore', 06:17:57 INFO - 'sessionrestore_no_auto_restore']}, 06:17:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:17:57 INFO - 'tests': ['a11yr', 06:17:57 INFO - 'ts_paint', 06:17:57 INFO - 'tpaint', 06:17:57 INFO - 'sessionrestore', 06:17:57 INFO - 'sessionrestore_no_auto_restore']}, 06:17:57 INFO - 'other_l64': {'tests': ['a11yr', 06:17:57 INFO - 'ts_paint', 06:17:57 INFO - 'tpaint', 06:17:57 INFO - 'sessionrestore', 06:17:57 INFO - 'sessionrestore_no_auto_restore']}, 06:17:57 INFO - 'other_nol64': {'tests': ['a11yr', 06:17:57 INFO - 'ts_paint', 06:17:57 INFO - 'tpaint', 06:17:57 INFO - 'sessionrestore', 06:17:57 INFO - 'sessionrestore_no_auto_restore']}, 06:17:57 INFO - 'svgr': {'tests': ['tsvgx', 06:17:57 INFO - 'tsvgr_opacity', 06:17:57 INFO - 'tart', 06:17:57 INFO - 'tscrollx', 06:17:57 INFO - 'cart']}, 06:17:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:17:57 INFO - 'tests': ['tsvgx', 06:17:57 INFO - 'tsvgr_opacity', 06:17:57 INFO - 'tart', 06:17:57 INFO - 'tscrollx', 06:17:57 INFO - 'cart']}, 06:17:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:17:57 INFO - 'tests': ['tp5o']}, 06:17:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:17:57 INFO - 'talos_options': ['--e10s'], 06:17:57 INFO - 'tests': ['tp5o']}, 06:17:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:17:57 INFO - 'talos_options': ['--xperf_path', 06:17:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:17:57 INFO - 'tests': ['tp5n']}, 06:17:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:17:57 INFO - 'talos_options': ['--e10s', 06:17:57 INFO - '--xperf_path', 06:17:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:17:57 INFO - 'tests': ['tp5n']}}, 06:17:57 INFO - 'talos.zip': {'path': '', 06:17:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:17:57 INFO - Running post-action listener: _resource_record_post_action 06:17:57 INFO - ##### 06:17:57 INFO - ##### Running create-virtualenv step. 06:17:57 INFO - ##### 06:17:57 INFO - Running pre-action listener: _resource_record_pre_action 06:17:57 INFO - Running main action method: create_virtualenv 06:17:57 INFO - Creating virtualenv /builds/slave/test/build/venv 06:17:57 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 06:17:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:17:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:17:57 INFO - Using real prefix '/usr' 06:17:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:17:58 INFO - Installing distribute.............................................................................................................................................................................................done. 06:18:00 INFO - Installing pip.................done. 06:18:00 INFO - Return code: 0 06:18:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:18:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f3c5f32ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ec0b0>, '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 0x20ecfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ed440>, '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': '5752742a61d0f534093fa7a9000001cb-1449324501.32155-1669891038', '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 06:18:00 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 06:18:00 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 06:18:00 INFO - Using env: {'DISPLAY': ':0', 06:18:00 INFO - 'HOME': '/home/cltbld', 06:18:00 INFO - 'LANG': 'en_US.UTF-8', 06:18:00 INFO - 'LANGUAGE': 'en_US:en', 06:18:00 INFO - 'LOGNAME': 'cltbld', 06:18:00 INFO - 'MAIL': '/var/mail/cltbld', 06:18:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:00 INFO - 'MOZ_NO_REMOTE': '1', 06:18:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:00 INFO - 'NO_EM_RESTART': '1', 06:18:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:00 INFO - 'PWD': '/builds/slave/test', 06:18:00 INFO - 'SHELL': '/bin/bash', 06:18:00 INFO - 'SHLVL': '1', 06:18:00 INFO - 'TERM': 'linux', 06:18:00 INFO - 'TMOUT': '86400', 06:18:00 INFO - 'USER': 'cltbld', 06:18:00 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1449324501.32155-1669891038', 06:18:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:00 INFO - '_': '/tools/buildbot/bin/python'} 06:18:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:01 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 06:18:01 INFO - Cleaning up... 06:18:01 INFO - Return code: 0 06:18:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:01 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 0x7f3c5f32ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ec0b0>, '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 0x20ecfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ed440>, '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': '5752742a61d0f534093fa7a9000001cb-1449324501.32155-1669891038', '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 06:18:01 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 06:18:01 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 06:18:01 INFO - Using env: {'DISPLAY': ':0', 06:18:01 INFO - 'HOME': '/home/cltbld', 06:18:01 INFO - 'LANG': 'en_US.UTF-8', 06:18:01 INFO - 'LANGUAGE': 'en_US:en', 06:18:01 INFO - 'LOGNAME': 'cltbld', 06:18:01 INFO - 'MAIL': '/var/mail/cltbld', 06:18:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:01 INFO - 'MOZ_NO_REMOTE': '1', 06:18:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:01 INFO - 'NO_EM_RESTART': '1', 06:18:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:01 INFO - 'PWD': '/builds/slave/test', 06:18:01 INFO - 'SHELL': '/bin/bash', 06:18:01 INFO - 'SHLVL': '1', 06:18:01 INFO - 'TERM': 'linux', 06:18:01 INFO - 'TMOUT': '86400', 06:18:01 INFO - 'USER': 'cltbld', 06:18:01 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1449324501.32155-1669891038', 06:18:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:01 INFO - '_': '/tools/buildbot/bin/python'} 06:18:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:01 INFO - Downloading/unpacking psutil>=0.7.1 06:18:01 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 06:18:01 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 06:18:01 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 06:18:01 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 06:18:01 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 06:18:01 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 06:18:03 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 06:18:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:18:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:18:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:18:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:18:03 INFO - Installing collected packages: psutil 06:18:03 INFO - Running setup.py install for psutil 06:18:03 INFO - building 'psutil._psutil_linux' extension 06:18:03 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 06:18:04 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 06:18:04 INFO - building 'psutil._psutil_posix' extension 06:18:04 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 06:18:04 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 06:18:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:18:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:18:04 INFO - Successfully installed psutil 06:18:04 INFO - Cleaning up... 06:18:05 INFO - Return code: 0 06:18:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:18:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3c5f32ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ec0b0>, '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 0x20ecfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ed440>, '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': '5752742a61d0f534093fa7a9000001cb-1449324501.32155-1669891038', '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 06:18:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:18:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:18:05 INFO - Using env: {'DISPLAY': ':0', 06:18:05 INFO - 'HOME': '/home/cltbld', 06:18:05 INFO - 'LANG': 'en_US.UTF-8', 06:18:05 INFO - 'LANGUAGE': 'en_US:en', 06:18:05 INFO - 'LOGNAME': 'cltbld', 06:18:05 INFO - 'MAIL': '/var/mail/cltbld', 06:18:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:05 INFO - 'MOZ_NO_REMOTE': '1', 06:18:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:05 INFO - 'NO_EM_RESTART': '1', 06:18:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:05 INFO - 'PWD': '/builds/slave/test', 06:18:05 INFO - 'SHELL': '/bin/bash', 06:18:05 INFO - 'SHLVL': '1', 06:18:05 INFO - 'TERM': 'linux', 06:18:05 INFO - 'TMOUT': '86400', 06:18:05 INFO - 'USER': 'cltbld', 06:18:05 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1449324501.32155-1669891038', 06:18:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:05 INFO - '_': '/tools/buildbot/bin/python'} 06:18:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:18:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:18:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:18:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:18:06 INFO - Installing collected packages: mozsystemmonitor 06:18:06 INFO - Running setup.py install for mozsystemmonitor 06:18:07 INFO - Successfully installed mozsystemmonitor 06:18:07 INFO - Cleaning up... 06:18:07 INFO - Return code: 0 06:18:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:18:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3c5f32ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ec0b0>, '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 0x20ecfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ed440>, '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': '5752742a61d0f534093fa7a9000001cb-1449324501.32155-1669891038', '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 06:18:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:18:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:18:07 INFO - Using env: {'DISPLAY': ':0', 06:18:07 INFO - 'HOME': '/home/cltbld', 06:18:07 INFO - 'LANG': 'en_US.UTF-8', 06:18:07 INFO - 'LANGUAGE': 'en_US:en', 06:18:07 INFO - 'LOGNAME': 'cltbld', 06:18:07 INFO - 'MAIL': '/var/mail/cltbld', 06:18:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:07 INFO - 'MOZ_NO_REMOTE': '1', 06:18:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:07 INFO - 'NO_EM_RESTART': '1', 06:18:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:07 INFO - 'PWD': '/builds/slave/test', 06:18:07 INFO - 'SHELL': '/bin/bash', 06:18:07 INFO - 'SHLVL': '1', 06:18:07 INFO - 'TERM': 'linux', 06:18:07 INFO - 'TMOUT': '86400', 06:18:07 INFO - 'USER': 'cltbld', 06:18:07 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1449324501.32155-1669891038', 06:18:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:07 INFO - '_': '/tools/buildbot/bin/python'} 06:18:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:07 INFO - Downloading/unpacking blobuploader==1.2.4 06:18:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:08 INFO - Downloading blobuploader-1.2.4.tar.gz 06:18:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:18:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:18:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:18:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:18:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:09 INFO - Downloading docopt-0.6.1.tar.gz 06:18:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:18:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:18:09 INFO - Installing collected packages: blobuploader, requests, docopt 06:18:09 INFO - Running setup.py install for blobuploader 06:18:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:18:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:18:09 INFO - Running setup.py install for requests 06:18:10 INFO - Running setup.py install for docopt 06:18:10 INFO - Successfully installed blobuploader requests docopt 06:18:10 INFO - Cleaning up... 06:18:10 INFO - Return code: 0 06:18:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:18:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:10 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 0x7f3c5f32ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ec0b0>, '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 0x20ecfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ed440>, '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': '5752742a61d0f534093fa7a9000001cb-1449324501.32155-1669891038', '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 06:18:10 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 06:18:10 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 06:18:10 INFO - Using env: {'DISPLAY': ':0', 06:18:10 INFO - 'HOME': '/home/cltbld', 06:18:10 INFO - 'LANG': 'en_US.UTF-8', 06:18:10 INFO - 'LANGUAGE': 'en_US:en', 06:18:10 INFO - 'LOGNAME': 'cltbld', 06:18:10 INFO - 'MAIL': '/var/mail/cltbld', 06:18:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:10 INFO - 'MOZ_NO_REMOTE': '1', 06:18:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:10 INFO - 'NO_EM_RESTART': '1', 06:18:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:10 INFO - 'PWD': '/builds/slave/test', 06:18:10 INFO - 'SHELL': '/bin/bash', 06:18:10 INFO - 'SHLVL': '1', 06:18:10 INFO - 'TERM': 'linux', 06:18:10 INFO - 'TMOUT': '86400', 06:18:10 INFO - 'USER': 'cltbld', 06:18:10 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1449324501.32155-1669891038', 06:18:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:10 INFO - '_': '/tools/buildbot/bin/python'} 06:18:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:18:10 INFO - Running setup.py (path:/tmp/pip-Aht_nF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:18:10 INFO - Running setup.py (path:/tmp/pip-qwBE9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:18:10 INFO - Running setup.py (path:/tmp/pip-xJZPyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:18:10 INFO - Running setup.py (path:/tmp/pip-28ovhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:18:10 INFO - Running setup.py (path:/tmp/pip-sRaeIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:18:10 INFO - Running setup.py (path:/tmp/pip-JwJRqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:18:10 INFO - Running setup.py (path:/tmp/pip-Lm52eC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:18:11 INFO - Running setup.py (path:/tmp/pip-VyepwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:18:11 INFO - Running setup.py (path:/tmp/pip-31QqC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:18:11 INFO - Running setup.py (path:/tmp/pip-P8xYzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:18:11 INFO - Running setup.py (path:/tmp/pip-CRMf20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:18:11 INFO - Running setup.py (path:/tmp/pip-_zR6ah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:18:11 INFO - Running setup.py (path:/tmp/pip-Plwen5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:18:11 INFO - Running setup.py (path:/tmp/pip-q1aQDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:18:11 INFO - Running setup.py (path:/tmp/pip-ezZD4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:18:11 INFO - Running setup.py (path:/tmp/pip-A3nuah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:18:11 INFO - Running setup.py (path:/tmp/pip-tzYfG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:18:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:18:11 INFO - Running setup.py install for manifestparser 06:18:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:18:11 INFO - Running setup.py install for mozcrash 06:18:11 INFO - Running setup.py install for mozdebug 06:18:12 INFO - Running setup.py install for mozdevice 06:18:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:18:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:18:12 INFO - Running setup.py install for mozfile 06:18:12 INFO - Running setup.py install for mozhttpd 06:18:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:18:12 INFO - Running setup.py install for mozinfo 06:18:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:18:12 INFO - Running setup.py install for mozInstall 06:18:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:18:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:18:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:18:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:18:12 INFO - Running setup.py install for mozleak 06:18:12 INFO - Running setup.py install for mozlog 06:18:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:18:12 INFO - Running setup.py install for moznetwork 06:18:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:18:12 INFO - Running setup.py install for mozprocess 06:18:13 INFO - Running setup.py install for mozprofile 06:18:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:18:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:18:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:18:13 INFO - Running setup.py install for mozrunner 06:18:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:18:13 INFO - Running setup.py install for mozscreenshot 06:18:13 INFO - Running setup.py install for moztest 06:18:13 INFO - Running setup.py install for mozversion 06:18:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:18:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:18:13 INFO - Cleaning up... 06:18:13 INFO - Return code: 0 06:18:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:18:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f3c5f32ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ec0b0>, '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 0x20ecfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ed440>, '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': '5752742a61d0f534093fa7a9000001cb-1449324501.32155-1669891038', '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 06:18:13 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 06:18:13 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 06:18:13 INFO - Using env: {'DISPLAY': ':0', 06:18:13 INFO - 'HOME': '/home/cltbld', 06:18:13 INFO - 'LANG': 'en_US.UTF-8', 06:18:13 INFO - 'LANGUAGE': 'en_US:en', 06:18:13 INFO - 'LOGNAME': 'cltbld', 06:18:13 INFO - 'MAIL': '/var/mail/cltbld', 06:18:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:13 INFO - 'MOZ_NO_REMOTE': '1', 06:18:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:13 INFO - 'NO_EM_RESTART': '1', 06:18:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:13 INFO - 'PWD': '/builds/slave/test', 06:18:13 INFO - 'SHELL': '/bin/bash', 06:18:13 INFO - 'SHLVL': '1', 06:18:13 INFO - 'TERM': 'linux', 06:18:13 INFO - 'TMOUT': '86400', 06:18:13 INFO - 'USER': 'cltbld', 06:18:13 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1449324501.32155-1669891038', 06:18:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:13 INFO - '_': '/tools/buildbot/bin/python'} 06:18:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:18:13 INFO - Running setup.py (path:/tmp/pip-xPytkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:18:13 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)) 06:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:18:13 INFO - Running setup.py (path:/tmp/pip-Ok1vAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:18:13 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)) 06:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:18:13 INFO - Running setup.py (path:/tmp/pip-mDnDuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:18:13 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)) 06:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:18:14 INFO - Running setup.py (path:/tmp/pip-GUdA4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:18:14 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)) 06:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:18:14 INFO - Running setup.py (path:/tmp/pip-ZhGab_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:18:14 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)) 06:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:18:14 INFO - Running setup.py (path:/tmp/pip-9T_H_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:18:14 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)) 06:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:18:14 INFO - Running setup.py (path:/tmp/pip-IM3aBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:18:14 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)) 06:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:18:14 INFO - Running setup.py (path:/tmp/pip-DzQqtM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:18:14 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)) 06:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:18:14 INFO - Running setup.py (path:/tmp/pip-NowOGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:18:14 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)) 06:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:18:14 INFO - Running setup.py (path:/tmp/pip-_21zIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:18:14 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)) 06:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:18:14 INFO - Running setup.py (path:/tmp/pip-5Ap3Zl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:18:14 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)) 06:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:18:14 INFO - Running setup.py (path:/tmp/pip-9uWG0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:18:14 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)) 06:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:18:14 INFO - Running setup.py (path:/tmp/pip-VIhLsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:18:14 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)) 06:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:18:14 INFO - Running setup.py (path:/tmp/pip-SDTdk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:18:14 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)) 06:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:18:14 INFO - Running setup.py (path:/tmp/pip-mcSHUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:18:14 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)) 06:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:18:14 INFO - Running setup.py (path:/tmp/pip-CvxnAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:18:14 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)) 06:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:18:14 INFO - Running setup.py (path:/tmp/pip-ycyg6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:18:15 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)) 06:18:15 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)) 06:18:15 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)) 06:18:15 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)) 06:18:15 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)) 06:18:15 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)) 06:18:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:18:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:16 INFO - Downloading blessings-1.5.1.tar.gz 06:18:16 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 06:18:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:18:16 INFO - Installing collected packages: blessings 06:18:16 INFO - Running setup.py install for blessings 06:18:16 INFO - Successfully installed blessings 06:18:16 INFO - Cleaning up... 06:18:16 INFO - Return code: 0 06:18:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:18:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:18:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:18:17 INFO - Reading from file tmpfile_stdout 06:18:17 INFO - Current package versions: 06:18:17 INFO - argparse == 1.2.1 06:18:17 INFO - blessings == 1.5.1 06:18:17 INFO - blobuploader == 1.2.4 06:18:17 INFO - docopt == 0.6.1 06:18:17 INFO - manifestparser == 1.1 06:18:17 INFO - mozInstall == 1.12 06:18:17 INFO - mozcrash == 0.16 06:18:17 INFO - mozdebug == 0.1 06:18:17 INFO - mozdevice == 0.47 06:18:17 INFO - mozfile == 1.2 06:18:17 INFO - mozhttpd == 0.7 06:18:17 INFO - mozinfo == 0.9 06:18:17 INFO - mozleak == 0.1 06:18:17 INFO - mozlog == 3.1 06:18:17 INFO - moznetwork == 0.27 06:18:17 INFO - mozprocess == 0.22 06:18:17 INFO - mozprofile == 0.27 06:18:17 INFO - mozrunner == 6.11 06:18:17 INFO - mozscreenshot == 0.1 06:18:17 INFO - mozsystemmonitor == 0.0 06:18:17 INFO - moztest == 0.7 06:18:17 INFO - mozversion == 1.4 06:18:17 INFO - psutil == 3.1.1 06:18:17 INFO - requests == 1.2.3 06:18:17 INFO - wsgiref == 0.1.2 06:18:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:18:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:17 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 0x7f3c5f32ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ec0b0>, '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 0x20ecfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ed440>, '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': '5752742a61d0f534093fa7a9000001cb-1449324501.32155-1669891038', '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 06:18:17 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 06:18:17 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 06:18:17 INFO - Using env: {'DISPLAY': ':0', 06:18:17 INFO - 'HOME': '/home/cltbld', 06:18:17 INFO - 'LANG': 'en_US.UTF-8', 06:18:17 INFO - 'LANGUAGE': 'en_US:en', 06:18:17 INFO - 'LOGNAME': 'cltbld', 06:18:17 INFO - 'MAIL': '/var/mail/cltbld', 06:18:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:17 INFO - 'MOZ_NO_REMOTE': '1', 06:18:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:17 INFO - 'NO_EM_RESTART': '1', 06:18:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:17 INFO - 'PWD': '/builds/slave/test', 06:18:17 INFO - 'SHELL': '/bin/bash', 06:18:17 INFO - 'SHLVL': '1', 06:18:17 INFO - 'TERM': 'linux', 06:18:17 INFO - 'TMOUT': '86400', 06:18:17 INFO - 'USER': 'cltbld', 06:18:17 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1449324501.32155-1669891038', 06:18:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:17 INFO - '_': '/tools/buildbot/bin/python'} 06:18:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:17 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)) 06:18:17 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)) 06:18:17 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)) 06:18:17 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)) 06:18:17 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)) 06:18:17 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)) 06:18:17 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)) 06:18:17 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)) 06:18:17 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)) 06:18:17 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)) 06:18:17 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)) 06:18:17 INFO - Cleaning up... 06:18:17 INFO - Return code: 0 06:18:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:18:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:17 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 0x7f3c5f32ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ec0b0>, '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 0x20ecfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ed440>, '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': '5752742a61d0f534093fa7a9000001cb-1449324501.32155-1669891038', '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 06:18:17 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 06:18:17 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 06:18:17 INFO - Using env: {'DISPLAY': ':0', 06:18:17 INFO - 'HOME': '/home/cltbld', 06:18:17 INFO - 'LANG': 'en_US.UTF-8', 06:18:17 INFO - 'LANGUAGE': 'en_US:en', 06:18:17 INFO - 'LOGNAME': 'cltbld', 06:18:17 INFO - 'MAIL': '/var/mail/cltbld', 06:18:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:17 INFO - 'MOZ_NO_REMOTE': '1', 06:18:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:17 INFO - 'NO_EM_RESTART': '1', 06:18:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:17 INFO - 'PWD': '/builds/slave/test', 06:18:17 INFO - 'SHELL': '/bin/bash', 06:18:17 INFO - 'SHLVL': '1', 06:18:17 INFO - 'TERM': 'linux', 06:18:17 INFO - 'TMOUT': '86400', 06:18:17 INFO - 'USER': 'cltbld', 06:18:17 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1449324501.32155-1669891038', 06:18:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:17 INFO - '_': '/tools/buildbot/bin/python'} 06:18:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:17 INFO - Downloading/unpacking jsonschema 06:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:18:19 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 06:18:19 INFO - Downloading/unpacking functools32 (from jsonschema) 06:18:19 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 06:18:19 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 06:18:19 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 06:18:19 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 06:18:19 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 06:18:19 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 06:18:19 INFO - Downloading functools32-3.2.3-2.tar.gz 06:18:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 06:18:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:18:19 INFO - warning: no files found matching '*.txt' 06:18:19 INFO - no previously-included directories found matching 'build' 06:18:19 INFO - no previously-included directories found matching 'dist' 06:18:19 INFO - no previously-included directories found matching '.git*' 06:18:19 INFO - Installing collected packages: jsonschema, functools32 06:18:19 INFO - Running setup.py install for functools32 06:18:19 INFO - warning: no files found matching '*.txt' 06:18:19 INFO - no previously-included directories found matching 'build' 06:18:19 INFO - no previously-included directories found matching 'dist' 06:18:19 INFO - no previously-included directories found matching '.git*' 06:18:19 INFO - Successfully installed jsonschema functools32 06:18:19 INFO - Cleaning up... 06:18:19 INFO - Return code: 0 06:18:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:18:19 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')]} 06:18:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:19 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')]} 06:18:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:19 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 0x7f3c5f32ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ec0b0>, '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 0x20ecfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ed440>, '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': '5752742a61d0f534093fa7a9000001cb-1449324501.32155-1669891038', '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 06:18:19 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 06:18:19 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 06:18:19 INFO - Using env: {'DISPLAY': ':0', 06:18:19 INFO - 'HOME': '/home/cltbld', 06:18:19 INFO - 'LANG': 'en_US.UTF-8', 06:18:19 INFO - 'LANGUAGE': 'en_US:en', 06:18:19 INFO - 'LOGNAME': 'cltbld', 06:18:19 INFO - 'MAIL': '/var/mail/cltbld', 06:18:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:19 INFO - 'MOZ_NO_REMOTE': '1', 06:18:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:19 INFO - 'NO_EM_RESTART': '1', 06:18:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:19 INFO - 'PWD': '/builds/slave/test', 06:18:19 INFO - 'SHELL': '/bin/bash', 06:18:19 INFO - 'SHLVL': '1', 06:18:19 INFO - 'TERM': 'linux', 06:18:19 INFO - 'TMOUT': '86400', 06:18:19 INFO - 'USER': 'cltbld', 06:18:19 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1449324501.32155-1669891038', 06:18:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:19 INFO - '_': '/tools/buildbot/bin/python'} 06:18:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:19 INFO - Downloading/unpacking flake8 06:18:19 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 06:18:19 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 06:18:19 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 06:18:19 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 06:18:19 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 06:18:19 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 06:18:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:18:21 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 06:18:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:18:21 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 06:18:21 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 06:18:21 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 06:18:21 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 06:18:21 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 06:18:21 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 06:18:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:18:21 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 06:18:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:18:21 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 06:18:21 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 06:18:21 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 06:18:21 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 06:18:21 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 06:18:21 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 06:18:21 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 06:18:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:18:21 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 06:18:21 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 06:18:21 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 06:18:21 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 06:18:21 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 06:18:21 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 06:18:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 06:18:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:18:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:18:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:18:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:18:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:18:22 INFO - no previously-included directories found matching 'docs/_build' 06:18:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:18:22 INFO - Running setup.py install for pep8 06:18:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:18:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:18:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:18:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:18:22 INFO - no previously-included directories found matching 'docs/_build' 06:18:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:18:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:18:22 INFO - Cleaning up... 06:18:22 INFO - Return code: 0 06:18:22 INFO - Running post-action listener: _resource_record_post_action 06:18:22 INFO - Running post-action listener: _start_resource_monitoring 06:18:22 INFO - Starting resource monitoring. 06:18:22 INFO - ##### 06:18:22 INFO - ##### Running install step. 06:18:22 INFO - ##### 06:18:22 INFO - Running pre-action listener: _resource_record_pre_action 06:18:22 INFO - Running main action method: install 06:18:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:18:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:18:22 INFO - Reading from file tmpfile_stdout 06:18:22 INFO - Detecting whether we're running mozinstall >=1.0... 06:18:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:18:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:18:22 INFO - Reading from file tmpfile_stdout 06:18:22 INFO - Output received: 06:18:22 INFO - Usage: mozinstall [options] installer 06:18:22 INFO - Options: 06:18:22 INFO - -h, --help show this help message and exit 06:18:22 INFO - -d DEST, --destination=DEST 06:18:22 INFO - Directory to install application into. [default: 06:18:22 INFO - "/builds/slave/test"] 06:18:22 INFO - --app=APP Application being installed. [default: firefox] 06:18:22 INFO - mkdir: /builds/slave/test/build/application 06:18:22 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'] 06:18:22 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 06:18:37 INFO - Reading from file tmpfile_stdout 06:18:37 INFO - Output received: 06:18:37 INFO - /builds/slave/test/build/application/firefox/firefox 06:18:37 INFO - Running post-action listener: _resource_record_post_action 06:18:37 INFO - ##### 06:18:37 INFO - ##### Running run-tests step. 06:18:37 INFO - ##### 06:18:37 INFO - Running pre-action listener: _resource_record_pre_action 06:18:37 INFO - Running main action method: run_tests 06:18:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:18:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:18:37 INFO - Python 2.7.3 06:18:37 INFO - Return code: 0 06:18:37 INFO - grabbing minidump binary from tooltool 06:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:37 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 0x20ec0b0>, '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 0x20ecfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ed440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:18:37 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 06:18:37 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 06:18:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:18:37 INFO - Return code: 0 06:18:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:18:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:18:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:18:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:18:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:18:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:18:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:18:38 INFO - Return code: 0 06:18:38 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/y70DRBpJRk-EjNPBEYg8PQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost'] in /builds/slave/test/build 06:18:38 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/y70DRBpJRk-EjNPBEYg8PQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --webServer localhost 06:18:38 INFO - Using env: {'DISPLAY': ':0', 06:18:38 INFO - 'HOME': '/home/cltbld', 06:18:38 INFO - 'LANG': 'en_US.UTF-8', 06:18:38 INFO - 'LANGUAGE': 'en_US:en', 06:18:38 INFO - 'LOGNAME': 'cltbld', 06:18:38 INFO - 'MAIL': '/var/mail/cltbld', 06:18:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:18:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:18:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:38 INFO - 'MOZ_NO_REMOTE': '1', 06:18:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:18:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:38 INFO - 'NO_EM_RESTART': '1', 06:18:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:38 INFO - 'PWD': '/builds/slave/test', 06:18:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:18:38 INFO - 'SHELL': '/bin/bash', 06:18:38 INFO - 'SHLVL': '1', 06:18:38 INFO - 'TERM': 'linux', 06:18:38 INFO - 'TMOUT': '86400', 06:18:38 INFO - 'USER': 'cltbld', 06:18:38 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1449324501.32155-1669891038', 06:18:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:38 INFO - '_': '/tools/buildbot/bin/python'} 06:18:38 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/y70DRBpJRk-EjNPBEYg8PQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost'] with output_timeout 3600 06:18:38 INFO - mozversion INFO | application_buildid: 20151205054030 06:18:38 INFO - mozversion INFO | application_changeset: 22d7d0b39c38a48fbb86c5c961404ae75403e4d4 06:18:38 INFO - mozversion INFO | application_display_name: Nightly 06:18:38 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:18:38 INFO - mozversion INFO | application_name: Firefox 06:18:38 INFO - mozversion INFO | application_remotingname: firefox 06:18:38 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 06:18:38 INFO - mozversion INFO | application_vendor: Mozilla 06:18:38 INFO - mozversion INFO | application_version: 45.0a1 06:18:38 INFO - mozversion INFO | platform_buildid: 20151205054030 06:18:38 INFO - mozversion INFO | platform_changeset: 22d7d0b39c38a48fbb86c5c961404ae75403e4d4 06:18:38 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 06:18:38 INFO - mozversion INFO | platform_version: 45.0a1 06:18:38 INFO - 2015-12-05 06:18:38,645 DEBUG : using testdate: 1449325118 06:18:38 INFO - 2015-12-05 06:18:38,645 DEBUG : actual date: 1449325118 06:18:38 INFO - 2015-12-05 06:18:38,657 INFO : starting webserver on 'localhost:57139' 06:18:38 INFO - 2015-12-05 06:18:38,658 INFO : Starting test suite talos-linux64-ix-059 06:18:38 INFO - 2015-12-05 06:18:38,658 INFO : Starting test dromaeo_css 06:18:38 INFO - 2015-12-05 06:18:38,658 DEBUG : operating with platform_type : linux_ 06:18:38 INFO - 2015-12-05 06:18:38,659 INFO : Initialising browser for dromaeo_css test... 06:18:38 INFO - 2015-12-05 06:18:38,676 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcTb69W/profile http://localhost:57139/getInfo.html 06:18:45 INFO - 2015-12-05 06:18:45,476 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:18:45 INFO - 2015-12-05 06:18:45,476 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:18:45 INFO - 2015-12-05 06:18:45,476 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:18:45 INFO - 2015-12-05 06:18:45,476 DEBUG : BROWSER_OUTPUT: __metrics 06:18:45 INFO - 2015-12-05 06:18:45,565 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] 06:18:45 INFO - 2015-12-05 06:18:45,641 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] 06:18:47 INFO - 2015-12-05 06:18:47,046 INFO : Browser initialized. 06:18:47 INFO - 2015-12-05 06:18:47,047 INFO : Running cycle 1/1 for dromaeo_css test... 06:18:47 INFO - 2015-12-05 06:18:47,047 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcTb69W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:18:59 INFO - 2015-12-05 06:18:59,120 DEBUG : BROWSER_OUTPUT: RSS: Main: 142733312 06:18:59 INFO - 2015-12-05 06:18:59,120 DEBUG : BROWSER_OUTPUT: 06:19:49 INFO - 2015-12-05 06:19:49,982 DEBUG : BROWSER_OUTPUT: 1449325189979 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] 06:22:03 INFO - 2015-12-05 06:22:03,529 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57139/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57139/tests/dromaeo/cssquery-ext.html) 06:22:04 INFO - 2015-12-05 06:22:04,734 DEBUG : BROWSER_OUTPUT: RSS: Main: 264343552 06:22:04 INFO - 2015-12-05 06:22:04,734 DEBUG : BROWSER_OUTPUT: 06:25:07 INFO - 2015-12-05 06:25:07,241 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57139/tests/dromaeo/cssquery-ext.html (next: http://localhost:57139/tests/dromaeo/cssquery-jquery.html) 06:25:07 INFO - 2015-12-05 06:25:07,814 DEBUG : BROWSER_OUTPUT: RSS: Main: 226766848 06:25:07 INFO - 2015-12-05 06:25:07,814 DEBUG : BROWSER_OUTPUT: 06:28:09 INFO - 2015-12-05 06:28:09,824 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57139/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57139/tests/dromaeo/cssquery-mootools.html) 06:28:10 INFO - 2015-12-05 06:28:10,398 DEBUG : BROWSER_OUTPUT: RSS: Main: 215248896 06:28:10 INFO - 2015-12-05 06:28:10,398 DEBUG : BROWSER_OUTPUT: 06:31:12 INFO - 2015-12-05 06:31:12,341 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57139/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57139/tests/dromaeo/cssquery-prototype.html) 06:31:12 INFO - 2015-12-05 06:31:12,947 DEBUG : BROWSER_OUTPUT: RSS: Main: 205008896 06:31:12 INFO - 2015-12-05 06:31:12,947 DEBUG : BROWSER_OUTPUT: 06:34:15 INFO - 2015-12-05 06:34:15,711 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57139/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57139/tests/dromaeo/cssquery-yui.html) 06:34:16 INFO - 2015-12-05 06:34:16,318 DEBUG : BROWSER_OUTPUT: RSS: Main: 205520896 06:34:16 INFO - 2015-12-05 06:34:16,318 DEBUG : BROWSER_OUTPUT: 06:37:19 INFO - 2015-12-05 06:37:19,148 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57139/tests/dromaeo/cssquery-yui.html (next: http://localhost:57139/tests/dromaeo/cssquery-dojo.html) 06:37:19 INFO - 2015-12-05 06:37:19,398 DEBUG : BROWSER_OUTPUT: RSS: Main: 248836096 06:37:19 INFO - 2015-12-05 06:37:19,398 DEBUG : BROWSER_OUTPUT: 06:37:19 INFO - 2015-12-05 06:37:19,402 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:37:19 INFO - 2015-12-05 06:37:19,402 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:37:19 INFO - 2015-12-05 06:37:19,402 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:37:19 INFO - 2015-12-05 06:37:19,402 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:37:19 INFO - 2015-12-05 06:37:19,402 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2628.342914271432;2708.498927698376;2713.674359076911;2726;2742.232174991002;4500.72995620263;4649.5118012608655;4655.115528049677;4738.668293219476;4779.593734532569;4587.082583483309;4594.471635761888;4676.97661511692;4689.413823272091;4704.9178688901575;4222.261104306742;4329.415528903605;4358.694891357591;4371.256886329315;4431.313146462304;4202.2856114460465;4393.033532622818;4396.164728701552;4428.6014258716705;4437.977810110961;4234.597713217239;4304.5910638489295;4343.956560434387;4355.281378572532;4366.781660916973;4345.521992580813;4345.69580129391;4362.21480133579;4385.429894113745;4392.648588112943;4174.937375939363;4325.416068830699;4342.370356298319;4344.978275108636;4380.6057454829215;4595.095302536259;4634.050019745944;4639.628829693616;4738.47876733559;4763.166445871993;5109.156989096795;5144.4083930348115;5145.691258524463;5156.123459011977;5205.984832957575;4873.049755297719;5182.300389447414;5186.247994040843;5189.818356357547;5199.766010529497;4632.536746325374;4635.7218566886095;4643.303504474356;4750.8337208197545;4755.025219829927;5197.272381866542;5215.348081489814;5219.347581552306;5222.764975576109;5227.111391063529;4980.2778597103215;5009.724465154379;5012.04771093491;5012.573931215888;5060.569851562658;4861.1006963711825;4971.751412429437;4974.850754477371;4979.30289759434;4981.850544483671;4885.096257192431;4924.630652701062;4930.580900623487;4954.851354459372;4981.302617633534;4894.486078961729;5002.574781143643;5002.724850133205;5008.574271186917;5009.44896061433;4196.622303992655;4224.514180869178;4277.807498662568;4282.614564689193;4310.52584215736;3686.8340924658455;3745.2696724139078;3762.736608437383;3783.7162212833596;3797.9240415191543;4199.118185181146;4294.57054294568;4297.613214810682;4343.652507799368;4414.1171765647;5097.057044446715;5174.120399532088;5181.145111056633;5187.870303242449;5195.064888320138;4430.069685366109;4436.82252709888;4442.511323754385;4463.218936686067;4480.596746292849;4310.0517886065645;4382;4382.802773875183;4426.291793313055;4566.26939689648;4866.099771542276;4900.950990490192;4901.191303434894;4923.0646177227645;4927.482614325444;5163.793448262028;5182.274481572507;5184.092783762751;5190.97404512975;5237.031149237403;4646.976765116288;4759.428868535798;4899.240617704261;4920.384951881015;4964.67729597575;4897.730624815669;4957.677750946177;4964.726940018189;4986.975065124651;5006.924896126488;5143.819966301162;5145.945081258258;5152.716600587004;5158.587313015025;5197.870053248699;4745.217039188633;4871.147549178951;4958.42978057528;4976.552110310089;4998;4875.731834749123;4877.317175595348;4942.357493525818;4960.255961605643;4978.929530151035;4887.780049897834;4895.828645997373;4902.338184345211;4919.0407870464915;4957.851264462072;4753.382060332135;4865.878353041202;5039;5039.244113383022;5057.064443078042;4753.595944344769;4762.4285085789925;4824.059308434821;4826.782794774173;4878.609711223165 06:37:19 INFO - 2015-12-05 06:37:19,404 DEBUG : BROWSER_OUTPUT: |1;ext.html;553.6318348298382;573.498189084551;575.8597976007508;584.6462889951581;586.0652259645866;27970.86014569927;36792.816035919815;37552;37568.624313756925;37584.248315033685;40182.799086004605;40912.38631420531;40951;40963.38554921671;40975.795121024355;6969.581825090486;7067.752628657998;7748.380129589634;7915.762527124196;7937.087234967995;9825.606975720963;9995.300328976975;9998.700038998843;10002.249831262649;10004.94997525015;9647.855282170773;9672.322937394385;9737.51312434379;9753.463559504224;9763.755906102333;9932.553035113437;10060.195184385231;10061.044200800949;10062.89937100627;10069;9705.805883882284;9845.950770246103;9852.80294394108;9855.507224638812;9857.654982075594;37444;37625.24749505022;37705.81147094275;37867.81066094652;37877.81061094705;2711.457708458316;2770.0858716623466;3127.2650927032355;3195.4407978603886;3343.130785995634;26704.732952670613;27075.45849083027;27277.454450911067;27518;27744.861275693493;3161.873525058995;3198.792078514889;3216.788802140524;3221.855016524262;3235.110344655215;221800;222166;222707;224820.99999999837;224857;48600.7569962155;49704.75147624239;52108.21837672438;56767.99999999917;58072;54655.18017229745;54937.725311373986;54993.45006549963;55053.44946550563;55070.44929550734;13013.414396352187;13224;13307.401166947511;13342.533011344556;13347.265900375378;8303.95848020756;8630;9762.609495620238;9785.315027948118;9880.654177103766;17809;17848.821511784718;17855.107244637715;17970.55073623144;18016.90991545034;7243.927560724325;7508.511946723445;7559.28186822251;7702.691892324245;7731.3041826234785;885.2121611765534;913.2921985461188;962.4177372689562;983.9311248212556;999.3104757717152;26216.34459138537;26296.47407051848;26512.734872651414;26601.068962586218;26617;938.061938061938;964.4888209249109;990.5047476261869;1021.8211812932856;1052.3002203534563;13996.370163342674;14055.43778248879;14529.491467798576;14781.482648107265;14823.258837058103;209691;212296;213496;213537;213976;41543.37684934728;42521.57478425238;42704;42734.57265427306;42751;1173.5305877648839;1199.5501686867424;1208.8670246272902;1211.8364020857248;1228.8709685482895;25496.23511294664;26252.474950501266;26871;27257;27314.453710926067;37388.765572819284;37968;38734.806325969315;39553.802230989815;40192.79903600463;239947;245114;245290;247461.5419226812;250396;25864.612030819928;26543.469130617665;26828.195154145407;26990.865045674647;27038.188854334403;29961.234971172064;30402.391952161277;31739.206519836265;34519;41445.378319325835;32058.519122213653;32173;32915.177120572174;33323.50014749829;33366.83316583402;32592.674073258964;32691;32753;32862.34275314432;32909.341813163126;32520.186995325304;32891.50662740109;33132.66867331392;33138;33209.16977075592;28788.280292992844;29506.852465737535;29778.255543610718;29975.452086572885;30142.54786178165;22595.88702056479;22943.084635800624;23114;23217;23375.41561460977 06:37:19 INFO - 2015-12-05 06:37:19,405 DEBUG : BROWSER_OUTPUT: |2;jquery.html;315.7552896505208;319.2418007232822;327.3518433501667;327.9409706252875;330.0214862931408;12927.547535836247;13389.531366402178;14635.780463293046;15106.395744170233;15317.310721017568;12749.936250318735;14531.346089425975;14933.431989641094;15516.224188790571;15518.146501942389;4796.760161991904;4829.68607040543;4929.4824043475455;4979.526944940225;4984.725840078794;3510.210202704384;3605.945910811327;4918.508149185089;4965.255211718235;5346;5378;5378.838634840961;5429.755660995245;5530.115181570949;5542.0301447246575;5002.324686167357;5400.324959380077;5627.465390787889;5639.379668236491;5660.377358490563;4985.302057711923;4985.725785081819;5021.196608542616;5033.874153146201;5039.168537191359;18407.63184736311;19366.612667746565;19371.225150993945;19397.709034364496;20431.591368172703;1770.3272756352503;1777.4223377402395;1819.7088465845402;1866.1727482863473;1899.7815251246145;12250.75498490034;12602.74794504114;12677.429515671816;12776.466823981089;12982.350882455934;1580.1230317173963;1650.9257083431276;1707.7182264926396;1731.6709825133184;1777.2002598830577;52541.73729131368;55181.448185518035;56586.15120773192;59876;61256;14667.612727854183;15382.769258461132;15500.30248638814;15541.222938853012;15813.1302778346;23242.53514929726;23364;23381.7661823383;23394.64908026381;23442;7756.185600511978;7885.250901164381;7993.360531157494;8025.317847982987;8066.637001334954;6528.902066469007;6538.901916471256;6562.146920900253;6613.603183808987;6624.436922861611;7439.218882017419;7602.7339043133225;7674.618568657584;7694.807629809299;7727.768166955;1700.6513664698707;1719.4239929623466;1735.973960390595;2141.466580142777;2948.3170315013235;863.7883718489011;930.1349744737324;932.7341707613433;947.3699989507038;994.5474808961905;15216.315265813066;15290.159041252615;15773.526794195963;16089.115098669452;16344.509664710078;838.1953324808252;841.1924552429614;865.299107722734;866.8049688819965;866.8873046504041;7456;8193.8361232775;8288.295494882881;8383.371247156365;8574.09971952936;477568;488870;495217;510244;512401;67661.66169169123;71675.64162179155;72172.63913680502;72349.63825180946;73094.26905730981;1096.1942971915635;1098.9780204395868;1099.2525082943675;1105.6240878101323;1113.9443027848574;14435.133891966516;14543.490977815725;14746.778798318248;14749.705005900036;14773.778393324324;29425.705742942297;30063;30171.245718857204;30394.696053039188;30983.845080774452;34408.48387274143;35311.470327945615;35852.28295434129;36294;36429.45355819612;8299.502029878227;8762.386632935633;8916.19754222123;8929.776755581162;8934;15926.68146637084;16011;16114;16310.673786524441;16412.917935410245;12615.873841261837;13360.331983400985;13456;13481;13592.660183495096;12572.497100115894;12808.6797830055;13254.53609123676;13352.666183345495;13386.129901556367;13079;13312.334383280991;13376.933115334361;13664.453421863014;13728.519501817389;8545.145485451654;8686.47881127109;8715.912840871764;8753.255973242345;8921.509316987369;10093.949530252596;12851.421686024338;12893;13073.215607063607;13322.467101315839 06:37:19 INFO - 2015-12-05 06:37:19,406 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1470.9117452952817;1628.641698826258;1684.4020372767668;1718.312674930028;1722.3455087066914;5976.850578735533;6404.839879003027;6941.895871561931;7561.924380756191;7585.9241407585905;6271.937280627192;7101.5739055656695;7107.111611048619;7250.746223882165;7300.087489063867;1975.506123469129;2023.8178563929243;2024.3724445421892;2026.1692705990547;2029.2187507809526;1715.8970461772333;1748.6764948484508;2022.251766846269;2052.1586149678633;2076.169532187122;2064.256867527689;2071.9378418647466;2074.1703318672503;2074.4502706782714;2077.480629842539;1996.950076248091;1999.730036445076;2053.240301088592;2058.7014882842054;2059.7116403703494;2048.4059622709397;2060.206820374152;2088.1229883448987;2098.643230650793;2100.4433825036376;7279;7367.594782286972;7391.963040184818;7393.260673932564;7404.333609975128;4153.54311025787;4154;4163.375493675942;4219.599138081878;4251.851185208534;2539.263613552068;2549.3754030262703;2576.9871150644312;2580.6000069988995;2603.1799983005294;827.5407149032285;829.2785276809154;1557.7196104701263;1571.1751330551438;1621.9756703649455;9817.410955342631;9897.75255618608;9936.354136981145;9944.651937182163;9998;3690.409534474525;3695.4087346024507;3745.8127093645753;3765.981170094132;3769.6418840210135;8075.757727268191;8077.474964127313;8082.515049097073;8084.595770211466;8103.837923241502;4221.240176768211;4257.297545904953;4259.169461954951;4259.914801703949;4261.316779871933;3861.9613803861603;3888.7666739995125;3890.7081968851885;3895.6883449323986;3895.7533589251734;3247.3018301064913;3251.6260630027377;3257.413665540178;3281.409346317686;3283.3925723741186;838.0404436919814;856.1652388920877;858.7123313689984;962.6341990043738;981.9705408837747;923.690563661181;939.915407613318;941.1576638908139;976.6923419122953;1232.7534493101416;6630.270670226271;6708.932910670928;6712.328767123347;6717.126773519509;6721;528.8810017746054;532.3133158225845;534.1666999480823;536.7987004873172;706.1878839334703;5372.409035006146;5407.70257635826;5463.235147079412;5475.945240547543;5481.780728770805;8547.829043419097;8778.780530486789;8884.955575222082;8887.422317549339;8905.198532132139;8721.127887211229;8785.253253473526;8814.382993190415;8882.911170888208;8903.643854245887;6738.831529211809;6778.356056174655;6903.1716194057035;6969.581825090409;6977.267386924402;6755.763548275787;6850.623215722983;6888.345607167311;6888.862222755417;6893.827654308482;7705.845883082419;7764.767056988074;7863.174366691415;7896.6575682133025;7931.286184243446;7982.640781164978;8141.3893957952205;8141.79645508867;8142.389320801082;8150.184981501802;5995.700214989321;6198.535109866688;6222.439980401786;6233.2208473940755;6240.625562466266;6843.7604683835825;6883.346082122191;6886.622675464827;6888.690008949709;6912.861742765217;5097.898042039213;6409.2949775525585;6520.673966301761;6672.299408562031;6701.061851340914;5837.8540536485225;6292.056191571301;6371.044343348535;6555.2133743951035;6681.799546013627;6013.248343957005;6149.20060392164;6271.4669253114;6278.277998030102;6330.8100756977365;5764.913526297025;5966.433188847052;5974.9402505974385;5987.850303742442;6001.279846418458;6012.368701286302;6043.758249669964;6045.969770151121;6050.6369617823075;6051.7579296827635 06:37:19 INFO - 2015-12-05 06:37:19,407 DEBUG : BROWSER_OUTPUT: |4;prototype.html;279.5904000639064;283.20984453375087;289.6509705804506;289.6856910252376;291.82782158526464;5225.137852254383;5382.650127741699;5420.620556561037;5422.48486393792;5488.396276409591;5331.546818520431;5388.245645609618;5398.109311963531;5399.514043736063;5408.242846001563;4061.1877624475073;4077.4699289092378;4078.5921407859123;4078.632923036926;4086.366613174963;3831.406132049523;3935.606439356056;3997.2605068062503;4077.531083925357;4098.4876890388705;4011.83952641894;4021.034951611621;4022.3765316376007;4031;4039.4950631171105;3828.7319887607878;3933.252681990413;4052.2503336882623;4080.469538959946;4086.2849001424634;3387.6104248011547;3448.77582957107;3451.2924850405607;3461.2904354607244;3465.826708664582;5096.337476128117;5097.3118628984985;5100.821471248526;5105.33630628016;5107.080725469414;4594.218982772936;4603.263477843562;4603.5166307537565;4604.171249175147;4607.17070927233;5356.651817631841;5534.225208470817;5541.0580201365865;5543.556515478793;5547.223388725582;3743.1952130292116;3749.2876353492748;3763.07804587875;3765.265773174232;3770.359038963383;5801.535877129862;5886.70566471679;5891.440313170242;5900.704964751745;5902.291724993029;3892.649661530476;3915.7650540967634;3916.8433262669173;3917.040325120364;3920.5687374389363;3964.7621142731527;3980.6616437602547;3981.303271927401;3982.920341593152;3987.342088555356;4517.751523666164;4601.654875884322;4634.791434385461;4642.257238841837;4643.8374656886845;5662.37713851476;5670;5671.461211184931;5674.06377947634;5684.175794509855;1370.595674276091;1385.2450414524108;1386.473140206715;1388.2503448137893;1388.965275868091;899.5637115998735;902.9864552031725;912.8037471943564;914.07221670005;917.9127982841619;4974.9751251243515;4985.077760614298;4986.202207646759;4988.301637770715;4989.276554899519;5867.061270196748;5867.589268751231;5869.20765696634;5869.266341707286;5871.823845284648;4925.113479573711;4947.356843610308;4973.801047958041;4974.1543937530705;4978.079055374767;3036.225762430566;3066.509358502629;3131.3424180921807;3164.5095010273444;3169.6037995250595;5441.863953401196;5526.557875369961;5552.056150454352;5607.130894711327;5616.241807356037;6005.279366476051;6036.366181550961;6039.275286965592;6044.969775151096;6051.273847138372;5592.384837667853;5594.748236329375;5599.804006859903;5600.831975040755;5601.551875849922;5696.971515142398;5879.853003674943;5890.263717035371;5894;5901.173835662925;5777.046787280052;5791.102379131242;5797.507211886868;5798.246227990334;5802.071668533014;5596.580256480862;5608.355039170548;5618.69097199658;5626.718664066862;5644.774209031592;3939.4287828265315;4026.6376026156613;4068.14568940514;4070.4301397804925;4070.61329173728;5798.15926690619;5801.245838041028;5843.065109582446;5877.588568800143;5883.55873309512;5625;5655.632383895034;5662.5469962402085;5662.546996240373;5666.490015898589;5652.4064973178865;5653.519450846559;5659;5659.801906933402;5665.943340566541;5406.162044883049;5500.669959802424;5522.30971128609;5523.143912693539;5530.391656917816;5699.715014249354;5707.372189059117;5708.771649133988;5709.885802283848;5712.11462223356;5506.91739623898;5509.228707980806;5509.283793106871;5531.446855314436;5534.750936207961 06:37:19 INFO - 2015-12-05 06:37:19,408 DEBUG : BROWSER_OUTPUT: |5;yui.html;700.0865163734725;723.7105157936825;741.6069483173917;752.9849403011937;774.6243072110029;11207.775844483105;11579.36313502757;11605.6518304451;11627.534898604057;12241.204321719082;12750.617481475547;12911.677208069803;12944.352782360891;12961.870381296185;12998.54505092322;632.7279269913935;639.2073828452732;790.3084800799286;809.5992483720566;821.9301359384459;813.877918312252;814.1451475950258;818.5907046476761;819.5697258939075;820.3683163963744;658.4666420199629;843.9113893041234;851.4848516647432;851.7998270406449;852.6887685994599;663.0319733189525;822.3298012120133;841.1798496465897;841.6002398860553;843.9282660973824;626.042155502078;628.0955424189153;629.8645791154878;630.7697690342992;630.8202162383699;11716.882831171664;12157.452914618863;12175.45210465531;12179.269243845398;12195.512179512809;11217.15871309655;11393.259438136494;11466.885331146665;11811.586594469238;12053.096017798613;9288.814223715488;9318.673846415411;9481;9481.857772133355;9498.525073746285;3201.9679803201902;3223.323102148528;3250.3174333390016;3258.771885967983;3320.9501857472155;38256.61743382558;43821.561784382066;44318.11363772707;44327.335089973676;44406.55593444056;9061.093890611019;9117.863232051524;9133.360664753403;9166.26669866409;9218.21645160169;16377.918110409371;16638.3344666212;16660.58348541272;16672.74990875138;16675.832141821487;6249.156363890907;6352.523560732963;6371.617702937839;6411.807645770635;6495.447886929569;3377.341418423384;3695.9651297636706;3755.4366844972924;3760.4359346098304;3828.3874580067054;2642.2205449392477;2681.986590067037;2689.1125928443566;2692.4480481501246;2867.4551835151256;498.4741098141423;498.49402856101085;505.1336957118559;510.20917577754335;510.3671447405265;438.2855944810003;467.3760529692898;470.30864628995323;533.1765362460395;584.3163498706524;7583.78041172801;7584.469087163846;7657;7773.339266162327;7780.610969451618;431.61586188292443;431.7495852405597;433.7462584388105;518.3261759712434;553.4880235781885;3347.598288205431;3368.3094965532496;3458.775179613317;3481.7736847104857;3555.484454754046;48818.75590622024;49970.75014624903;50690.74654626777;50742.74628626907;50914.490855090975;42229.366559501635;43267.13465730668;43372.783136084116;43666.56333436688;44232.3365149523;38172.61827381746;38704.806475968006;38834.146146466286;39707;40347.79826100851;7482.326590606872;7745.419093567893;7915.722949696733;8045.718399855977;8055.436119471581;29212.56181157327;29462.937594368188;29607.55588666129;29826.552601711424;30915.381692366478;37596;37693.81153094217;38122;39342.803285983384;39795.204095918496;9465.716028519155;9837.311388202757;10155.593776248867;10244.64143754965;10527.526261318106;10521.263511554118;10608.575656973635;10702.411367374869;11400.258983166068;11404.885951140383;9698.903010970082;10041.74895627586;10136.797264054825;10376.377417354983;10989.945050274697;10735.302205356627;10743.623973161215;10822.621208257673;11015.339079655247;11185.608503702331;8717.564121794012;9504.667336643184;9713.805723885624;9943.403395796275;10499.317544359592;8629.784255393666;8644.654213831627;8856.114388561093;8890.64437422496;9305.86041209396;8127.512349259064;8526.27526660216;8710.869336959824;8809.07504711996;9240.306976976888 06:37:19 INFO - 2015-12-05 06:37:19,408 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:37:19 INFO - 2015-12-05 06:37:19,408 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:37:19 INFO - 2015-12-05 06:37:19,408 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1056 06:37:19 INFO - 2015-12-05 06:37:19,408 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:37:19 INFO - 2015-12-05 06:37:19,408 DEBUG : BROWSER_OUTPUT: __startTimestamp1449326239399__endTimestamp 06:37:19 INFO - 2015-12-05 06:37:19,408 DEBUG : BROWSER_OUTPUT: 06:37:19 INFO - 2015-12-05 06:37:19,408 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:37:19 INFO - 2015-12-05 06:37:19,408 DEBUG : BROWSER_OUTPUT: Number of tests: 6 06:37:19 INFO - 2015-12-05 06:37:19,408 DEBUG : BROWSER_OUTPUT: 06:37:19 INFO - 2015-12-05 06:37:19,408 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4678.62 Median:4826.78 stddev:496.71 (10.3%) stddev-sans-first:471.47 06:37:19 INFO - 2015-12-05 06:37:19,408 DEBUG : BROWSER_OUTPUT: Values: 2628.3 2708.5 2713.7 2726.0 2742.2 4500.7 4649.5 4655.1 4738.7 4779.6 4587.1 4594.5 4677.0 4689.4 4704.9 4222.3 4329.4 4358.7 4371.3 4431.3 4202.3 4393.0 4396.2 4428.6 4438.0 4234.6 4304.6 4344.0 4355.3 4366.8 4345.5 4345.7 4362.2 4385.4 4392.6 4174.9 4325.4 4342.4 4345.0 4380.6 4595.1 4634.1 4639.6 4738.5 4763.2 5109.2 5144.4 5145.7 5156.1 5206.0 4873.0 5182.3 5186.2 5189.8 5199.8 4632.5 4635.7 4643.3 4750.8 4755.0 5197.3 5215.3 5219.3 5222.8 5227.1 4980.3 5009.7 5012.0 5012.6 5060.6 4861.1 4971.8 4974.9 4979.3 4981.9 4885.1 4924.6 4930.6 4954.9 4981.3 4894.5 5002.6 5002.7 5008.6 5009.4 4196.6 4224.5 4277.8 4282.6 4310.5 3686.8 3745.3 3762.7 3783.7 3797.9 4199.1 4294.6 4297.6 4343.7 4414.1 5097.1 5174.1 5181.1 5187.9 5195.1 4430.1 4436.8 4442.5 4463.2 4480.6 4310.1 4382.0 4382.8 4426.3 4566.3 4866.1 4901.0 4901.2 4923.1 4927.5 5163.8 5182.3 5184.1 5191.0 5237.0 4647.0 4759.4 4899.2 4920.4 4964.7 4897.7 4957.7 4964.7 4987.0 5006.9 5143.8 5145.9 5152.7 5158.6 5197.9 4745.2 4871.1 4958.4 4976.6 4998.0 4875.7 4877.3 4942.4 4960.3 4978.9 4887.8 4895.8 4902.3 4919.0 4957.9 4753.4 4865.9 5039.0 5039.2 5057.1 4753.6 4762.4 4824.1 4826.8 4878.6 06:37:19 INFO - 2015-12-05 06:37:19,408 DEBUG : BROWSER_OUTPUT: 06:37:19 INFO - 2015-12-05 06:37:19,409 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38776.73 Median:32722.00 stddev:59033.61 (180.4%) stddev-sans-first:59129.45 06:37:19 INFO - 2015-12-05 06:37:19,410 DEBUG : BROWSER_OUTPUT: Values: 553.6 573.5 575.9 584.6 586.1 27970.9 36792.8 37552.0 37568.6 37584.2 40182.8 40912.4 40951.0 40963.4 40975.8 6969.6 7067.8 7748.4 7915.8 7937.1 9825.6 9995.3 9998.7 10002.2 10004.9 9647.9 9672.3 9737.5 9753.5 9763.8 9932.6 10060.2 10061.0 10062.9 10069.0 9705.8 9846.0 9852.8 9855.5 9857.7 37444.0 37625.2 37705.8 37867.8 37877.8 2711.5 2770.1 3127.3 3195.4 3343.1 26704.7 27075.5 27277.5 27518.0 27744.9 3161.9 3198.8 3216.8 3221.9 3235.1 221800.0 222166.0 222707.0 224821.0 224857.0 48600.8 49704.8 52108.2 56768.0 58072.0 54655.2 54937.7 54993.5 55053.4 55070.4 13013.4 13224.0 13307.4 13342.5 13347.3 8304.0 8630.0 9762.6 9785.3 9880.7 17809.0 17848.8 17855.1 17970.6 18016.9 7243.9 7508.5 7559.3 7702.7 7731.3 885.2 913.3 962.4 983.9 999.3 26216.3 26296.5 26512.7 26601.1 26617.0 938.1 964.5 990.5 1021.8 1052.3 13996.4 14055.4 14529.5 14781.5 14823.3 209691.0 212296.0 213496.0 213537.0 213976.0 41543.4 42521.6 42704.0 42734.6 42751.0 1173.5 1199.6 1208.9 1211.8 1228.9 25496.2 26252.5 26871.0 27257.0 27314.5 37388.8 37968.0 38734.8 39553.8 40192.8 239947.0 245114.0 245290.0 247461.5 250396.0 25864.6 26543.5 26828.2 26990.9 27038.2 29961.2 30402.4 31739.2 34519.0 41445.4 32058.5 32173.0 32915.2 33323.5 33366.8 32592.7 32691.0 32753.0 32862.3 32909.3 32520.2 32891.5 33132.7 33138.0 33209.2 28788.3 29506.9 29778.3 29975.5 30142.5 22595.9 22943.1 23114.0 23217.0 23375.4 06:37:19 INFO - 2015-12-05 06:37:19,410 DEBUG : BROWSER_OUTPUT: 06:37:19 INFO - 2015-12-05 06:37:19,410 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26989.92 Median:317.50 stddev:81028.24 (25520.8%) stddev-sans-first:81230.79 06:37:19 INFO - 2015-12-05 06:37:19,410 DEBUG : BROWSER_OUTPUT: Values: 315.8 319.2 327.4 327.9 330.0 12927.5 13389.5 14635.8 15106.4 15317.3 12749.9 14531.3 14933.4 15516.2 15518.1 4796.8 4829.7 4929.5 4979.5 4984.7 3510.2 3605.9 4918.5 4965.3 5346.0 5378.0 5378.8 5429.8 5530.1 5542.0 5002.3 5400.3 5627.5 5639.4 5660.4 4985.3 4985.7 5021.2 5033.9 5039.2 18407.6 19366.6 19371.2 19397.7 20431.6 1770.3 1777.4 1819.7 1866.2 1899.8 12250.8 12602.7 12677.4 12776.5 12982.4 1580.1 1650.9 1707.7 1731.7 1777.2 52541.7 55181.4 56586.2 59876.0 61256.0 14667.6 15382.8 15500.3 15541.2 15813.1 23242.5 23364.0 23381.8 23394.6 23442.0 7756.2 7885.3 7993.4 8025.3 8066.6 6528.9 6538.9 6562.1 6613.6 6624.4 7439.2 7602.7 7674.6 7694.8 7727.8 1700.7 1719.4 1736.0 2141.5 2948.3 863.8 930.1 932.7 947.4 994.5 15216.3 15290.2 15773.5 16089.1 16344.5 838.2 841.2 865.3 866.8 866.9 7456.0 8193.8 8288.3 8383.4 8574.1 477568.0 488870.0 495217.0 510244.0 512401.0 67661.7 71675.6 72172.6 72349.6 73094.3 1096.2 1099.0 1099.3 1105.6 1113.9 14435.1 14543.5 14746.8 14749.7 14773.8 29425.7 30063.0 30171.2 30394.7 30983.8 34408.5 35311.5 35852.3 36294.0 36429.5 8299.5 8762.4 8916.2 8929.8 8934.0 15926.7 16011.0 16114.0 16310.7 16412.9 12615.9 13360.3 13456.0 13481.0 13592.7 12572.5 12808.7 13254.5 13352.7 13386.1 13079.0 13312.3 13376.9 13664.5 13728.5 8545.1 8686.5 8715.9 8753.3 8921.5 10093.9 12851.4 12893.0 13073.2 13322.5 06:37:19 INFO - 2015-12-05 06:37:19,410 DEBUG : BROWSER_OUTPUT: 06:37:19 INFO - 2015-12-05 06:37:19,410 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4999.93 Median:6227.83 stddev:2650.88 (42.6%) stddev-sans-first:2645.05 06:37:19 INFO - 2015-12-05 06:37:19,410 DEBUG : BROWSER_OUTPUT: Values: 1470.9 1628.6 1684.4 1718.3 1722.3 5976.9 6404.8 6941.9 7561.9 7585.9 6271.9 7101.6 7107.1 7250.7 7300.1 1975.5 2023.8 2024.4 2026.2 2029.2 1715.9 1748.7 2022.3 2052.2 2076.2 2064.3 2071.9 2074.2 2074.5 2077.5 1997.0 1999.7 2053.2 2058.7 2059.7 2048.4 2060.2 2088.1 2098.6 2100.4 7279.0 7367.6 7392.0 7393.3 7404.3 4153.5 4154.0 4163.4 4219.6 4251.9 2539.3 2549.4 2577.0 2580.6 2603.2 827.5 829.3 1557.7 1571.2 1622.0 9817.4 9897.8 9936.4 9944.7 9998.0 3690.4 3695.4 3745.8 3766.0 3769.6 8075.8 8077.5 8082.5 8084.6 8103.8 4221.2 4257.3 4259.2 4259.9 4261.3 3862.0 3888.8 3890.7 3895.7 3895.8 3247.3 3251.6 3257.4 3281.4 3283.4 838.0 856.2 858.7 962.6 982.0 923.7 939.9 941.2 976.7 1232.8 6630.3 6708.9 6712.3 6717.1 6721.0 528.9 532.3 534.2 536.8 706.2 5372.4 5407.7 5463.2 5475.9 5481.8 8547.8 8778.8 8885.0 8887.4 8905.2 8721.1 8785.3 8814.4 8882.9 8903.6 6738.8 6778.4 6903.2 6969.6 6977.3 6755.8 6850.6 6888.3 6888.9 6893.8 7705.8 7764.8 7863.2 7896.7 7931.3 7982.6 8141.4 8141.8 8142.4 8150.2 5995.7 6198.5 6222.4 6233.2 6240.6 6843.8 6883.3 6886.6 6888.7 6912.9 5097.9 6409.3 6520.7 6672.3 6701.1 5837.9 6292.1 6371.0 6555.2 6681.8 6013.2 6149.2 6271.5 6278.3 6330.8 5764.9 5966.4 5974.9 5987.9 6001.3 6012.4 6043.8 6046.0 6050.6 6051.8 06:37:19 INFO - 2015-12-05 06:37:19,410 DEBUG : BROWSER_OUTPUT: 06:37:19 INFO - 2015-12-05 06:37:19,410 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4643.95 Median:5398.81 stddev:1407.68 (26.1%) stddev-sans-first:1372.98 06:37:19 INFO - 2015-12-05 06:37:19,412 DEBUG : BROWSER_OUTPUT: Values: 279.6 283.2 289.7 289.7 291.8 5225.1 5382.7 5420.6 5422.5 5488.4 5331.5 5388.2 5398.1 5399.5 5408.2 4061.2 4077.5 4078.6 4078.6 4086.4 3831.4 3935.6 3997.3 4077.5 4098.5 4011.8 4021.0 4022.4 4031.0 4039.5 3828.7 3933.3 4052.3 4080.5 4086.3 3387.6 3448.8 3451.3 3461.3 3465.8 5096.3 5097.3 5100.8 5105.3 5107.1 4594.2 4603.3 4603.5 4604.2 4607.2 5356.7 5534.2 5541.1 5543.6 5547.2 3743.2 3749.3 3763.1 3765.3 3770.4 5801.5 5886.7 5891.4 5900.7 5902.3 3892.6 3915.8 3916.8 3917.0 3920.6 3964.8 3980.7 3981.3 3982.9 3987.3 4517.8 4601.7 4634.8 4642.3 4643.8 5662.4 5670.0 5671.5 5674.1 5684.2 1370.6 1385.2 1386.5 1388.3 1389.0 899.6 903.0 912.8 914.1 917.9 4975.0 4985.1 4986.2 4988.3 4989.3 5867.1 5867.6 5869.2 5869.3 5871.8 4925.1 4947.4 4973.8 4974.2 4978.1 3036.2 3066.5 3131.3 3164.5 3169.6 5441.9 5526.6 5552.1 5607.1 5616.2 6005.3 6036.4 6039.3 6045.0 6051.3 5592.4 5594.7 5599.8 5600.8 5601.6 5697.0 5879.9 5890.3 5894.0 5901.2 5777.0 5791.1 5797.5 5798.2 5802.1 5596.6 5608.4 5618.7 5626.7 5644.8 3939.4 4026.6 4068.1 4070.4 4070.6 5798.2 5801.2 5843.1 5877.6 5883.6 5625.0 5655.6 5662.5 5662.5 5666.5 5652.4 5653.5 5659.0 5659.8 5665.9 5406.2 5500.7 5522.3 5523.1 5530.4 5699.7 5707.4 5708.8 5709.9 5712.1 5506.9 5509.2 5509.3 5531.4 5534.8 06:37:19 INFO - 2015-12-05 06:37:19,412 DEBUG : BROWSER_OUTPUT: 06:37:19 INFO - 2015-12-05 06:37:19,412 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12161.86 Median:44366.95 stddev:13755.97 (31.0%) stddev-sans-first:13767.63 06:37:19 INFO - 2015-12-05 06:37:19,412 DEBUG : BROWSER_OUTPUT: Values: 700.1 723.7 741.6 753.0 774.6 11207.8 11579.4 11605.7 11627.5 12241.2 12750.6 12911.7 12944.4 12961.9 12998.5 632.7 639.2 790.3 809.6 821.9 813.9 814.1 818.6 819.6 820.4 658.5 843.9 851.5 851.8 852.7 663.0 822.3 841.2 841.6 843.9 626.0 628.1 629.9 630.8 630.8 11716.9 12157.5 12175.5 12179.3 12195.5 11217.2 11393.3 11466.9 11811.6 12053.1 9288.8 9318.7 9481.0 9481.9 9498.5 3202.0 3223.3 3250.3 3258.8 3321.0 38256.6 43821.6 44318.1 44327.3 44406.6 9061.1 9117.9 9133.4 9166.3 9218.2 16377.9 16638.3 16660.6 16672.7 16675.8 6249.2 6352.5 6371.6 6411.8 6495.4 3377.3 3696.0 3755.4 3760.4 3828.4 2642.2 2682.0 2689.1 2692.4 2867.5 498.5 498.5 505.1 510.2 510.4 438.3 467.4 470.3 533.2 584.3 7583.8 7584.5 7657.0 7773.3 7780.6 431.6 431.7 433.7 518.3 553.5 3347.6 3368.3 3458.8 3481.8 3555.5 48818.8 49970.8 50690.7 50742.7 50914.5 42229.4 43267.1 43372.8 43666.6 44232.3 38172.6 38704.8 38834.1 39707.0 40347.8 7482.3 7745.4 7915.7 8045.7 8055.4 29212.6 29462.9 29607.6 29826.6 30915.4 37596.0 37693.8 38122.0 39342.8 39795.2 9465.7 9837.3 10155.6 10244.6 10527.5 10521.3 10608.6 10702.4 11400.3 11404.9 9698.9 10041.7 10136.8 10376.4 10989.9 10735.3 10743.6 10822.6 11015.3 11185.6 8717.6 9504.7 9713.8 9943.4 10499.3 8629.8 8644.7 8856.1 8890.6 9305.9 8127.5 8526.3 8710.9 8809.1 9240.3 06:37:19 INFO - 2015-12-05 06:37:19,412 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:37:19 INFO - 2015-12-05 06:37:19,412 DEBUG : BROWSER_OUTPUT: 06:37:20 INFO - 2015-12-05 06:37:20,179 INFO : Browser exited with error code: 0 06:37:20 INFO - 2015-12-05 06:37:20,200 INFO : Completed test dromaeo_css (00:18:41) 06:37:20 INFO - 2015-12-05 06:37:20,200 INFO : Starting test kraken 06:37:20 INFO - 2015-12-05 06:37:20,200 DEBUG : operating with platform_type : linux_ 06:37:20 INFO - 2015-12-05 06:37:20,200 INFO : Initialising browser for kraken test... 06:37:20 INFO - 2015-12-05 06:37:20,206 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqdl3AS/profile http://localhost:57139/getInfo.html 06:37:24 INFO - 2015-12-05 06:37:24,065 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:37:24 INFO - 2015-12-05 06:37:24,065 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:37:24 INFO - 2015-12-05 06:37:24,065 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:37:24 INFO - 2015-12-05 06:37:24,065 DEBUG : BROWSER_OUTPUT: __metrics 06:37:24 INFO - 2015-12-05 06:37:24,194 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] 06:37:24 INFO - 2015-12-05 06:37:24,249 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] 06:37:25 INFO - 2015-12-05 06:37:25,325 INFO : Browser initialized. 06:37:25 INFO - 2015-12-05 06:37:25,326 INFO : Running cycle 1/1 for kraken test... 06:37:25 INFO - 2015-12-05 06:37:25,326 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqdl3AS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:37:37 INFO - 2015-12-05 06:37:37,370 DEBUG : BROWSER_OUTPUT: RSS: Main: 142778368 06:37:37 INFO - 2015-12-05 06:37:37,370 DEBUG : BROWSER_OUTPUT: 06:37:40 INFO - 2015-12-05 06:37:40,006 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57139/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57139/tests/kraken/driver.html?testName=audio-beat-detection) 06:37:40 INFO - 2015-12-05 06:37:40,592 DEBUG : BROWSER_OUTPUT: RSS: Main: 178950144 06:37:40 INFO - 2015-12-05 06:37:40,592 DEBUG : BROWSER_OUTPUT: 06:37:43 INFO - 2015-12-05 06:37:43,390 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57139/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57139/tests/kraken/driver.html?testName=audio-dft) 06:37:43 INFO - 2015-12-05 06:37:43,972 DEBUG : BROWSER_OUTPUT: RSS: Main: 166821888 06:37:43 INFO - 2015-12-05 06:37:43,972 DEBUG : BROWSER_OUTPUT: 06:37:46 INFO - 2015-12-05 06:37:46,981 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57139/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57139/tests/kraken/driver.html?testName=audio-fft) 06:37:47 INFO - 2015-12-05 06:37:47,546 DEBUG : BROWSER_OUTPUT: RSS: Main: 152481792 06:37:47 INFO - 2015-12-05 06:37:47,547 DEBUG : BROWSER_OUTPUT: 06:37:49 INFO - 2015-12-05 06:37:49,583 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57139/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57139/tests/kraken/driver.html?testName=audio-oscillator) 06:37:50 INFO - 2015-12-05 06:37:50,148 DEBUG : BROWSER_OUTPUT: RSS: Main: 156520448 06:37:50 INFO - 2015-12-05 06:37:50,149 DEBUG : BROWSER_OUTPUT: 06:37:52 INFO - 2015-12-05 06:37:52,411 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57139/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57139/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:37:52 INFO - 2015-12-05 06:37:52,976 DEBUG : BROWSER_OUTPUT: RSS: Main: 157081600 06:37:52 INFO - 2015-12-05 06:37:52,976 DEBUG : BROWSER_OUTPUT: 06:37:56 INFO - 2015-12-05 06:37:56,018 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57139/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57139/tests/kraken/driver.html?testName=imaging-darkroom) 06:37:56 INFO - 2015-12-05 06:37:56,603 DEBUG : BROWSER_OUTPUT: RSS: Main: 156565504 06:37:56 INFO - 2015-12-05 06:37:56,604 DEBUG : BROWSER_OUTPUT: 06:38:00 INFO - 2015-12-05 06:38:00,031 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57139/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57139/tests/kraken/driver.html?testName=imaging-desaturate) 06:38:00 INFO - 2015-12-05 06:38:00,612 DEBUG : BROWSER_OUTPUT: RSS: Main: 157347840 06:38:00 INFO - 2015-12-05 06:38:00,612 DEBUG : BROWSER_OUTPUT: 06:38:03 INFO - 2015-12-05 06:38:03,543 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57139/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57139/tests/kraken/driver.html?testName=json-parse-financial) 06:38:04 INFO - 2015-12-05 06:38:04,129 DEBUG : BROWSER_OUTPUT: RSS: Main: 158322688 06:38:04 INFO - 2015-12-05 06:38:04,129 DEBUG : BROWSER_OUTPUT: 06:38:05 INFO - 2015-12-05 06:38:05,883 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57139/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57139/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:38:06 INFO - 2015-12-05 06:38:06,456 DEBUG : BROWSER_OUTPUT: RSS: Main: 167178240 06:38:06 INFO - 2015-12-05 06:38:06,456 DEBUG : BROWSER_OUTPUT: 06:38:08 INFO - 2015-12-05 06:38:08,332 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57139/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57139/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:38:08 INFO - 2015-12-05 06:38:08,925 DEBUG : BROWSER_OUTPUT: RSS: Main: 168222720 06:38:08 INFO - 2015-12-05 06:38:08,925 DEBUG : BROWSER_OUTPUT: 06:38:11 INFO - 2015-12-05 06:38:11,462 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57139/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57139/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:38:12 INFO - 2015-12-05 06:38:12,044 DEBUG : BROWSER_OUTPUT: RSS: Main: 180334592 06:38:12 INFO - 2015-12-05 06:38:12,045 DEBUG : BROWSER_OUTPUT: 06:38:14 INFO - 2015-12-05 06:38:14,600 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57139/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57139/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:38:15 INFO - 2015-12-05 06:38:15,189 DEBUG : BROWSER_OUTPUT: RSS: Main: 182607872 06:38:15 INFO - 2015-12-05 06:38:15,190 DEBUG : BROWSER_OUTPUT: 06:38:17 INFO - 2015-12-05 06:38:17,790 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57139/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57139/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:38:18 INFO - 2015-12-05 06:38:18,371 DEBUG : BROWSER_OUTPUT: RSS: Main: 178376704 06:38:18 INFO - 2015-12-05 06:38:18,371 DEBUG : BROWSER_OUTPUT: 06:38:20 INFO - 2015-12-05 06:38:20,126 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57139/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57139/tests/kraken/driver.html?testName=ai-astar) 06:38:20 INFO - 2015-12-05 06:38:20,376 DEBUG : BROWSER_OUTPUT: RSS: Main: 236449792 06:38:20 INFO - 2015-12-05 06:38:20,376 DEBUG : BROWSER_OUTPUT: 06:38:20 INFO - 2015-12-05 06:38:20,377 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:38:20 INFO - 2015-12-05 06:38:20,377 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:38:20 INFO - 2015-12-05 06:38:20,379 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:38:20 INFO - 2015-12-05 06:38:20,379 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:38:20 INFO - 2015-12-05 06:38:20,379 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;111;105;110;110;112;101;111;109;101 06:38:20 INFO - 2015-12-05 06:38:20,379 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;130;153;176;138;159;151;145;174;138 06:38:20 INFO - 2015-12-05 06:38:20,379 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;160;161;163;162;162;161;161;163 06:38:20 INFO - 2015-12-05 06:38:20,379 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;73;80;92;74;72;72;107;93;72 06:38:20 INFO - 2015-12-05 06:38:20,380 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;134;94;95;95;136;95;94;134 06:38:20 INFO - 2015-12-05 06:38:20,380 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;110;110;110;110;109;110;109 06:38:20 INFO - 2015-12-05 06:38:20,380 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;147;148;146;148;146;147;148;147 06:38:20 INFO - 2015-12-05 06:38:20,380 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;97;96;95;96;96;97;96;95 06:38:20 INFO - 2015-12-05 06:38:20,380 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;70;69;71;70;70;69;71;80;69;70 06:38:20 INFO - 2015-12-05 06:38:20,380 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;69;69;68;68;69;68;68;68 06:38:20 INFO - 2015-12-05 06:38:20,380 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;82;83;93;85;85;87;86;85;92 06:38:20 INFO - 2015-12-05 06:38:20,381 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;117;130;127;128;124;128;127;125;144;127 06:38:20 INFO - 2015-12-05 06:38:20,381 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;132;146;150;145;151;134;143;150;146;137 06:38:20 INFO - 2015-12-05 06:38:20,381 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;69;68;69;69;68;69;67;68;68 06:38:20 INFO - 2015-12-05 06:38:20,381 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:38:20 INFO - 2015-12-05 06:38:20,381 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:38:20 INFO - 2015-12-05 06:38:20,381 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1004 06:38:20 INFO - 2015-12-05 06:38:20,381 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:38:20 INFO - 2015-12-05 06:38:20,381 DEBUG : BROWSER_OUTPUT: __startTimestamp1449326300377__endTimestamp 06:38:20 INFO - 2015-12-05 06:38:20,382 DEBUG : BROWSER_OUTPUT: 06:38:20 INFO - 2015-12-05 06:38:20,389 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:38:20 INFO - 2015-12-05 06:38:20,389 DEBUG : BROWSER_OUTPUT: Number of tests: 14 06:38:20 INFO - 2015-12-05 06:38:20,389 DEBUG : BROWSER_OUTPUT: 06:38:20 INFO - 2015-12-05 06:38:20,389 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.00 Median:110.00 stddev:4.14 (3.8%) stddev-sans-first:4.32 06:38:20 INFO - 2015-12-05 06:38:20,389 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 105.0 110.0 110.0 112.0 101.0 111.0 109.0 101.0 06:38:20 INFO - 2015-12-05 06:38:20,389 DEBUG : BROWSER_OUTPUT: 06:38:20 INFO - 2015-12-05 06:38:20,390 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.80 Median:153.50 stddev:15.05 (9.8%) stddev-sans-first:15.95 06:38:20 INFO - 2015-12-05 06:38:20,390 DEBUG : BROWSER_OUTPUT: Values: 154.0 130.0 153.0 176.0 138.0 159.0 151.0 145.0 174.0 138.0 06:38:20 INFO - 2015-12-05 06:38:20,390 DEBUG : BROWSER_OUTPUT: 06:38:20 INFO - 2015-12-05 06:38:20,390 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.07 (0.7%) stddev-sans-first:1.13 06:38:20 INFO - 2015-12-05 06:38:20,390 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 160.0 161.0 163.0 162.0 162.0 161.0 161.0 163.0 06:38:20 INFO - 2015-12-05 06:38:20,390 DEBUG : BROWSER_OUTPUT: 06:38:20 INFO - 2015-12-05 06:38:20,390 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.60 Median:73.50 stddev:12.46 (16.9%) stddev-sans-first:12.72 06:38:20 INFO - 2015-12-05 06:38:20,390 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 80.0 92.0 74.0 72.0 72.0 107.0 93.0 72.0 06:38:20 INFO - 2015-12-05 06:38:20,390 DEBUG : BROWSER_OUTPUT: 06:38:20 INFO - 2015-12-05 06:38:20,390 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.60 Median:94.50 stddev:19.38 (20.5%) stddev-sans-first:20.10 06:38:20 INFO - 2015-12-05 06:38:20,390 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 134.0 94.0 95.0 95.0 136.0 95.0 94.0 134.0 06:38:20 INFO - 2015-12-05 06:38:20,390 DEBUG : BROWSER_OUTPUT: 06:38:20 INFO - 2015-12-05 06:38:20,390 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 06:38:20 INFO - 2015-12-05 06:38:20,391 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 110.0 110.0 110.0 110.0 109.0 110.0 109.0 06:38:20 INFO - 2015-12-05 06:38:20,391 DEBUG : BROWSER_OUTPUT: 06:38:20 INFO - 2015-12-05 06:38:20,391 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 06:38:20 INFO - 2015-12-05 06:38:20,391 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 147.0 148.0 146.0 148.0 146.0 147.0 148.0 147.0 06:38:20 INFO - 2015-12-05 06:38:20,391 DEBUG : BROWSER_OUTPUT: 06:38:20 INFO - 2015-12-05 06:38:20,391 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 06:38:20 INFO - 2015-12-05 06:38:20,391 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 97.0 96.0 95.0 96.0 96.0 97.0 96.0 95.0 06:38:20 INFO - 2015-12-05 06:38:20,391 DEBUG : BROWSER_OUTPUT: 06:38:20 INFO - 2015-12-05 06:38:20,391 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.90 Median:70.00 stddev:3.28 (4.7%) stddev-sans-first:3.46 06:38:20 INFO - 2015-12-05 06:38:20,391 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 71.0 70.0 70.0 69.0 71.0 80.0 69.0 70.0 06:38:20 INFO - 2015-12-05 06:38:20,391 DEBUG : BROWSER_OUTPUT: 06:38:20 INFO - 2015-12-05 06:38:20,392 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.50 06:38:20 INFO - 2015-12-05 06:38:20,392 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 69.0 69.0 68.0 68.0 69.0 68.0 68.0 68.0 06:38:20 INFO - 2015-12-05 06:38:20,392 DEBUG : BROWSER_OUTPUT: 06:38:20 INFO - 2015-12-05 06:38:20,392 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:85.50 stddev:3.80 (4.4%) stddev-sans-first:3.75 06:38:20 INFO - 2015-12-05 06:38:20,392 DEBUG : BROWSER_OUTPUT: Values: 82.0 82.0 83.0 93.0 85.0 85.0 87.0 86.0 85.0 92.0 06:38:20 INFO - 2015-12-05 06:38:20,392 DEBUG : BROWSER_OUTPUT: 06:38:20 INFO - 2015-12-05 06:38:20,392 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:127.50 stddev:6.73 (5.3%) stddev-sans-first:5.93 06:38:20 INFO - 2015-12-05 06:38:20,392 DEBUG : BROWSER_OUTPUT: Values: 117.0 130.0 127.0 128.0 124.0 128.0 127.0 125.0 144.0 127.0 06:38:20 INFO - 2015-12-05 06:38:20,392 DEBUG : BROWSER_OUTPUT: 06:38:20 INFO - 2015-12-05 06:38:20,392 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.40 Median:146.00 stddev:6.83 (4.7%) stddev-sans-first:5.87 06:38:20 INFO - 2015-12-05 06:38:20,392 DEBUG : BROWSER_OUTPUT: Values: 132.0 146.0 150.0 145.0 151.0 134.0 143.0 150.0 146.0 137.0 06:38:20 INFO - 2015-12-05 06:38:20,392 DEBUG : BROWSER_OUTPUT: 06:38:20 INFO - 2015-12-05 06:38:20,392 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:0.85 (1.2%) stddev-sans-first:0.71 06:38:20 INFO - 2015-12-05 06:38:20,392 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 68.0 69.0 69.0 68.0 69.0 67.0 68.0 68.0 06:38:20 INFO - 2015-12-05 06:38:20,392 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:38:20 INFO - 2015-12-05 06:38:20,392 DEBUG : BROWSER_OUTPUT: 06:38:21 INFO - 2015-12-05 06:38:21,171 INFO : Browser exited with error code: 0 06:38:21 INFO - 2015-12-05 06:38:21,224 INFO : Completed test kraken (00:01:01) 06:38:21 INFO - 2015-12-05 06:38:21,224 INFO : Starting test v8_7 06:38:21 INFO - 2015-12-05 06:38:21,224 DEBUG : operating with platform_type : linux_ 06:38:21 INFO - 2015-12-05 06:38:21,224 INFO : Initialising browser for v8_7 test... 06:38:21 INFO - 2015-12-05 06:38:21,230 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppFvkBk/profile http://localhost:57139/getInfo.html 06:38:25 INFO - 2015-12-05 06:38:25,376 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:38:25 INFO - 2015-12-05 06:38:25,376 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:38:25 INFO - 2015-12-05 06:38:25,376 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:38:25 INFO - 2015-12-05 06:38:25,376 DEBUG : BROWSER_OUTPUT: __metrics 06:38:25 INFO - 2015-12-05 06:38:25,452 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] 06:38:25 INFO - 2015-12-05 06:38:25,513 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] 06:38:25 INFO - 2015-12-05 06:38:25,783 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 06:38:26 INFO - 2015-12-05 06:38:26,448 INFO : Browser initialized. 06:38:26 INFO - 2015-12-05 06:38:26,449 INFO : Running cycle 1/1 for v8_7 test... 06:38:26 INFO - 2015-12-05 06:38:26,449 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppFvkBk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:38:38 INFO - 2015-12-05 06:38:38,431 DEBUG : BROWSER_OUTPUT: RSS: Main: 140500992 06:38:38 INFO - 2015-12-05 06:38:38,431 DEBUG : BROWSER_OUTPUT: 06:38:59 INFO - 2015-12-05 06:38:59,872 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57139/tests/v8_7/run.html (next: http://localhost:57139/tests/v8_7/run.html) 06:39:00 INFO - 2015-12-05 06:39:00,130 DEBUG : BROWSER_OUTPUT: RSS: Main: 435027968 06:39:00 INFO - 2015-12-05 06:39:00,131 DEBUG : BROWSER_OUTPUT: 06:39:00 INFO - 2015-12-05 06:39:00,131 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:39:00 INFO - 2015-12-05 06:39:00,131 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:39:00 INFO - 2015-12-05 06:39:00,131 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:39:00 INFO - 2015-12-05 06:39:00,131 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:39:00 INFO - 2015-12-05 06:39:00,131 DEBUG : BROWSER_OUTPUT: |0;Richards;172.68174753928508 06:39:00 INFO - 2015-12-05 06:39:00,131 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.25442354255912 06:39:00 INFO - 2015-12-05 06:39:00,131 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.00945232137894 06:39:00 INFO - 2015-12-05 06:39:00,131 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5181.347150259067 06:39:00 INFO - 2015-12-05 06:39:00,131 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2018.1451612903227 06:39:00 INFO - 2015-12-05 06:39:00,131 DEBUG : BROWSER_OUTPUT: |5;Earley;781.8608287724785 06:39:00 INFO - 2015-12-05 06:39:00,132 DEBUG : BROWSER_OUTPUT: |6;Boyer;12048.192771084337 06:39:00 INFO - 2015-12-05 06:39:00,132 DEBUG : BROWSER_OUTPUT: |7;RegExp;26394.736842105263 06:39:00 INFO - 2015-12-05 06:39:00,132 DEBUG : BROWSER_OUTPUT: |8;Splay;603.1175059952038 06:39:00 INFO - 2015-12-05 06:39:00,132 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4854.368932038835 06:39:00 INFO - 2015-12-05 06:39:00,132 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:39:00 INFO - 2015-12-05 06:39:00,132 DEBUG : BROWSER_OUTPUT: __startTimestamp1449326340124__endTimestamp 06:39:00 INFO - 2015-12-05 06:39:00,132 DEBUG : BROWSER_OUTPUT: 06:39:00 INFO - 2015-12-05 06:39:00,132 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:39:00 INFO - 2015-12-05 06:39:00,132 DEBUG : BROWSER_OUTPUT: Number of tests: 10 06:39:00 INFO - 2015-12-05 06:39:00,133 DEBUG : BROWSER_OUTPUT: 06:39:00 INFO - 2015-12-05 06:39:00,133 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:172.68 Median:172.68 stddev:0.00 (0.0%) 06:39:00 INFO - 2015-12-05 06:39:00,133 DEBUG : BROWSER_OUTPUT: Values: 172.7 06:39:00 INFO - 2015-12-05 06:39:00,133 DEBUG : BROWSER_OUTPUT: 06:39:00 INFO - 2015-12-05 06:39:00,133 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.25 Median:186.25 stddev:0.00 (0.0%) 06:39:00 INFO - 2015-12-05 06:39:00,133 DEBUG : BROWSER_OUTPUT: Values: 186.3 06:39:00 INFO - 2015-12-05 06:39:00,133 DEBUG : BROWSER_OUTPUT: 06:39:00 INFO - 2015-12-05 06:39:00,133 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.01 Median:278.01 stddev:0.00 (0.0%) 06:39:00 INFO - 2015-12-05 06:39:00,134 DEBUG : BROWSER_OUTPUT: Values: 278.0 06:39:00 INFO - 2015-12-05 06:39:00,134 DEBUG : BROWSER_OUTPUT: 06:39:00 INFO - 2015-12-05 06:39:00,134 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 06:39:00 INFO - 2015-12-05 06:39:00,134 DEBUG : BROWSER_OUTPUT: Values: 5181.3 06:39:00 INFO - 2015-12-05 06:39:00,134 DEBUG : BROWSER_OUTPUT: 06:39:00 INFO - 2015-12-05 06:39:00,134 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2018.15 Median:2018.15 stddev:0.00 (0.0%) 06:39:00 INFO - 2015-12-05 06:39:00,134 DEBUG : BROWSER_OUTPUT: Values: 2018.1 06:39:00 INFO - 2015-12-05 06:39:00,134 DEBUG : BROWSER_OUTPUT: 06:39:00 INFO - 2015-12-05 06:39:00,134 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:781.86 Median:781.86 stddev:0.00 (0.0%) 06:39:00 INFO - 2015-12-05 06:39:00,134 DEBUG : BROWSER_OUTPUT: Values: 781.9 06:39:00 INFO - 2015-12-05 06:39:00,134 DEBUG : BROWSER_OUTPUT: 06:39:00 INFO - 2015-12-05 06:39:00,134 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12048.19 Median:12048.19 stddev:0.00 (0.0%) 06:39:00 INFO - 2015-12-05 06:39:00,134 DEBUG : BROWSER_OUTPUT: Values: 12048.2 06:39:00 INFO - 2015-12-05 06:39:00,134 DEBUG : BROWSER_OUTPUT: 06:39:00 INFO - 2015-12-05 06:39:00,134 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26394.74 Median:26394.74 stddev:0.00 (0.0%) 06:39:00 INFO - 2015-12-05 06:39:00,135 DEBUG : BROWSER_OUTPUT: Values: 26394.7 06:39:00 INFO - 2015-12-05 06:39:00,135 DEBUG : BROWSER_OUTPUT: 06:39:00 INFO - 2015-12-05 06:39:00,135 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:603.12 Median:603.12 stddev:0.00 (0.0%) 06:39:00 INFO - 2015-12-05 06:39:00,135 DEBUG : BROWSER_OUTPUT: Values: 603.1 06:39:00 INFO - 2015-12-05 06:39:00,135 DEBUG : BROWSER_OUTPUT: 06:39:00 INFO - 2015-12-05 06:39:00,135 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 06:39:00 INFO - 2015-12-05 06:39:00,135 DEBUG : BROWSER_OUTPUT: Values: 4854.4 06:39:00 INFO - 2015-12-05 06:39:00,135 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:39:00 INFO - 2015-12-05 06:39:00,135 DEBUG : BROWSER_OUTPUT: 06:39:01 INFO - 2015-12-05 06:39:01,027 INFO : Browser exited with error code: 0 06:39:01 INFO - 2015-12-05 06:39:01,043 INFO : Completed test v8_7 (00:00:39) 06:39:01 INFO - 2015-12-05 06:39:01,141 INFO : Completed test suite (00:20:22) 06:39:01 INFO - 2015-12-05 06:39:01,141 DEBUG : Working with test: dromaeo_css 06:39:01 INFO - 2015-12-05 06:39:01,141 DEBUG : Generating results file: dromaeo_css 06:39:01 INFO - 2015-12-05 06:39:01,143 DEBUG : Working with test: kraken 06:39:01 INFO - 2015-12-05 06:39:01,143 DEBUG : Generating results file: kraken 06:39:01 INFO - 2015-12-05 06:39:01,143 INFO : javascript benchmark 06:39:01 INFO - 2015-12-05 06:39:01,143 DEBUG : Working with test: v8_7 06:39:01 INFO - 2015-12-05 06:39:01,143 DEBUG : Generating results file: v8_7 06:39:01 INFO - 2015-12-05 06:39:01,144 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:39:01 INFO - 2015-12-05 06:39:01,200 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 06:39:01 INFO - 2015-12-05 06:39:01,200 DEBUG : process_Request line: dromaeo_css 6339.43 graph.html#tests=[[72,132,35]] 06:39:01 INFO - 2015-12-05 06:39:01,200 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:39:01 INFO - 2015-12-05 06:39:01,237 DEBUG : process_Request line: kraken 1525.80 graph.html#tests=[[232,132,35]] 06:39:01 INFO - 2015-12-05 06:39:01,237 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:39:01 INFO - 2015-12-05 06:39:01,289 DEBUG : process_Request line: v8_7 19774.94 graph.html#tests=[[230,132,35]] 06:39:01 INFO - 2015-12-05 06:39:01,291 INFO : javascript benchmark 06:39:01 INFO - 2015-12-05 06:39:01,294 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2628.342914271432, 2708.498927698376, 2713.674359076911, 2726.0, 2742.232174991002, 4500.72995620263, 4649.5118012608655, 4655.115528049677, 4738.668293219476, 4779.593734532569, 4587.082583483309, 4594.471635761888, 4676.97661511692, 4689.413823272091, 4704.9178688901575, 4222.261104306742, 4329.415528903605, 4358.694891357591, 4371.256886329315, 4431.313146462304, 4202.2856114460465, 4393.033532622818, 4396.164728701552, 4428.6014258716705, 4437.977810110961, 4234.597713217239, 4304.5910638489295, 4343.956560434387, 4355.281378572532, 4366.781660916973, 4345.521992580813, 4345.69580129391, 4362.21480133579, 4385.429894113745, 4392.648588112943, 4174.937375939363, 4325.416068830699, 4342.370356298319, 4344.978275108636, 4380.6057454829215, 4595.095302536259, 4634.050019745944, 4639.628829693616, 4738.47876733559, 4763.166445871993, 5109.156989096795, 5144.4083930348115, 5145.691258524463, 5156.123459011977, 5205.984832957575, 4873.049755297719, 5182.300389447414, 5186.247994040843, 5189.818356357547, 5199.766010529497, 4632.536746325374, 4635.7218566886095, 4643.303504474356, 4750.8337208197545, 4755.025219829927, 5197.272381866542, 5215.348081489814, 5219.347581552306, 5222.764975576109, 5227.111391063529, 4980.2778597103215, 5009.724465154379, 5012.04771093491, 5012.573931215888, 5060.569851562658, 4861.1006963711825, 4971.751412429437, 4974.850754477371, 4979.30289759434, 4981.850544483671, 4885.096257192431, 4924.630652701062, 4930.580900623487, 4954.851354459372, 4981.302617633534, 4894.486078961729, 5002.574781143643, 5002.724850133205, 5008.574271186917, 5009.44896061433, 4196.622303992655, 4224.514180869178, 4277.807498662568, 4282.614564689193, 4310.52584215736, 3686.8340924658455, 3745.2696724139078, 3762.736608437383, 3783.7162212833596, 3797.9240415191543, 4199.118185181146, 4294.57054294568, 4297.613214810682, 4343.652507799368, 4414.1171765647, 5097.057044446715, 5174.120399532088, 5181.145111056633, 5187.870303242449, 5195.064888320138, 4430.069685366109, 4436.82252709888, 4442.511323754385, 4463.218936686067, 4480.596746292849, 4310.0517886065645, 4382.0, 4382.802773875183, 4426.291793313055, 4566.26939689648, 4866.099771542276, 4900.950990490192, 4901.191303434894, 4923.0646177227645, 4927.482614325444, 5163.793448262028, 5182.274481572507, 5184.092783762751, 5190.97404512975, 5237.031149237403, 4646.976765116288, 4759.428868535798, 4899.240617704261, 4920.384951881015, 4964.67729597575, 4897.730624815669, 4957.677750946177, 4964.726940018189, 4986.975065124651, 5006.924896126488, 5143.819966301162, 5145.945081258258, 5152.716600587004, 5158.587313015025, 5197.870053248699, 4745.217039188633, 4871.147549178951, 4958.42978057528, 4976.552110310089, 4998.0, 4875.731834749123, 4877.317175595348, 4942.357493525818, 4960.255961605643, 4978.929530151035, 4887.780049897834, 4895.828645997373, 4902.338184345211, 4919.0407870464915, 4957.851264462072, 4753.382060332135, 4865.878353041202, 5039.0, 5039.244113383022, 5057.064443078042, 4753.595944344769, 4762.4285085789925, 4824.059308434821, 4826.782794774173, 4878.609711223165], "unit": "ms", "name": "dojo.html", "value": 4647.463980240899}, {"lowerIsBetter": false, "replicates": [553.6318348298382, 573.498189084551, 575.8597976007508, 584.6462889951581, 586.0652259645866, 27970.86014569927, 36792.816035919815, 37552.0, 37568.624313756925, 37584.248315033685, 40182.799086004605, 40912.38631420531, 40951.0, 40963.38554921671, 40975.795121024355, 6969.581825090486, 7067.752628657998, 7748.380129589634, 7915.762527124196, 7937.087234967995, 9825.606975720963, 9995.300328976975, 9998.700038998843, 10002.249831262649, 10004.94997525015, 9647.855282170773, 9672.322937394385, 9737.51312434379, 9753.463559504224, 9763.755906102333, 9932.553035113437, 10060.195184385231, 10061.044200800949, 10062.89937100627, 10069.0, 9705.805883882284, 9845.950770246103, 9852.80294394108, 9855.507224638812, 9857.654982075594, 37444.0, 37625.24749505022, 37705.81147094275, 37867.81066094652, 37877.81061094705, 2711.457708458316, 2770.0858716623466, 3127.2650927032355, 3195.4407978603886, 3343.130785995634, 26704.732952670613, 27075.45849083027, 27277.454450911067, 27518.0, 27744.861275693493, 3161.873525058995, 3198.792078514889, 3216.788802140524, 3221.855016524262, 3235.110344655215, 221800.0, 222166.0, 222707.0, 224820.99999999837, 224857.0, 48600.7569962155, 49704.75147624239, 52108.21837672438, 56767.99999999917, 58072.0, 54655.18017229745, 54937.725311373986, 54993.45006549963, 55053.44946550563, 55070.44929550734, 13013.414396352187, 13224.0, 13307.401166947511, 13342.533011344556, 13347.265900375378, 8303.95848020756, 8630.0, 9762.609495620238, 9785.315027948118, 9880.654177103766, 17809.0, 17848.821511784718, 17855.107244637715, 17970.55073623144, 18016.90991545034, 7243.927560724325, 7508.511946723445, 7559.28186822251, 7702.691892324245, 7731.3041826234785, 885.2121611765534, 913.2921985461188, 962.4177372689562, 983.9311248212556, 999.3104757717152, 26216.34459138537, 26296.47407051848, 26512.734872651414, 26601.068962586218, 26617.0, 938.061938061938, 964.4888209249109, 990.5047476261869, 1021.8211812932856, 1052.3002203534563, 13996.370163342674, 14055.43778248879, 14529.491467798576, 14781.482648107265, 14823.258837058103, 209691.0, 212296.0, 213496.0, 213537.0, 213976.0, 41543.37684934728, 42521.57478425238, 42704.0, 42734.57265427306, 42751.0, 1173.5305877648839, 1199.5501686867424, 1208.8670246272902, 1211.8364020857248, 1228.8709685482895, 25496.23511294664, 26252.474950501266, 26871.0, 27257.0, 27314.453710926067, 37388.765572819284, 37968.0, 38734.806325969315, 39553.802230989815, 40192.79903600463, 239947.0, 245114.0, 245290.0, 247461.5419226812, 250396.0, 25864.612030819928, 26543.469130617665, 26828.195154145407, 26990.865045674647, 27038.188854334403, 29961.234971172064, 30402.391952161277, 31739.206519836265, 34519.0, 41445.378319325835, 32058.519122213653, 32173.0, 32915.177120572174, 33323.50014749829, 33366.83316583402, 32592.674073258964, 32691.0, 32753.0, 32862.34275314432, 32909.341813163126, 32520.186995325304, 32891.50662740109, 33132.66867331392, 33138.0, 33209.16977075592, 28788.280292992844, 29506.852465737535, 29778.255543610718, 29975.452086572885, 30142.54786178165, 22595.88702056479, 22943.084635800624, 23114.0, 23217.0, 23375.41561460977], "unit": "ms", "name": "ext.html", "value": 16835.59879969196}, {"lowerIsBetter": false, "replicates": [315.7552896505208, 319.2418007232822, 327.3518433501667, 327.9409706252875, 330.0214862931408, 12927.547535836247, 13389.531366402178, 14635.780463293046, 15106.395744170233, 15317.310721017568, 12749.936250318735, 14531.346089425975, 14933.431989641094, 15516.224188790571, 15518.146501942389, 4796.760161991904, 4829.68607040543, 4929.4824043475455, 4979.526944940225, 4984.725840078794, 3510.210202704384, 3605.945910811327, 4918.508149185089, 4965.255211718235, 5346.0, 5378.0, 5378.838634840961, 5429.755660995245, 5530.115181570949, 5542.0301447246575, 5002.324686167357, 5400.324959380077, 5627.465390787889, 5639.379668236491, 5660.377358490563, 4985.302057711923, 4985.725785081819, 5021.196608542616, 5033.874153146201, 5039.168537191359, 18407.63184736311, 19366.612667746565, 19371.225150993945, 19397.709034364496, 20431.591368172703, 1770.3272756352503, 1777.4223377402395, 1819.7088465845402, 1866.1727482863473, 1899.7815251246145, 12250.75498490034, 12602.74794504114, 12677.429515671816, 12776.466823981089, 12982.350882455934, 1580.1230317173963, 1650.9257083431276, 1707.7182264926396, 1731.6709825133184, 1777.2002598830577, 52541.73729131368, 55181.448185518035, 56586.15120773192, 59876.0, 61256.0, 14667.612727854183, 15382.769258461132, 15500.30248638814, 15541.222938853012, 15813.1302778346, 23242.53514929726, 23364.0, 23381.7661823383, 23394.64908026381, 23442.0, 7756.185600511978, 7885.250901164381, 7993.360531157494, 8025.317847982987, 8066.637001334954, 6528.902066469007, 6538.901916471256, 6562.146920900253, 6613.603183808987, 6624.436922861611, 7439.218882017419, 7602.7339043133225, 7674.618568657584, 7694.807629809299, 7727.768166955, 1700.6513664698707, 1719.4239929623466, 1735.973960390595, 2141.466580142777, 2948.3170315013235, 863.7883718489011, 930.1349744737324, 932.7341707613433, 947.3699989507038, 994.5474808961905, 15216.315265813066, 15290.159041252615, 15773.526794195963, 16089.115098669452, 16344.509664710078, 838.1953324808252, 841.1924552429614, 865.299107722734, 866.8049688819965, 866.8873046504041, 7456.0, 8193.8361232775, 8288.295494882881, 8383.371247156365, 8574.09971952936, 477568.0, 488870.0, 495217.0, 510244.0, 512401.0, 67661.66169169123, 71675.64162179155, 72172.63913680502, 72349.63825180946, 73094.26905730981, 1096.1942971915635, 1098.9780204395868, 1099.2525082943675, 1105.6240878101323, 1113.9443027848574, 14435.133891966516, 14543.490977815725, 14746.778798318248, 14749.705005900036, 14773.778393324324, 29425.705742942297, 30063.0, 30171.245718857204, 30394.696053039188, 30983.845080774452, 34408.48387274143, 35311.470327945615, 35852.28295434129, 36294.0, 36429.45355819612, 8299.502029878227, 8762.386632935633, 8916.19754222123, 8929.776755581162, 8934.0, 15926.68146637084, 16011.0, 16114.0, 16310.673786524441, 16412.917935410245, 12615.873841261837, 13360.331983400985, 13456.0, 13481.0, 13592.660183495096, 12572.497100115894, 12808.6797830055, 13254.53609123676, 13352.666183345495, 13386.129901556367, 13079.0, 13312.334383280991, 13376.933115334361, 13664.453421863014, 13728.519501817389, 8545.145485451654, 8686.47881127109, 8715.912840871764, 8753.255973242345, 8921.509316987369, 10093.949530252596, 12851.421686024338, 12893.0, 13073.215607063607, 13322.467101315839], "unit": "ms", "name": "jquery.html", "value": 8693.331518418892}, {"lowerIsBetter": false, "replicates": [1470.9117452952817, 1628.641698826258, 1684.4020372767668, 1718.312674930028, 1722.3455087066914, 5976.850578735533, 6404.839879003027, 6941.895871561931, 7561.924380756191, 7585.9241407585905, 6271.937280627192, 7101.5739055656695, 7107.111611048619, 7250.746223882165, 7300.087489063867, 1975.506123469129, 2023.8178563929243, 2024.3724445421892, 2026.1692705990547, 2029.2187507809526, 1715.8970461772333, 1748.6764948484508, 2022.251766846269, 2052.1586149678633, 2076.169532187122, 2064.256867527689, 2071.9378418647466, 2074.1703318672503, 2074.4502706782714, 2077.480629842539, 1996.950076248091, 1999.730036445076, 2053.240301088592, 2058.7014882842054, 2059.7116403703494, 2048.4059622709397, 2060.206820374152, 2088.1229883448987, 2098.643230650793, 2100.4433825036376, 7279.0, 7367.594782286972, 7391.963040184818, 7393.260673932564, 7404.333609975128, 4153.54311025787, 4154.0, 4163.375493675942, 4219.599138081878, 4251.851185208534, 2539.263613552068, 2549.3754030262703, 2576.9871150644312, 2580.6000069988995, 2603.1799983005294, 827.5407149032285, 829.2785276809154, 1557.7196104701263, 1571.1751330551438, 1621.9756703649455, 9817.410955342631, 9897.75255618608, 9936.354136981145, 9944.651937182163, 9998.0, 3690.409534474525, 3695.4087346024507, 3745.8127093645753, 3765.981170094132, 3769.6418840210135, 8075.757727268191, 8077.474964127313, 8082.515049097073, 8084.595770211466, 8103.837923241502, 4221.240176768211, 4257.297545904953, 4259.169461954951, 4259.914801703949, 4261.316779871933, 3861.9613803861603, 3888.7666739995125, 3890.7081968851885, 3895.6883449323986, 3895.7533589251734, 3247.3018301064913, 3251.6260630027377, 3257.413665540178, 3281.409346317686, 3283.3925723741186, 838.0404436919814, 856.1652388920877, 858.7123313689984, 962.6341990043738, 981.9705408837747, 923.690563661181, 939.915407613318, 941.1576638908139, 976.6923419122953, 1232.7534493101416, 6630.270670226271, 6708.932910670928, 6712.328767123347, 6717.126773519509, 6721.0, 528.8810017746054, 532.3133158225845, 534.1666999480823, 536.7987004873172, 706.1878839334703, 5372.409035006146, 5407.70257635826, 5463.235147079412, 5475.945240547543, 5481.780728770805, 8547.829043419097, 8778.780530486789, 8884.955575222082, 8887.422317549339, 8905.198532132139, 8721.127887211229, 8785.253253473526, 8814.382993190415, 8882.911170888208, 8903.643854245887, 6738.831529211809, 6778.356056174655, 6903.1716194057035, 6969.581825090409, 6977.267386924402, 6755.763548275787, 6850.623215722983, 6888.345607167311, 6888.862222755417, 6893.827654308482, 7705.845883082419, 7764.767056988074, 7863.174366691415, 7896.6575682133025, 7931.286184243446, 7982.640781164978, 8141.3893957952205, 8141.79645508867, 8142.389320801082, 8150.184981501802, 5995.700214989321, 6198.535109866688, 6222.439980401786, 6233.2208473940755, 6240.625562466266, 6843.7604683835825, 6883.346082122191, 6886.622675464827, 6888.690008949709, 6912.861742765217, 5097.898042039213, 6409.2949775525585, 6520.673966301761, 6672.299408562031, 6701.061851340914, 5837.8540536485225, 6292.056191571301, 6371.044343348535, 6555.2133743951035, 6681.799546013627, 6013.248343957005, 6149.20060392164, 6271.4669253114, 6278.277998030102, 6330.8100756977365, 5764.913526297025, 5966.433188847052, 5974.9402505974385, 5987.850303742442, 6001.279846418458, 6012.368701286302, 6043.758249669964, 6045.969770151121, 6050.6369617823075, 6051.7579296827635], "unit": "ms", "name": "mootools.html", "value": 4048.3634496677637}, {"lowerIsBetter": false, "replicates": [279.5904000639064, 283.20984453375087, 289.6509705804506, 289.6856910252376, 291.82782158526464, 5225.137852254383, 5382.650127741699, 5420.620556561037, 5422.48486393792, 5488.396276409591, 5331.546818520431, 5388.245645609618, 5398.109311963531, 5399.514043736063, 5408.242846001563, 4061.1877624475073, 4077.4699289092378, 4078.5921407859123, 4078.632923036926, 4086.366613174963, 3831.406132049523, 3935.606439356056, 3997.2605068062503, 4077.531083925357, 4098.4876890388705, 4011.83952641894, 4021.034951611621, 4022.3765316376007, 4031.0, 4039.4950631171105, 3828.7319887607878, 3933.252681990413, 4052.2503336882623, 4080.469538959946, 4086.2849001424634, 3387.6104248011547, 3448.77582957107, 3451.2924850405607, 3461.2904354607244, 3465.826708664582, 5096.337476128117, 5097.3118628984985, 5100.821471248526, 5105.33630628016, 5107.080725469414, 4594.218982772936, 4603.263477843562, 4603.5166307537565, 4604.171249175147, 4607.17070927233, 5356.651817631841, 5534.225208470817, 5541.0580201365865, 5543.556515478793, 5547.223388725582, 3743.1952130292116, 3749.2876353492748, 3763.07804587875, 3765.265773174232, 3770.359038963383, 5801.535877129862, 5886.70566471679, 5891.440313170242, 5900.704964751745, 5902.291724993029, 3892.649661530476, 3915.7650540967634, 3916.8433262669173, 3917.040325120364, 3920.5687374389363, 3964.7621142731527, 3980.6616437602547, 3981.303271927401, 3982.920341593152, 3987.342088555356, 4517.751523666164, 4601.654875884322, 4634.791434385461, 4642.257238841837, 4643.8374656886845, 5662.37713851476, 5670.0, 5671.461211184931, 5674.06377947634, 5684.175794509855, 1370.595674276091, 1385.2450414524108, 1386.473140206715, 1388.2503448137893, 1388.965275868091, 899.5637115998735, 902.9864552031725, 912.8037471943564, 914.07221670005, 917.9127982841619, 4974.9751251243515, 4985.077760614298, 4986.202207646759, 4988.301637770715, 4989.276554899519, 5867.061270196748, 5867.589268751231, 5869.20765696634, 5869.266341707286, 5871.823845284648, 4925.113479573711, 4947.356843610308, 4973.801047958041, 4974.1543937530705, 4978.079055374767, 3036.225762430566, 3066.509358502629, 3131.3424180921807, 3164.5095010273444, 3169.6037995250595, 5441.863953401196, 5526.557875369961, 5552.056150454352, 5607.130894711327, 5616.241807356037, 6005.279366476051, 6036.366181550961, 6039.275286965592, 6044.969775151096, 6051.273847138372, 5592.384837667853, 5594.748236329375, 5599.804006859903, 5600.831975040755, 5601.551875849922, 5696.971515142398, 5879.853003674943, 5890.263717035371, 5894.0, 5901.173835662925, 5777.046787280052, 5791.102379131242, 5797.507211886868, 5798.246227990334, 5802.071668533014, 5596.580256480862, 5608.355039170548, 5618.69097199658, 5626.718664066862, 5644.774209031592, 3939.4287828265315, 4026.6376026156613, 4068.14568940514, 4070.4301397804925, 4070.61329173728, 5798.15926690619, 5801.245838041028, 5843.065109582446, 5877.588568800143, 5883.55873309512, 5625.0, 5655.632383895034, 5662.5469962402085, 5662.546996240373, 5666.490015898589, 5652.4064973178865, 5653.519450846559, 5659.0, 5659.801906933402, 5665.943340566541, 5406.162044883049, 5500.669959802424, 5522.30971128609, 5523.143912693539, 5530.391656917816, 5699.715014249354, 5707.372189059117, 5708.771649133988, 5709.885802283848, 5712.11462223356, 5506.91739623898, 5509.228707980806, 5509.283793106871, 5531.446855314436, 5534.750936207961], "unit": "ms", "name": "prototype.html", "value": 4180.598874969871}, {"lowerIsBetter": false, "replicates": [700.0865163734725, 723.7105157936825, 741.6069483173917, 752.9849403011937, 774.6243072110029, 11207.775844483105, 11579.36313502757, 11605.6518304451, 11627.534898604057, 12241.204321719082, 12750.617481475547, 12911.677208069803, 12944.352782360891, 12961.870381296185, 12998.54505092322, 632.7279269913935, 639.2073828452732, 790.3084800799286, 809.5992483720566, 821.9301359384459, 813.877918312252, 814.1451475950258, 818.5907046476761, 819.5697258939075, 820.3683163963744, 658.4666420199629, 843.9113893041234, 851.4848516647432, 851.7998270406449, 852.6887685994599, 663.0319733189525, 822.3298012120133, 841.1798496465897, 841.6002398860553, 843.9282660973824, 626.042155502078, 628.0955424189153, 629.8645791154878, 630.7697690342992, 630.8202162383699, 11716.882831171664, 12157.452914618863, 12175.45210465531, 12179.269243845398, 12195.512179512809, 11217.15871309655, 11393.259438136494, 11466.885331146665, 11811.586594469238, 12053.096017798613, 9288.814223715488, 9318.673846415411, 9481.0, 9481.857772133355, 9498.525073746285, 3201.9679803201902, 3223.323102148528, 3250.3174333390016, 3258.771885967983, 3320.9501857472155, 38256.61743382558, 43821.561784382066, 44318.11363772707, 44327.335089973676, 44406.55593444056, 9061.093890611019, 9117.863232051524, 9133.360664753403, 9166.26669866409, 9218.21645160169, 16377.918110409371, 16638.3344666212, 16660.58348541272, 16672.74990875138, 16675.832141821487, 6249.156363890907, 6352.523560732963, 6371.617702937839, 6411.807645770635, 6495.447886929569, 3377.341418423384, 3695.9651297636706, 3755.4366844972924, 3760.4359346098304, 3828.3874580067054, 2642.2205449392477, 2681.986590067037, 2689.1125928443566, 2692.4480481501246, 2867.4551835151256, 498.4741098141423, 498.49402856101085, 505.1336957118559, 510.20917577754335, 510.3671447405265, 438.2855944810003, 467.3760529692898, 470.30864628995323, 533.1765362460395, 584.3163498706524, 7583.78041172801, 7584.469087163846, 7657.0, 7773.339266162327, 7780.610969451618, 431.61586188292443, 431.7495852405597, 433.7462584388105, 518.3261759712434, 553.4880235781885, 3347.598288205431, 3368.3094965532496, 3458.775179613317, 3481.7736847104857, 3555.484454754046, 48818.75590622024, 49970.75014624903, 50690.74654626777, 50742.74628626907, 50914.490855090975, 42229.366559501635, 43267.13465730668, 43372.783136084116, 43666.56333436688, 44232.3365149523, 38172.61827381746, 38704.806475968006, 38834.146146466286, 39707.0, 40347.79826100851, 7482.326590606872, 7745.419093567893, 7915.722949696733, 8045.718399855977, 8055.436119471581, 29212.56181157327, 29462.937594368188, 29607.55588666129, 29826.552601711424, 30915.381692366478, 37596.0, 37693.81153094217, 38122.0, 39342.803285983384, 39795.204095918496, 9465.716028519155, 9837.311388202757, 10155.593776248867, 10244.64143754965, 10527.526261318106, 10521.263511554118, 10608.575656973635, 10702.411367374869, 11400.258983166068, 11404.885951140383, 9698.903010970082, 10041.74895627586, 10136.797264054825, 10376.377417354983, 10989.945050274697, 10735.302205356627, 10743.623973161215, 10822.621208257673, 11015.339079655247, 11185.608503702331, 8717.564121794012, 9504.667336643184, 9713.805723885624, 9943.403395796275, 10499.317544359592, 8629.784255393666, 8644.654213831627, 8856.114388561093, 8890.64437422496, 9305.86041209396, 8127.512349259064, 8526.27526660216, 8710.869336959824, 8809.07504711996, 9240.306976976888], "unit": "ms", "name": "yui.html", "value": 5637.753416526952}], "name": "dromaeo_css", "value": 6339.429971154719}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 105.0, 110.0, 110.0, 112.0, 101.0, 111.0, 109.0, 101.0], "unit": "ms", "name": "ai-astar", "value": 108.0}, {"lowerIsBetter": true, "replicates": [154.0, 130.0, 153.0, 176.0, 138.0, 159.0, 151.0, 145.0, 174.0, 138.0], "unit": "ms", "name": "audio-beat-detection", "value": 151.8}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 160.0, 161.0, 163.0, 162.0, 162.0, 161.0, 161.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 80.0, 92.0, 74.0, 72.0, 72.0, 107.0, 93.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 80.6}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 134.0, 94.0, 95.0, 95.0, 136.0, 95.0, 94.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 106.6}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 148.0, 146.0, 148.0, 146.0, 147.0, 148.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 96.0, 95.0, 96.0, 96.0, 97.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 71.0, 70.0, 70.0, 69.0, 71.0, 80.0, 69.0, 70.0], "unit": "ms", "name": "json-parse-financial", "value": 70.9}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 69.0, 69.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 83.0, 93.0, 85.0, 85.0, 87.0, 86.0, 85.0, 92.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.0}, {"lowerIsBetter": true, "replicates": [117.0, 130.0, 127.0, 128.0, 124.0, 128.0, 127.0, 125.0, 144.0, 127.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 127.7}, {"lowerIsBetter": true, "replicates": [132.0, 146.0, 150.0, 145.0, 151.0, 134.0, 143.0, 150.0, 146.0, 137.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.4}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 68.0, 69.0, 69.0, 68.0, 69.0, 67.0, 68.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.5}], "name": "kraken", "value": 1525.8000000000004}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [172.68174753928508], "unit": "score", "name": "Richards", "value": 204.43388200000004}, {"lowerIsBetter": false, "replicates": [186.25442354255912], "unit": "score", "name": "DeltaBlue", "value": 354.98754199999996}, {"lowerIsBetter": false, "replicates": [278.00945232137894], "unit": "score", "name": "Encrypt", "value": 957.4530570000002}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [2018.1451612903227], "unit": "score", "name": "RayTrace", "value": 366.667876123876}, {"lowerIsBetter": false, "replicates": [781.8608287724785], "unit": "score", "name": "Earley", "value": 852.4061770000001}, {"lowerIsBetter": false, "replicates": [12048.192771084337], "unit": "score", "name": "Boyer", "value": 55.31642899999996}, {"lowerIsBetter": false, "replicates": [26394.736842105263], "unit": "score", "name": "RegExp", "value": 34.51388833499503}, {"lowerIsBetter": false, "replicates": [603.1175059952038], "unit": "score", "name": "Splay", "value": 135.1162902584493}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 19774.943199903224}]} 06:39:01 INFO - RETURN: dromaeo_css: 6339.43 06:39:01 INFO - RETURN: kraken: 1525.80 06:39:01 INFO - RETURN: v8_7: 19774.94 06:39:01 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19774.94"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1525.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6339.43"}}} 06:39:01 INFO - Return code: 0 06:39:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:39:01 INFO - # TBPL SUCCESS # 06:39:01 INFO - Running post-action listener: _resource_record_post_action 06:39:01 INFO - Running post-run listener: _resource_record_post_run 06:39:02 INFO - Total resource usage - Wall time: 1238s; CPU: 13.0%; Read bytes: 10657792; Write bytes: 409034752; Read time: 3976; Write time: 324624 06:39:02 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 11558912; Read time: 0; Write time: 2096 06:39:02 INFO - run-tests - Wall time: 1224s; CPU: 13.0%; Read bytes: 8896512; Write bytes: 397475840; Read time: 3920; Write time: 322528 06:39:02 INFO - Running post-run listener: _upload_blobber_files 06:39:02 INFO - Blob upload gear active. 06:39:02 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 06:39:02 INFO - Copying logs to upload dir... 06:39:02 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1279.001457 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2015-12-05 06:39:02.514284) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-05 06:39:02.519901) ========= 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=5752742a61d0f534093fa7a9000001cb-1449324501.32155-1669891038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/y70DRBpJRk-EjNPBEYg8PQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.008813 build_url: 'https://queue.taskcluster.net/v1/task/y70DRBpJRk-EjNPBEYg8PQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.09 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-05 06:39:02.622215) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 06:39:02.622555) ========= 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=5752742a61d0f534093fa7a9000001cb-1449324501.32155-1669891038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004530 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 06:39:02.672334) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-05 06:39:02.672655) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-05 06:39:02.672963) ========= ========= Total master_lag: 0.29 =========