builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-036 starttime: 1450162357.71 results: success (0) buildid: 20151214222411 builduid: 44cd65127b4e4fa2822d3b573c791482 revision: efbbf72b9d0a2c54f5fa08a01b6a5d4df8e0f738 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-14 22:52:37.713490) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-14 22:52:37.713962) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-14 22:52:37.714281) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1450152327.723067-1415303169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006438 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-14 22:52:37.776259) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-14 22:52:37.776609) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-14 22:52:37.828944) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 22:52:37.829216) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1450152327.723067-1415303169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004565 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 22:52:37.887100) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-14 22:52:37.887435) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-14 22:52:37.887884) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 22:52:37.888256) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1450152327.723067-1415303169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-14 22:52:38-- 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% 221M=0s 2015-12-14 22:52:38 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.304930 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 22:52:38.207615) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 22:52:38.207937) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1450152327.723067-1415303169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019668 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 22:52:38.258281) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 22:52:38.258789) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev efbbf72b9d0a2c54f5fa08a01b6a5d4df8e0f738 --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 efbbf72b9d0a2c54f5fa08a01b6a5d4df8e0f738 --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=9c54e757a4c805d85fea3bc7000001f2-1450152327.723067-1415303169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-14 22:52:38,752 truncating revision to first 12 chars 2015-12-14 22:52:38,752 Setting DEBUG logging. 2015-12-14 22:52:38,752 attempt 1/10 2015-12-14 22:52:38,752 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/efbbf72b9d0a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-14 22:52:38,998 unpacking tar archive at: fx-team-efbbf72b9d0a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.888800 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 22:52:39.162356) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-14 22:52:39.162670) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-14 22:52:39.173498) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-14 22:52:39.173807) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-14 22:52:39.174310) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2015-12-14 22:52:39.174616) ========= /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=9c54e757a4c805d85fea3bc7000001f2-1450152327.723067-1415303169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:52:39 INFO - MultiFileLogger online at 20151214 22:52:39 in /builds/slave/test 22:52:39 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 22:52:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:52:39 INFO - {'append_to_log': False, 22:52:39 INFO - 'base_work_dir': '/builds/slave/test', 22:52:39 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:52:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:52:39 INFO - 'branch': 'Fx-Team-Non-PGO', 22:52:39 INFO - 'buildbot_json_path': 'buildprops.json', 22:52:39 INFO - 'config_files': ('talos/linux_config.py',), 22:52:39 INFO - 'default_actions': ('clobber', 22:52:39 INFO - 'read-buildbot-config', 22:52:39 INFO - 'download-and-extract', 22:52:39 INFO - 'populate-webroot', 22:52:39 INFO - 'create-virtualenv', 22:52:39 INFO - 'install', 22:52:39 INFO - 'run-tests'), 22:52:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:52:39 INFO - 'download_minidump_stackwalk': True, 22:52:39 INFO - 'download_symbols': 'ondemand', 22:52:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:52:39 INFO - 'tooltool.py': '/tools/tooltool.py', 22:52:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:52:39 INFO - '/tools/misc-python/virtualenv.py')}, 22:52:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:52:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:52:39 INFO - 'installer_path': 'installer.exe', 22:52:39 INFO - 'log_level': 'info', 22:52:39 INFO - 'log_name': 'talos', 22:52:39 INFO - 'log_to_console': True, 22:52:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:52:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:52:39 INFO - 'opt_config_files': (), 22:52:39 INFO - 'pip_index': False, 22:52:39 INFO - 'sps_profile': False, 22:52:39 INFO - 'sps_profile_interval': 0, 22:52:39 INFO - 'suite': 'dromaeojs', 22:52:39 INFO - 'system_bits': '64', 22:52:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:52:39 INFO - 'title': 'talos-linux64-ix-036', 22:52:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:52:39 INFO - 'use_talos_json': True, 22:52:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:52:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:52:39 INFO - 'work_dir': 'build'} 22:52:39 INFO - ##### 22:52:39 INFO - ##### Running clobber step. 22:52:39 INFO - ##### 22:52:39 INFO - Running pre-action listener: _resource_record_pre_action 22:52:39 INFO - Running main action method: clobber 22:52:39 INFO - rmtree: /builds/slave/test/build 22:52:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:52:40 INFO - Running post-action listener: _resource_record_post_action 22:52:40 INFO - ##### 22:52:40 INFO - ##### Running read-buildbot-config step. 22:52:40 INFO - ##### 22:52:40 INFO - Running pre-action listener: _resource_record_pre_action 22:52:40 INFO - Running main action method: read_buildbot_config 22:52:40 INFO - Using buildbot properties: 22:52:40 INFO - { 22:52:40 INFO - "properties": { 22:52:40 INFO - "buildnumber": 2211, 22:52:40 INFO - "product": "firefox", 22:52:40 INFO - "script_repo_revision": "production", 22:52:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:52:40 INFO - "repository": "", 22:52:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 22:52:40 INFO - "buildid": "20151214222411", 22:52:40 INFO - "slavename": "talos-linux64-ix-036", 22:52:40 INFO - "pgo_build": "False", 22:52:40 INFO - "basedir": "/builds/slave/test", 22:52:40 INFO - "project": "", 22:52:40 INFO - "platform": "ubuntu64_hw", 22:52:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:52:40 INFO - "slavebuilddir": "test", 22:52:40 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:52:40 INFO - "branch": "fx-team", 22:52:40 INFO - "repo_path": "integration/fx-team", 22:52:40 INFO - "stage_platform": "linux64", 22:52:40 INFO - "builduid": "44cd65127b4e4fa2822d3b573c791482", 22:52:40 INFO - "revision": "efbbf72b9d0a2c54f5fa08a01b6a5d4df8e0f738" 22:52:40 INFO - }, 22:52:40 INFO - "sourcestamp": { 22:52:40 INFO - "repository": "", 22:52:40 INFO - "hasPatch": false, 22:52:40 INFO - "project": "", 22:52:40 INFO - "branch": "fx-team-linux64-talos", 22:52:40 INFO - "changes": [ 22:52:40 INFO - { 22:52:40 INFO - "category": null, 22:52:40 INFO - "files": [ 22:52:40 INFO - { 22:52:40 INFO - "url": null, 22:52:40 INFO - "name": "https://queue.taskcluster.net/v1/task/2FdolsOWTOuZotw1PDf0cA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 22:52:40 INFO - } 22:52:40 INFO - ], 22:52:40 INFO - "repository": "", 22:52:40 INFO - "rev": "efbbf72b9d0a2c54f5fa08a01b6a5d4df8e0f738", 22:52:40 INFO - "who": "philringnalda@gmail.com", 22:52:40 INFO - "when": 1450162347, 22:52:40 INFO - "number": 7361076, 22:52:40 INFO - "comments": "Merge m-c to f-t", 22:52:40 INFO - "project": "", 22:52:40 INFO - "at": "Mon 14 Dec 2015 22:52:27", 22:52:40 INFO - "branch": "fx-team-linux64-talos", 22:52:40 INFO - "revlink": "", 22:52:40 INFO - "properties": [ 22:52:40 INFO - [ 22:52:40 INFO - "buildid", 22:52:40 INFO - "20151214222411", 22:52:40 INFO - "Change" 22:52:40 INFO - ], 22:52:40 INFO - [ 22:52:40 INFO - "builduid", 22:52:40 INFO - "44cd65127b4e4fa2822d3b573c791482", 22:52:40 INFO - "Change" 22:52:40 INFO - ], 22:52:40 INFO - [ 22:52:40 INFO - "pgo_build", 22:52:40 INFO - "False", 22:52:40 INFO - "Change" 22:52:40 INFO - ] 22:52:40 INFO - ], 22:52:40 INFO - "revision": "efbbf72b9d0a2c54f5fa08a01b6a5d4df8e0f738" 22:52:40 INFO - } 22:52:40 INFO - ], 22:52:40 INFO - "revision": "efbbf72b9d0a2c54f5fa08a01b6a5d4df8e0f738" 22:52:40 INFO - } 22:52:40 INFO - } 22:52:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/2FdolsOWTOuZotw1PDf0cA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 22:52:40 INFO - Running post-action listener: _resource_record_post_action 22:52:40 INFO - ##### 22:52:40 INFO - ##### Running download-and-extract step. 22:52:40 INFO - ##### 22:52:40 INFO - Running pre-action listener: _resource_record_pre_action 22:52:40 INFO - Running main action method: download_and_extract 22:52:40 INFO - mkdir: /builds/slave/test/build/tests 22:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:40 INFO - https://queue.taskcluster.net/v1/task/2FdolsOWTOuZotw1PDf0cA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:52:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2FdolsOWTOuZotw1PDf0cA/artifacts/public/build/test_packages.json 22:52:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2FdolsOWTOuZotw1PDf0cA/artifacts/public/build/test_packages.json 22:52:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2FdolsOWTOuZotw1PDf0cA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 22:52:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2FdolsOWTOuZotw1PDf0cA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 22:52:47 INFO - Downloaded 1302 bytes. 22:52:47 INFO - Reading from file /builds/slave/test/build/test_packages.json 22:52:47 INFO - Using the following test package requirements: 22:52:47 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:52:47 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:52:47 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:52:47 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:52:47 INFO - u'jsshell-linux-x86_64.zip'], 22:52:47 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:52:47 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:52:47 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:52:47 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:52:47 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:52:47 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:52:47 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:52:47 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:52:47 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:52:47 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:52:47 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:52:47 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:52:47 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:52:47 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')]} 22:52:47 INFO - https://queue.taskcluster.net/v1/task/2FdolsOWTOuZotw1PDf0cA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:52:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2FdolsOWTOuZotw1PDf0cA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:52:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2FdolsOWTOuZotw1PDf0cA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:52:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2FdolsOWTOuZotw1PDf0cA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:52:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2FdolsOWTOuZotw1PDf0cA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:52:53 INFO - Downloaded 21869884 bytes. 22:52:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 22:52:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:52:53 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:52:54 INFO - Return code: 0 22:52:54 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:52:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:54 INFO - https://queue.taskcluster.net/v1/task/2FdolsOWTOuZotw1PDf0cA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:52:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2FdolsOWTOuZotw1PDf0cA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:52:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2FdolsOWTOuZotw1PDf0cA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:52:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2FdolsOWTOuZotw1PDf0cA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:52:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2FdolsOWTOuZotw1PDf0cA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:53:00 INFO - Downloaded 21869884 bytes. 22:53:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 22:53:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:53:00 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:53:01 INFO - Return code: 0 22:53: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')]} 22:53:01 INFO - https://queue.taskcluster.net/v1/task/2FdolsOWTOuZotw1PDf0cA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:53:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2FdolsOWTOuZotw1PDf0cA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:53:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2FdolsOWTOuZotw1PDf0cA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:53:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2FdolsOWTOuZotw1PDf0cA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:53:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2FdolsOWTOuZotw1PDf0cA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:53:02 INFO - Downloaded 11132038 bytes. 22:53:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 22:53:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:53:02 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 22:53:02 INFO - Return code: 0 22:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:02 INFO - https://queue.taskcluster.net/v1/task/2FdolsOWTOuZotw1PDf0cA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:53:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2FdolsOWTOuZotw1PDf0cA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:53:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2FdolsOWTOuZotw1PDf0cA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:53:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2FdolsOWTOuZotw1PDf0cA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:53:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2FdolsOWTOuZotw1PDf0cA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:53:04 INFO - Downloaded 57741677 bytes. 22:53:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/2FdolsOWTOuZotw1PDf0cA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:53:04 INFO - mkdir: /builds/slave/test/properties 22:53:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:53:04 INFO - Writing to file /builds/slave/test/properties/build_url 22:53:04 INFO - Contents: 22:53:04 INFO - build_url:https://queue.taskcluster.net/v1/task/2FdolsOWTOuZotw1PDf0cA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:53:04 INFO - Running post-action listener: _resource_record_post_action 22:53:04 INFO - Running post-action listener: set_extra_try_arguments 22:53:04 INFO - ##### 22:53:04 INFO - ##### Running populate-webroot step. 22:53:04 INFO - ##### 22:53:04 INFO - Running pre-action listener: _resource_record_pre_action 22:53:04 INFO - Running main action method: populate_webroot 22:53:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:53:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:53:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:53:04 INFO - '--tppagecycles', 22:53:04 INFO - '7'], 22:53:04 INFO - 'tests': ['tsvgm']}}, 22:53:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:53:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:53:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:53:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:53:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:53:04 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:53:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:53:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:04 INFO - 'talos_options': ['--e10s'], 22:53:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:53:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:04 INFO - 'tests': ['damp', 'tps']}, 22:53:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:04 INFO - 'talos_options': ['--e10s'], 22:53:04 INFO - 'tests': ['damp', 'tps']}, 22:53:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:53:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:53:04 INFO - 'other': {'tests': ['a11yr', 22:53:04 INFO - 'ts_paint', 22:53:04 INFO - 'tpaint', 22:53:04 INFO - 'sessionrestore', 22:53:04 INFO - 'sessionrestore_no_auto_restore']}, 22:53:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:53:04 INFO - 'tests': ['a11yr', 22:53:04 INFO - 'ts_paint', 22:53:04 INFO - 'tpaint', 22:53:04 INFO - 'sessionrestore', 22:53:04 INFO - 'sessionrestore_no_auto_restore']}, 22:53:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:53:04 INFO - 'tests': ['a11yr', 22:53:04 INFO - 'ts_paint', 22:53:04 INFO - 'tpaint', 22:53:04 INFO - 'sessionrestore', 22:53:04 INFO - 'sessionrestore_no_auto_restore']}, 22:53:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:53:04 INFO - 'tests': ['a11yr', 22:53:04 INFO - 'ts_paint', 22:53:04 INFO - 'tpaint', 22:53:04 INFO - 'sessionrestore', 22:53:04 INFO - 'sessionrestore_no_auto_restore']}, 22:53:04 INFO - 'other_l64': {'tests': ['a11yr', 22:53:04 INFO - 'ts_paint', 22:53:04 INFO - 'tpaint', 22:53:04 INFO - 'sessionrestore', 22:53:04 INFO - 'sessionrestore_no_auto_restore']}, 22:53:04 INFO - 'other_nol64': {'tests': ['a11yr', 22:53:04 INFO - 'ts_paint', 22:53:04 INFO - 'tpaint', 22:53:04 INFO - 'sessionrestore', 22:53:04 INFO - 'sessionrestore_no_auto_restore']}, 22:53:04 INFO - 'svgr': {'tests': ['tsvgx', 22:53:04 INFO - 'tsvgr_opacity', 22:53:04 INFO - 'tart', 22:53:04 INFO - 'tscrollx', 22:53:04 INFO - 'cart']}, 22:53:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:53:04 INFO - 'tests': ['tsvgx', 22:53:04 INFO - 'tsvgr_opacity', 22:53:04 INFO - 'tart', 22:53:04 INFO - 'tscrollx', 22:53:04 INFO - 'cart']}, 22:53:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:04 INFO - 'tests': ['tp5o']}, 22:53:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:04 INFO - 'talos_options': ['--e10s'], 22:53:04 INFO - 'tests': ['tp5o']}, 22:53:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:04 INFO - 'talos_options': ['--xperf_path', 22:53:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:53:04 INFO - 'tests': ['tp5n']}, 22:53:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:04 INFO - 'talos_options': ['--e10s', 22:53:04 INFO - '--xperf_path', 22:53:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:53:04 INFO - 'tests': ['tp5n']}}, 22:53:04 INFO - 'talos.zip': {'path': '', 22:53:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:53:04 INFO - Running post-action listener: _resource_record_post_action 22:53:04 INFO - ##### 22:53:04 INFO - ##### Running create-virtualenv step. 22:53:04 INFO - ##### 22:53:04 INFO - Running pre-action listener: _resource_record_pre_action 22:53:04 INFO - Running main action method: create_virtualenv 22:53:04 INFO - Creating virtualenv /builds/slave/test/build/venv 22:53:04 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 22:53:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:53:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:53:04 INFO - Using real prefix '/usr' 22:53:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:53:04 INFO - Installing distribute.............................................................................................................................................................................................done. 22:53:06 INFO - Installing pip.................done. 22:53:06 INFO - Return code: 0 22:53:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:06 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 0x7ffdebfcaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e70b0>, '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 0x25e7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e8440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1450152327.723067-1415303169', '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 22:53:06 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 22:53:06 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 22:53:06 INFO - Using env: {'DISPLAY': ':0', 22:53:06 INFO - 'HOME': '/home/cltbld', 22:53:06 INFO - 'LANG': 'en_US.UTF-8', 22:53:06 INFO - 'LANGUAGE': 'en_US:en', 22:53:06 INFO - 'LOGNAME': 'cltbld', 22:53:06 INFO - 'MAIL': '/var/mail/cltbld', 22:53:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:06 INFO - 'MOZ_NO_REMOTE': '1', 22:53:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:06 INFO - 'NO_EM_RESTART': '1', 22:53:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:53:06 INFO - 'PWD': '/builds/slave/test', 22:53:06 INFO - 'SHELL': '/bin/bash', 22:53:06 INFO - 'SHLVL': '1', 22:53:06 INFO - 'TERM': 'linux', 22:53:06 INFO - 'TMOUT': '86400', 22:53:06 INFO - 'USER': 'cltbld', 22:53:06 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450152327.723067-1415303169', 22:53:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:06 INFO - '_': '/tools/buildbot/bin/python'} 22:53:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:07 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 22:53:07 INFO - Cleaning up... 22:53:07 INFO - Return code: 0 22:53:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:53: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')]} 22:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53: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')]} 22:53:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53: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', '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 0x7ffdebfcaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e70b0>, '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 0x25e7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e8440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1450152327.723067-1415303169', '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 22:53: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', 'psutil>=0.7.1'] in /builds/slave/test/build 22:53: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 psutil>=0.7.1 22:53:07 INFO - Using env: {'DISPLAY': ':0', 22:53:07 INFO - 'HOME': '/home/cltbld', 22:53:07 INFO - 'LANG': 'en_US.UTF-8', 22:53:07 INFO - 'LANGUAGE': 'en_US:en', 22:53:07 INFO - 'LOGNAME': 'cltbld', 22:53:07 INFO - 'MAIL': '/var/mail/cltbld', 22:53:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:07 INFO - 'MOZ_NO_REMOTE': '1', 22:53:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:07 INFO - 'NO_EM_RESTART': '1', 22:53:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:53:07 INFO - 'PWD': '/builds/slave/test', 22:53:07 INFO - 'SHELL': '/bin/bash', 22:53:07 INFO - 'SHLVL': '1', 22:53:07 INFO - 'TERM': 'linux', 22:53:07 INFO - 'TMOUT': '86400', 22:53:07 INFO - 'USER': 'cltbld', 22:53:07 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450152327.723067-1415303169', 22:53:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:07 INFO - '_': '/tools/buildbot/bin/python'} 22:53:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:07 INFO - Downloading/unpacking psutil>=0.7.1 22:53: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 22:53: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 22:53: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 22:53: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 22:53: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 22:53: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 22:53:08 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 22:53:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:53:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:53:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:53:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:53:09 INFO - Installing collected packages: psutil 22:53:09 INFO - Running setup.py install for psutil 22:53:09 INFO - building 'psutil._psutil_linux' extension 22:53:09 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 22:53:09 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 22:53:09 INFO - building 'psutil._psutil_posix' extension 22:53:09 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 22:53:09 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 22:53:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:53:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:53:09 INFO - Successfully installed psutil 22:53:09 INFO - Cleaning up... 22:53:09 INFO - Return code: 0 22:53:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:53:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffdebfcaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e70b0>, '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 0x25e7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e8440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1450152327.723067-1415303169', '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 22:53:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 22:53:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:53:09 INFO - Using env: {'DISPLAY': ':0', 22:53:09 INFO - 'HOME': '/home/cltbld', 22:53:09 INFO - 'LANG': 'en_US.UTF-8', 22:53:09 INFO - 'LANGUAGE': 'en_US:en', 22:53:09 INFO - 'LOGNAME': 'cltbld', 22:53:09 INFO - 'MAIL': '/var/mail/cltbld', 22:53:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:09 INFO - 'MOZ_NO_REMOTE': '1', 22:53:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:09 INFO - 'NO_EM_RESTART': '1', 22:53:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:53:09 INFO - 'PWD': '/builds/slave/test', 22:53:09 INFO - 'SHELL': '/bin/bash', 22:53:09 INFO - 'SHLVL': '1', 22:53:09 INFO - 'TERM': 'linux', 22:53:09 INFO - 'TMOUT': '86400', 22:53:09 INFO - 'USER': 'cltbld', 22:53:09 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450152327.723067-1415303169', 22:53:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:09 INFO - '_': '/tools/buildbot/bin/python'} 22:53:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:53: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 22:53: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 22:53: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 22:53: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 22:53: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 22:53: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 22:53:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:53:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:53:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:53:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:53:11 INFO - Installing collected packages: mozsystemmonitor 22:53:11 INFO - Running setup.py install for mozsystemmonitor 22:53:11 INFO - Successfully installed mozsystemmonitor 22:53:11 INFO - Cleaning up... 22:53:11 INFO - Return code: 0 22:53:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffdebfcaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e70b0>, '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 0x25e7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e8440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1450152327.723067-1415303169', '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 22:53:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:53:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:53:11 INFO - Using env: {'DISPLAY': ':0', 22:53:11 INFO - 'HOME': '/home/cltbld', 22:53:11 INFO - 'LANG': 'en_US.UTF-8', 22:53:11 INFO - 'LANGUAGE': 'en_US:en', 22:53:11 INFO - 'LOGNAME': 'cltbld', 22:53:11 INFO - 'MAIL': '/var/mail/cltbld', 22:53:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:11 INFO - 'MOZ_NO_REMOTE': '1', 22:53:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:11 INFO - 'NO_EM_RESTART': '1', 22:53:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:53:11 INFO - 'PWD': '/builds/slave/test', 22:53:11 INFO - 'SHELL': '/bin/bash', 22:53:11 INFO - 'SHLVL': '1', 22:53:11 INFO - 'TERM': 'linux', 22:53:11 INFO - 'TMOUT': '86400', 22:53:11 INFO - 'USER': 'cltbld', 22:53:11 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450152327.723067-1415303169', 22:53:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:11 INFO - '_': '/tools/buildbot/bin/python'} 22:53:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:11 INFO - Downloading/unpacking blobuploader==1.2.4 22:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:13 INFO - Downloading blobuploader-1.2.4.tar.gz 22:53:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:53:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:53:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:53:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:53:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:14 INFO - Downloading docopt-0.6.1.tar.gz 22:53:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:53:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:53:14 INFO - Installing collected packages: blobuploader, requests, docopt 22:53:14 INFO - Running setup.py install for blobuploader 22:53:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:53:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:53:14 INFO - Running setup.py install for requests 22:53:14 INFO - Running setup.py install for docopt 22:53:14 INFO - Successfully installed blobuploader requests docopt 22:53:14 INFO - Cleaning up... 22:53:14 INFO - Return code: 0 22:53:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:53:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:14 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 0x7ffdebfcaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e70b0>, '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 0x25e7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e8440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1450152327.723067-1415303169', '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 22:53:14 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 22:53:14 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 22:53:14 INFO - Using env: {'DISPLAY': ':0', 22:53:14 INFO - 'HOME': '/home/cltbld', 22:53:14 INFO - 'LANG': 'en_US.UTF-8', 22:53:14 INFO - 'LANGUAGE': 'en_US:en', 22:53:14 INFO - 'LOGNAME': 'cltbld', 22:53:14 INFO - 'MAIL': '/var/mail/cltbld', 22:53:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:14 INFO - 'MOZ_NO_REMOTE': '1', 22:53:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:14 INFO - 'NO_EM_RESTART': '1', 22:53:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:53:14 INFO - 'PWD': '/builds/slave/test', 22:53:14 INFO - 'SHELL': '/bin/bash', 22:53:14 INFO - 'SHLVL': '1', 22:53:14 INFO - 'TERM': 'linux', 22:53:14 INFO - 'TMOUT': '86400', 22:53:14 INFO - 'USER': 'cltbld', 22:53:14 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450152327.723067-1415303169', 22:53:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:14 INFO - '_': '/tools/buildbot/bin/python'} 22:53:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:53:15 INFO - Running setup.py (path:/tmp/pip-e6uY6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:53:15 INFO - Running setup.py (path:/tmp/pip-gt3Nuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:53:15 INFO - Running setup.py (path:/tmp/pip-tytVXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:53:15 INFO - Running setup.py (path:/tmp/pip-DYt1Z0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:53:15 INFO - Running setup.py (path:/tmp/pip-9vxp_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:53:15 INFO - Running setup.py (path:/tmp/pip-OtmydA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:53:15 INFO - Running setup.py (path:/tmp/pip-vlSG9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:53:15 INFO - Running setup.py (path:/tmp/pip-WhIY3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:53:15 INFO - Running setup.py (path:/tmp/pip-jDNz9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:53:15 INFO - Running setup.py (path:/tmp/pip-51OSyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:53:15 INFO - Running setup.py (path:/tmp/pip-O6OrGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:53:15 INFO - Running setup.py (path:/tmp/pip-wgO0bV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:53:15 INFO - Running setup.py (path:/tmp/pip-rZGyDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:53:16 INFO - Running setup.py (path:/tmp/pip-rFgsOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:53:16 INFO - Running setup.py (path:/tmp/pip-epEQ3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:53:16 INFO - Running setup.py (path:/tmp/pip-wLYq9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:53:16 INFO - Running setup.py (path:/tmp/pip-KReiGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:53:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:53:16 INFO - Running setup.py install for manifestparser 22:53:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:53:16 INFO - Running setup.py install for mozcrash 22:53:16 INFO - Running setup.py install for mozdebug 22:53:16 INFO - Running setup.py install for mozdevice 22:53:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:53:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:53:16 INFO - Running setup.py install for mozfile 22:53:16 INFO - Running setup.py install for mozhttpd 22:53:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:53:16 INFO - Running setup.py install for mozinfo 22:53:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:53:16 INFO - Running setup.py install for mozInstall 22:53:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:53:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:53:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:53:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:53:17 INFO - Running setup.py install for mozleak 22:53:17 INFO - Running setup.py install for mozlog 22:53:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:53:17 INFO - Running setup.py install for moznetwork 22:53:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:53:17 INFO - Running setup.py install for mozprocess 22:53:17 INFO - Running setup.py install for mozprofile 22:53:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:53:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:53:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:53:17 INFO - Running setup.py install for mozrunner 22:53:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:53:17 INFO - Running setup.py install for mozscreenshot 22:53:17 INFO - Running setup.py install for moztest 22:53:17 INFO - Running setup.py install for mozversion 22:53:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:53:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:53:18 INFO - Cleaning up... 22:53:18 INFO - Return code: 0 22:53:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:53:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:18 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 0x7ffdebfcaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e70b0>, '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 0x25e7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e8440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1450152327.723067-1415303169', '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 22:53:18 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 22:53:18 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 22:53:18 INFO - Using env: {'DISPLAY': ':0', 22:53:18 INFO - 'HOME': '/home/cltbld', 22:53:18 INFO - 'LANG': 'en_US.UTF-8', 22:53:18 INFO - 'LANGUAGE': 'en_US:en', 22:53:18 INFO - 'LOGNAME': 'cltbld', 22:53:18 INFO - 'MAIL': '/var/mail/cltbld', 22:53:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:18 INFO - 'MOZ_NO_REMOTE': '1', 22:53:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:18 INFO - 'NO_EM_RESTART': '1', 22:53:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:53:18 INFO - 'PWD': '/builds/slave/test', 22:53:18 INFO - 'SHELL': '/bin/bash', 22:53:18 INFO - 'SHLVL': '1', 22:53:18 INFO - 'TERM': 'linux', 22:53:18 INFO - 'TMOUT': '86400', 22:53:18 INFO - 'USER': 'cltbld', 22:53:18 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450152327.723067-1415303169', 22:53:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:18 INFO - '_': '/tools/buildbot/bin/python'} 22:53:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:53:18 INFO - Running setup.py (path:/tmp/pip-XlkKYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:53:18 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)) 22:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:53:18 INFO - Running setup.py (path:/tmp/pip-diofAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:53:18 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)) 22:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:53:18 INFO - Running setup.py (path:/tmp/pip-7Ty1qm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:53:18 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)) 22:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:53:18 INFO - Running setup.py (path:/tmp/pip-8_Eo95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:53:18 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)) 22:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:53:18 INFO - Running setup.py (path:/tmp/pip-Tmn5gF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:53:18 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)) 22:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:53:18 INFO - Running setup.py (path:/tmp/pip-mjjhNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:53:18 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)) 22:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:53:18 INFO - Running setup.py (path:/tmp/pip-ybXYip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:53:18 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)) 22:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:53:18 INFO - Running setup.py (path:/tmp/pip-YX4QUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:53:18 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)) 22:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:53:18 INFO - Running setup.py (path:/tmp/pip-JUDi0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:53:18 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)) 22:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:53:18 INFO - Running setup.py (path:/tmp/pip-0v43RI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:53:18 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)) 22:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:53:19 INFO - Running setup.py (path:/tmp/pip-99zLlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:53:19 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)) 22:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:53:19 INFO - Running setup.py (path:/tmp/pip-lsr91X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:53:19 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)) 22:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:53:19 INFO - Running setup.py (path:/tmp/pip-Sf34ye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:53:19 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)) 22:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:53:19 INFO - Running setup.py (path:/tmp/pip-jdFAaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:53:19 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)) 22:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:53:19 INFO - Running setup.py (path:/tmp/pip-MvmfrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:53:19 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)) 22:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:53:19 INFO - Running setup.py (path:/tmp/pip-C3Rith-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:53:19 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)) 22:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:53:19 INFO - Running setup.py (path:/tmp/pip-4gOYkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:53:19 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)) 22:53:19 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)) 22:53:19 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)) 22:53:19 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)) 22:53:19 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)) 22:53:19 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)) 22:53:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:53: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 22:53: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 22:53: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 22:53: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 22:53: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 22:53: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 22:53:21 INFO - Downloading blessings-1.5.1.tar.gz 22:53:21 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 22:53:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:53:21 INFO - Installing collected packages: blessings 22:53:21 INFO - Running setup.py install for blessings 22:53:21 INFO - Successfully installed blessings 22:53:21 INFO - Cleaning up... 22:53:21 INFO - Return code: 0 22:53:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:53:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:53:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:53:21 INFO - Reading from file tmpfile_stdout 22:53:21 INFO - Current package versions: 22:53:21 INFO - argparse == 1.2.1 22:53:21 INFO - blessings == 1.5.1 22:53:21 INFO - blobuploader == 1.2.4 22:53:21 INFO - docopt == 0.6.1 22:53:21 INFO - manifestparser == 1.1 22:53:21 INFO - mozInstall == 1.12 22:53:21 INFO - mozcrash == 0.16 22:53:21 INFO - mozdebug == 0.1 22:53:21 INFO - mozdevice == 0.47 22:53:21 INFO - mozfile == 1.2 22:53:21 INFO - mozhttpd == 0.7 22:53:21 INFO - mozinfo == 0.9 22:53:21 INFO - mozleak == 0.1 22:53:21 INFO - mozlog == 3.1 22:53:21 INFO - moznetwork == 0.27 22:53:21 INFO - mozprocess == 0.22 22:53:21 INFO - mozprofile == 0.27 22:53:21 INFO - mozrunner == 6.11 22:53:21 INFO - mozscreenshot == 0.1 22:53:21 INFO - mozsystemmonitor == 0.0 22:53:21 INFO - moztest == 0.7 22:53:21 INFO - mozversion == 1.4 22:53:21 INFO - psutil == 3.1.1 22:53:21 INFO - requests == 1.2.3 22:53:21 INFO - wsgiref == 0.1.2 22:53:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:53:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:21 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 0x7ffdebfcaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e70b0>, '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 0x25e7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e8440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1450152327.723067-1415303169', '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 22:53:21 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 22:53:21 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 22:53:21 INFO - Using env: {'DISPLAY': ':0', 22:53:21 INFO - 'HOME': '/home/cltbld', 22:53:21 INFO - 'LANG': 'en_US.UTF-8', 22:53:21 INFO - 'LANGUAGE': 'en_US:en', 22:53:21 INFO - 'LOGNAME': 'cltbld', 22:53:21 INFO - 'MAIL': '/var/mail/cltbld', 22:53:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:21 INFO - 'MOZ_NO_REMOTE': '1', 22:53:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:21 INFO - 'NO_EM_RESTART': '1', 22:53:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:53:21 INFO - 'PWD': '/builds/slave/test', 22:53:21 INFO - 'SHELL': '/bin/bash', 22:53:21 INFO - 'SHLVL': '1', 22:53:21 INFO - 'TERM': 'linux', 22:53:21 INFO - 'TMOUT': '86400', 22:53:21 INFO - 'USER': 'cltbld', 22:53:21 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450152327.723067-1415303169', 22:53:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:21 INFO - '_': '/tools/buildbot/bin/python'} 22:53:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:21 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)) 22:53:21 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)) 22:53:21 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)) 22:53:21 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)) 22:53:21 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)) 22:53:21 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)) 22:53:21 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)) 22:53:21 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)) 22:53:21 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)) 22:53:21 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)) 22:53:21 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)) 22:53:21 INFO - Cleaning up... 22:53:21 INFO - Return code: 0 22:53:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:53:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:21 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 0x7ffdebfcaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e70b0>, '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 0x25e7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e8440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1450152327.723067-1415303169', '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 22:53:21 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 22:53:21 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 22:53:21 INFO - Using env: {'DISPLAY': ':0', 22:53:21 INFO - 'HOME': '/home/cltbld', 22:53:21 INFO - 'LANG': 'en_US.UTF-8', 22:53:21 INFO - 'LANGUAGE': 'en_US:en', 22:53:21 INFO - 'LOGNAME': 'cltbld', 22:53:21 INFO - 'MAIL': '/var/mail/cltbld', 22:53:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:21 INFO - 'MOZ_NO_REMOTE': '1', 22:53:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:21 INFO - 'NO_EM_RESTART': '1', 22:53:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:53:21 INFO - 'PWD': '/builds/slave/test', 22:53:21 INFO - 'SHELL': '/bin/bash', 22:53:21 INFO - 'SHLVL': '1', 22:53:21 INFO - 'TERM': 'linux', 22:53:21 INFO - 'TMOUT': '86400', 22:53:21 INFO - 'USER': 'cltbld', 22:53:21 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450152327.723067-1415303169', 22:53:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:21 INFO - '_': '/tools/buildbot/bin/python'} 22:53:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:22 INFO - Downloading/unpacking jsonschema 22:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:53:23 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 22:53:23 INFO - Downloading/unpacking functools32 (from jsonschema) 22:53:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:24 INFO - Downloading functools32-3.2.3-2.tar.gz 22:53:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 22:53:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:53:24 INFO - warning: no files found matching '*.txt' 22:53:24 INFO - no previously-included directories found matching 'build' 22:53:24 INFO - no previously-included directories found matching 'dist' 22:53:24 INFO - no previously-included directories found matching '.git*' 22:53:24 INFO - Installing collected packages: jsonschema, functools32 22:53:24 INFO - Running setup.py install for functools32 22:53:24 INFO - warning: no files found matching '*.txt' 22:53:24 INFO - no previously-included directories found matching 'build' 22:53:24 INFO - no previously-included directories found matching 'dist' 22:53:24 INFO - no previously-included directories found matching '.git*' 22:53:24 INFO - Successfully installed jsonschema functools32 22:53:24 INFO - Cleaning up... 22:53:24 INFO - Return code: 0 22:53:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:53:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdebfcaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e70b0>, '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 0x25e7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e8440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1450152327.723067-1415303169', '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 22:53:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 22:53:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:53:24 INFO - Using env: {'DISPLAY': ':0', 22:53:24 INFO - 'HOME': '/home/cltbld', 22:53:24 INFO - 'LANG': 'en_US.UTF-8', 22:53:24 INFO - 'LANGUAGE': 'en_US:en', 22:53:24 INFO - 'LOGNAME': 'cltbld', 22:53:24 INFO - 'MAIL': '/var/mail/cltbld', 22:53:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:24 INFO - 'MOZ_NO_REMOTE': '1', 22:53:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:24 INFO - 'NO_EM_RESTART': '1', 22:53:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:53:24 INFO - 'PWD': '/builds/slave/test', 22:53:24 INFO - 'SHELL': '/bin/bash', 22:53:24 INFO - 'SHLVL': '1', 22:53:24 INFO - 'TERM': 'linux', 22:53:24 INFO - 'TMOUT': '86400', 22:53:24 INFO - 'USER': 'cltbld', 22:53:24 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450152327.723067-1415303169', 22:53:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:24 INFO - '_': '/tools/buildbot/bin/python'} 22:53:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:24 INFO - Downloading/unpacking flake8 22:53:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:53:26 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 22:53:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:53:26 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 22:53:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:26 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 22:53:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 22:53:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:53:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:53:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:53:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:53:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:53:26 INFO - no previously-included directories found matching 'docs/_build' 22:53:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:53:26 INFO - Running setup.py install for pep8 22:53:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:53:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:53:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:53:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:53:27 INFO - no previously-included directories found matching 'docs/_build' 22:53:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:53:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:53:27 INFO - Cleaning up... 22:53:27 INFO - Return code: 0 22:53:27 INFO - Running post-action listener: _resource_record_post_action 22:53:27 INFO - Running post-action listener: _start_resource_monitoring 22:53:27 INFO - Starting resource monitoring. 22:53:27 INFO - ##### 22:53:27 INFO - ##### Running install step. 22:53:27 INFO - ##### 22:53:27 INFO - Running pre-action listener: _resource_record_pre_action 22:53:27 INFO - Running main action method: install 22:53:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:53:27 INFO - Reading from file tmpfile_stdout 22:53:27 INFO - Detecting whether we're running mozinstall >=1.0... 22:53:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:53:27 INFO - Reading from file tmpfile_stdout 22:53:27 INFO - Output received: 22:53:27 INFO - Usage: mozinstall [options] installer 22:53:27 INFO - Options: 22:53:27 INFO - -h, --help show this help message and exit 22:53:27 INFO - -d DEST, --destination=DEST 22:53:27 INFO - Directory to install application into. [default: 22:53:27 INFO - "/builds/slave/test"] 22:53:27 INFO - --app=APP Application being installed. [default: firefox] 22:53:27 INFO - mkdir: /builds/slave/test/build/application 22:53:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:53:42 INFO - Reading from file tmpfile_stdout 22:53:42 INFO - Output received: 22:53:42 INFO - /builds/slave/test/build/application/firefox/firefox 22:53:42 INFO - Running post-action listener: _resource_record_post_action 22:53:42 INFO - ##### 22:53:42 INFO - ##### Running run-tests step. 22:53:42 INFO - ##### 22:53:42 INFO - Running pre-action listener: _resource_record_pre_action 22:53:42 INFO - Running main action method: run_tests 22:53:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:53:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:53:42 INFO - Python 2.7.3 22:53:42 INFO - Return code: 0 22:53:42 INFO - grabbing minidump binary from tooltool 22:53:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:42 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 0x25e70b0>, '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 0x25e7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e8440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:53:42 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 22:53:42 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 22:53:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:53:42 INFO - Return code: 0 22:53:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:53:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:53:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:53:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:53:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:53:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:53:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:53:43 INFO - Return code: 0 22:53:43 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/2FdolsOWTOuZotw1PDf0cA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost'] in /builds/slave/test/build 22:53:43 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/2FdolsOWTOuZotw1PDf0cA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost 22:53:43 INFO - Using env: {'DISPLAY': ':0', 22:53:43 INFO - 'HOME': '/home/cltbld', 22:53:43 INFO - 'LANG': 'en_US.UTF-8', 22:53:43 INFO - 'LANGUAGE': 'en_US:en', 22:53:43 INFO - 'LOGNAME': 'cltbld', 22:53:43 INFO - 'MAIL': '/var/mail/cltbld', 22:53:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:53:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:53:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:43 INFO - 'MOZ_NO_REMOTE': '1', 22:53:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:53:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:43 INFO - 'NO_EM_RESTART': '1', 22:53:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:53:43 INFO - 'PWD': '/builds/slave/test', 22:53:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:53:43 INFO - 'SHELL': '/bin/bash', 22:53:43 INFO - 'SHLVL': '1', 22:53:43 INFO - 'TERM': 'linux', 22:53:43 INFO - 'TMOUT': '86400', 22:53:43 INFO - 'USER': 'cltbld', 22:53:43 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450152327.723067-1415303169', 22:53:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:43 INFO - '_': '/tools/buildbot/bin/python'} 22:53:43 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/2FdolsOWTOuZotw1PDf0cA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost'] with output_timeout 3600 22:53:43 INFO - mozversion INFO | application_buildid: 20151214222411 22:53:43 INFO - mozversion INFO | application_changeset: efbbf72b9d0a2c54f5fa08a01b6a5d4df8e0f738 22:53:43 INFO - mozversion INFO | application_display_name: Nightly 22:53:43 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:53:43 INFO - mozversion INFO | application_name: Firefox 22:53:43 INFO - mozversion INFO | application_remotingname: firefox 22:53:43 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 22:53:43 INFO - mozversion INFO | application_vendor: Mozilla 22:53:43 INFO - mozversion INFO | application_version: 46.0a1 22:53:43 INFO - mozversion INFO | platform_buildid: 20151214222411 22:53:43 INFO - mozversion INFO | platform_changeset: efbbf72b9d0a2c54f5fa08a01b6a5d4df8e0f738 22:53:43 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 22:53:43 INFO - mozversion INFO | platform_version: 46.0a1 22:53:43 INFO - 2015-12-14 22:53:43,220 DEBUG : using testdate: 1450162423 22:53:43 INFO - 2015-12-14 22:53:43,220 DEBUG : actual date: 1450162423 22:53:43 INFO - 2015-12-14 22:53:43,268 INFO : starting webserver on 'localhost:40968' 22:53:43 INFO - 2015-12-14 22:53:43,269 INFO : Starting test suite talos-linux64-ix-036 22:53:43 INFO - 2015-12-14 22:53:43,269 INFO : Starting test dromaeo_css 22:53:43 INFO - 2015-12-14 22:53:43,269 DEBUG : operating with platform_type : linux_ 22:53:43 INFO - 2015-12-14 22:53:43,270 INFO : Initialising browser for dromaeo_css test... 22:53:43 INFO - 2015-12-14 22:53:43,280 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2bzTKz/profile http://localhost:40968/getInfo.html 22:53:48 INFO - 2015-12-14 22:53:48,136 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:53:48 INFO - 2015-12-14 22:53:48,136 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:53:48 INFO - 2015-12-14 22:53:48,136 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:53:48 INFO - 2015-12-14 22:53:48,136 DEBUG : BROWSER_OUTPUT: __metrics 22:53:48 INFO - 2015-12-14 22:53:48,217 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:53:48 INFO - 2015-12-14 22:53:48,305 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:53:49 INFO - 2015-12-14 22:53:49,201 INFO : Browser initialized. 22:53:49 INFO - 2015-12-14 22:53:49,201 INFO : Running cycle 1/1 for dromaeo_css test... 22:53:49 INFO - 2015-12-14 22:53:49,201 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2bzTKz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:54:01 INFO - 2015-12-14 22:54:01,182 DEBUG : BROWSER_OUTPUT: RSS: Main: 142442496 22:54:01 INFO - 2015-12-14 22:54:01,182 DEBUG : BROWSER_OUTPUT: 22:54:52 INFO - 2015-12-14 22:54:52,393 DEBUG : BROWSER_OUTPUT: 1450162492386 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] 22:57:04 INFO - 2015-12-14 22:57:04,416 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40968/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40968/tests/dromaeo/cssquery-ext.html) 22:57:05 INFO - 2015-12-14 22:57:05,453 DEBUG : BROWSER_OUTPUT: RSS: Main: 238297088 22:57:05 INFO - 2015-12-14 22:57:05,453 DEBUG : BROWSER_OUTPUT: 23:00:07 INFO - 2015-12-14 23:00:07,896 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40968/tests/dromaeo/cssquery-ext.html (next: http://localhost:40968/tests/dromaeo/cssquery-jquery.html) 23:00:08 INFO - 2015-12-14 23:00:08,469 DEBUG : BROWSER_OUTPUT: RSS: Main: 224837632 23:00:08 INFO - 2015-12-14 23:00:08,469 DEBUG : BROWSER_OUTPUT: 23:03:10 INFO - 2015-12-14 23:03:10,643 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40968/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40968/tests/dromaeo/cssquery-mootools.html) 23:03:11 INFO - 2015-12-14 23:03:11,217 DEBUG : BROWSER_OUTPUT: RSS: Main: 226734080 23:03:11 INFO - 2015-12-14 23:03:11,217 DEBUG : BROWSER_OUTPUT: 23:06:13 INFO - 2015-12-14 23:06:13,142 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40968/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40968/tests/dromaeo/cssquery-prototype.html) 23:06:13 INFO - 2015-12-14 23:06:13,728 DEBUG : BROWSER_OUTPUT: RSS: Main: 204492800 23:06:13 INFO - 2015-12-14 23:06:13,728 DEBUG : BROWSER_OUTPUT: 23:09:16 INFO - 2015-12-14 23:09:16,585 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40968/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40968/tests/dromaeo/cssquery-yui.html) 23:09:17 INFO - 2015-12-14 23:09:17,167 DEBUG : BROWSER_OUTPUT: RSS: Main: 210841600 23:09:17 INFO - 2015-12-14 23:09:17,167 DEBUG : BROWSER_OUTPUT: 23:12:19 INFO - 2015-12-14 23:12:19,580 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40968/tests/dromaeo/cssquery-yui.html (next: http://localhost:40968/tests/dromaeo/cssquery-dojo.html) 23:12:19 INFO - 2015-12-14 23:12:19,826 DEBUG : BROWSER_OUTPUT: RSS: Main: 255066112 23:12:19 INFO - 2015-12-14 23:12:19,826 DEBUG : BROWSER_OUTPUT: 23:12:19 INFO - 2015-12-14 23:12:19,827 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:12:19 INFO - 2015-12-14 23:12:19,827 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:12:19 INFO - 2015-12-14 23:12:19,827 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:12:19 INFO - 2015-12-14 23:12:19,827 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:12:19 INFO - 2015-12-14 23:12:19,828 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2582.2511471673215;2697.042549894788;2697.784177265819;2701.1356365962874;2707.1607801581513;4549;4629.976850115749;4669.463011753649;4677.1347300749385;4704.976475117628;4541.636669066475;4641.0949864776385;4694.530546945304;4713.457952335482;4717.363155973942;4250.61744443;4265;4320.222359975203;4377.124575084979;4388.780560971939;4310.82756689732;4363.454568178978;4380.430544029272;4385;4421.182081314951;4127.731697439672;4231.70378073535;4282.314829627245;4337.110892267077;4342.435483387171;4292.270314046619;4316.6978311518205;4317.309230523133;4338.479382474124;4351.760653164075;4276.957230427687;4283.100548884707;4284.5715428457215;4284.721493102938;4318.784060796947;4386.100849325912;4475.664325175625;4499.212637788374;4527.094581083797;4689.718616882998;5074.213496907985;5075.670081444731;5085.974570127163;5088.0587091388215;5116.897662046776;5099.056674515226;5103.055934652101;5103.668261562986;5111.361079865017;5151.4333423323405;4582.221022426195;4688.343631891538;4689.554492323224;4690.202665546865;4711.316859055452;5060.898782024339;5167.354080739908;5169.043726910533;5187.170052791535;5197.7141257231215;4966.056449274699;4986.601071914238;4999.200127979579;5006.74966251686;5053.69677819332;4891.828785992473;5009.073321435546;5088.0587091388215;5088.363954505687;5101.285819985205;4936.432310284364;4978.377702787152;5027.195648696191;5044.596432285409;5046.571041461517;4986.401631804207;4998.525140111684;5006.299118123466;5007.148784706608;5050.4949505049935;4172.311568591149;4204.306289462204;4207;4207.431996680409;4245.511766146933;3541.1678255609913;3621.2033352662897;3646.4530320451613;3668.4497325401403;3721;4361.433013708198;4369;4372.497162826252;4373.671974601918;4408.9859332353735;5068.265101560253;5072.873178170502;5077.543021128043;5083.161278389024;5092.9745351273;4177.665786737054;4265.893352666209;4268.08236229206;4271.722338048079;4359.149965756647;4502.077074199781;4509.954900451019;4521.706089104264;4543.795529201194;4560.270356742905;4819.7108173509705;4821.831235906797;4821.879453013633;4832.395950506187;4882.7314497701545;4874.756262186947;4937.456879743298;4975.452700202903;4978.27814966835;5104.515071068243;4774.665773395829;4776.5701086902345;4777.0684716479955;4825.396825396825;4845.563899249085;4978.2781496682055;4982.576480999156;4991.900161996812;5003.099442100457;5029.044481548494;4773;4935.925961110514;4948.727819969936;4954.083494553375;5111.87220319495;4850.272459131017;4851.078295123915;4878.365812444502;4894.975525122351;4935.457099718957;4839.637027222902;4840.83057093;4844.32179494864;4859.611231101574;4897.730624815669;4528.366028756042;4647.488776234544;4680.578747912704;4683.718976861399;4786.042791441656;4927.581155601814;4935.605151587936;4937.9259311109645;4938.629602779878;5003.024410239968;4827.179379505563;4839.903201936012;4843.007183527298;4843.903121937612;4883.121038213014 23:12:19 INFO - 2015-12-14 23:12:19,830 DEBUG : BROWSER_OUTPUT: |1;ext.html;570.8915306091842;572.8138355034614;578.22517826113;582.3157789597224;585.8330375842886;27347;36538.451923221175;37643.623563764355;37661;37675.62324376756;40490.39264411036;41283.17433651325;41320.173596528126;41374.37938430926;41381.17237655245;6980.965095174517;7106.467014973872;7810.453268271209;7972.202779722011;7988.440809143333;9910.504474776268;10146.64486742964;10154.847677284846;10156.644517441891;10170.9491452543;10015.19878409729;10115.898841011569;10164.237682173829;10174.03346682064;10178.185745140408;7158.749443769495;7358.448116391239;9776.657816976407;10196;10431.374117552896;9873.864505581807;9986.300958932878;9995.75010624733;10008.49957502122;10008.59965601375;37684.24631507382;38137;38189.61810381888;38256.80871595624;38293.61706382956;2837.3048603092375;2842;2858.6283783108065;2878.107786586144;2908.0694177863093;29025.41949161026;29048.56427153573;29154.562681559793;29208.853955730297;29852.55221171684;3347.7991320520846;3381.881634142818;3410.300888317889;3445.6898879101;3531.3820081485637;219263;219294;219454;220374.9999999984;221161;47373.5262647376;48647;57113.42886571164;57337;57404.71297643485;60572;61873.381266187665;61899.6905015481;61983;62054.37945620577;14165.079269847427;14495.855041449662;14495.912806539553;14598.41606335756;14618.415263389557;9916.25628077897;9947.353422027545;9951.850722239173;9975.850362244571;9989.850152247722;19227;19268.518287042654;19278.13248403825;19350;19432.611347773247;7299.598522081336;7602.7339043133225;7616.7334143304715;7657.310842024244;7743.574103424366;819.2708489444399;837.5560952695081;948.0661548374845;986.5166068626465;1000.5947591225565;26488;26581.867090664422;26728.732712673012;26761;26914.730852691613;913.5477938420391;950.1496160936061;951.8952915179325;980.8921018687938;1013.9543720532594;13824.239666818221;13991.86008139926;14041.78937315941;14241.287935603179;14258.643533911527;268588;273404;273925;274466;275066;46229.537704622526;46303.5369646306;46519.30221046687;46589.5341046592;46680.299795503095;1182.0720734223764;1193.8448001759716;1202.60314096348;1212.1999480342931;1215.7629262293767;24846.130385436423;25551.872240638677;26306;26470.602940956287;26572.202833915013;40618;41306.586934130275;41366;41411.1717765637;41426;313358;324392;355316;368742;369151;26800.463990719687;26869.328266793487;26899.462010760068;26956;26993;36881.26237475289;39002.60997390103;39293.803530982164;40228;40231;29680.257993550335;32299.51550726788;33242.66757332395;33480;33732.49401258934;29575;29614.851925740233;29806.552901706058;29819.552706708982;29875.70124298816;33397.49903751494;34002.829985849916;34038.319233615686;34567;34613.13467163341;27339;28094.71905280921;29772.702272976992;29979.850100749358;30030.3993920116;21289;21501.354959351243;21564.35306940794;21569.568608627425;21582.8920855401 23:12:19 INFO - 2015-12-14 23:12:19,831 DEBUG : BROWSER_OUTPUT: |2;jquery.html;325.2924888367801;329.55180953902703;333.25849983786065;334.6168636910737;339.2367173858818;12572.622821315352;12966.675833104176;15051.096934183943;15530.990485618428;16052.197390130505;9651.420914745102;9855.310128291023;9878.950605246964;14419.855801441983;14842.183679897602;3876.6511014008734;4631.328457373679;4633.93049104262;4634.165850146972;4636.953630463686;3459.636738142484;3572.4462708280257;3573.5533058367705;3574.3566158091535;4800.49594792547;3568.4290513517844;5112.8977420451565;5277.8416647500635;5278.736063196844;5283.233931079991;5131.281620573122;5255.947440525603;5269.6311258211945;5280.023195708806;5285.418603953562;5086.084504789136;5092.7453627318855;5093.5415812576675;5097.6941383517105;5098.235264710286;11463.31220126795;12956.676083097904;14382.568522944328;14394.856051439561;14402.567922962327;1656.2960741684856;1705.2326453096157;1744.834240747127;1769.8672599554957;1838.7333836593752;8864.955675221647;8890.555472226428;8941.865872011926;9076.183143517115;9158.679446219418;1712.1952682239453;1714.8885322454125;1742.7473016412548;1784.794748603901;1805.494461550768;52590.737046314905;55458.9999999996;55920.72039639817;56391.71804140953;56413;9535.856962145574;9680.661176858775;9785.559649815776;9812.754681132887;9900.108990190773;12402.317872516918;12411.131220814637;12424.56514022005;12429.502819887104;12434.316112613713;6518.57629254097;6747.932520674731;6827.897581536281;6939.861202775916;7171.784846454615;6690.498212634072;6859.9314006860295;6870.793876183722;6943.236244013155;6951.061606683134;4151.3772934059525;4153.896152596149;4168;4176.18564379943;4197.223513649985;1617.6683779825107;1645.95885102871;1666.3251383189827;1669.7578851066528;1736.0885535094176;364.7756629672732;366.5839272425816;380.0062835684665;763.5914785589794;850.3197442046462;9304.93273542595;9663;9876.308658393988;9926.454045027593;9929.404235745878;350.14389816897443;382.87747920665674;393.6791514915335;401.6224748736179;420.26663472241137;5529.972350138223;5703.17303990919;8977.775555611031;9291.21024712907;9367.765805854908;474417;475635;476419;481904;488776;69886.65056674786;71434;73569.63215183996;73630;75266.62366688241;1103.150574057971;1105.607509334207;1116.1182665694173;1133.8469306643663;1137.181229514748;14667.706645867236;14814.333354999266;14876;15004.174770387734;15385;33000.174995625304;33202.16994575155;33335.66664333326;33849.661503385636;34293;42186.78906605447;44420.333694993955;44667.776661116484;44735.55264447314;45619.315710263705;8631.654733810577;8774.837743384922;8837.293016558788;8874.60064297121;8955;10332.431716255678;10348.120409765253;10384.792304153723;10478.637777089234;10480.895191047992;13339.466421343037;13886.652833678834;13985.370658320197;14343.56969290923;14430.42278308856;13029.348532573144;13681.110727802661;13714.108582942077;13913.652158696113;14142.575722728334;11206.495707693337;11454.255473394536;14200.786988195392;14319.856801432268;14690.779638305221;7273.818154546178;8102.635381407733;8717.694880679146;8724.69463568772;8977.865332020156;12857.228566286052;13008.154469959421;13135.277559734306;13284.80072798928;13679.86320136786 23:12:19 INFO - 2015-12-14 23:12:19,831 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1267.252321130533;1408.6407965968683;1425.2232533269366;1669.8330166983299;1736.366226327391;5874.559408044398;6421.871562568752;6547.148870646809;6561.6391098489685;6575.901361479576;6606.2072551293795;6722.6974786134615;6742.190937087556;6745.426638735701;6753.493487988409;1714.1000974488431;1748.9038102904335;1941.4272789527124;1969.2024729984307;1980.2178139634836;2034.9593008139827;2050.179928028793;2051.005262447719;2055.2703790154505;2056.938291851247;1952.0532541717255;1978.6834106542956;2001.9699704504444;2002.7696814866258;2004.2584243829804;1992.1234656751128;2003.9599208015832;2031.329661211804;2033.054629597237;2048.7541495020546;2044.0188709419413;2068.503559145809;2068.6896965455153;2069.151647824385;2070.130545171032;6680.665966701694;6762.154730658668;6765.086713293692;6767.796966091025;6770.966145169243;3894.9805250973845;3987.4018897165656;3989.7207195496326;3994.201159768029;3996.440498330236;2486.7015958084967;2568.9871550642315;2573.2280315905155;2579.7678208961283;2595.740425957408;810.8580998325269;814.2712272516125;825.1748251748252;844.8141408890034;879.4503435352905;8973.461592304417;9008.729738107868;9011.549422528913;9017.684381046698;9071.138241867078;3637.1452708613456;3688.797116158637;3737.252549490113;3756.2675278320467;3757.1922036762226;7841.686332546748;7851.921480785233;7860.567668778158;7863.13505514393;7865;4057.350823868167;4068.7762173080173;4111.814968326433;4124.731892426983;4125.484314460692;3687.4468829675225;3695.667389934919;3699.5190625218547;3717.182219911615;3737.364648009845;2855.486012517725;2894;3153.44814657434;3165.1612322734495;3257.885973990899;1024.5440778853338;1039.4231201683137;1042.5517027678172;1045.1586472889246;1049.5434485998614;855.3713020929612;855.6534603485599;859.8065435277138;931.3387494878712;1001.3341128149699;5989.371116032841;6000.819975400657;6001.939980600226;6007.279126504847;6067.180930574316;1030.1192480429274;1047.5181416548473;1063.2982231727024;1064.2284343850647;1086.7011571817814;4875.878103047381;4911.263310503453;4934;4942.456329803718;4944.3572335596145;7934.642941067666;7983.680652773824;8169.223923727236;8192.631331590093;8234.670613175525;8086.919130808734;8164.183581641907;8183.304419124441;8202.630881610341;8223.54770487629;6414.647194404352;6553.541252112402;6556.475481961432;6560.8359791005605;6563.50773691975;5985.341612422717;6191.876162476815;6196.47329976957;6200.131981522501;6203.16257305258;7160.283971603007;7276.854462910606;7312.085989251344;7319.890201647086;7386.15059268191;7340.632968351454;7517.699292028257;7550.3582195514;7573.848523029619;7653.158152603321;6030.849228769141;6074.696265186812;6090.908636370546;6095.420935011167;6096.420840020191;5479.890402192013;5787.884242315215;5789.507891829073;5839.854003649943;6332.271788744353;5987.88024239504;5988.131720900358;6047.425494578008;6192.164057852132;6217.595856269328;5904.61619994699;5906.5233691577105;6000.249968753906;6035.426634469718;6128.32588415265;5812.476877081083;5986.640801551921;6018.849528761641;6020.638761674313;6035.336113027652;5703.857403564944;5761.798337058183;5764.654120752601;5768.711564421678;5771.971140144273;5838.4453476919625;5852.473277405054;5876.6180198288685;5888.793892213752;5895.115732639967 23:12:19 INFO - 2015-12-14 23:12:19,832 DEBUG : BROWSER_OUTPUT: |4;prototype.html;299.254855410029;301.0351822409179;301.820416851973;302.2926352335534;306.0451391658029;5130.820421285246;5208.973955130219;5212.895742085161;5233.241180028898;5277.050130976423;5067.163917953533;5191.221316802482;5212.76542555585;5237.580993520519;5241.973790131044;4077.734947228428;4088.2641124597562;4090.5295890972475;4095.344744840826;4101.589841015904;3890.3580909150096;3987.3620220764683;3998.480197574311;4083.4079058536495;4093.5087789465306;4037.6971727120435;4042.373432118012;4044.1396957399634;4050.3316952702767;4064.756114633117;4031.6371526562602;4038.4346191533064;4045.59544045596;4053.736507127057;4066.1257829566784;3562.3943929532043;3570.839312230956;3575.4994300797907;3575.928481430357;3582.229820588586;4975.228839529878;5073.340465739467;5074.0612986597225;5076.035553244872;5133.614978876599;4563.452385713736;4565.155446242423;4569.154706379297;4578.771061446914;4614.30785382192;5529.976954263434;5536.584756143265;5540.445955404468;5542.91685624716;5546.55627549795;3591.2637909228547;3683.778973261613;3837.2325534892852;3899.883003509871;3922;5693.601447898649;5770.9422905770825;5780.277465316835;5786.47921687046;5792.044312688401;4038;4045.4943132108488;4045.939310910339;4048.967513284094;4049.7570145791346;4097.733647312915;4099.959000410017;4108.137291168829;4108.630223279919;4115.670746340285;4554.795034223468;4656.301554766745;4661.813527458864;4665.6967297125575;4671.672982891165;5502.0921547944945;5506.366767821672;5509.807156749494;5510.448955104457;5511.22842802008;1394.4491925689297;1453.556665217119;1456.8251809782894;1457.5627311806415;1462.1957923142443;991.1179050644931;997.8602995580625;997.8902320744712;1006.9144122749649;1020.2297265564599;4886.413630364308;4887.047025829929;4887.780049897763;4888.046830868017;4894.339264199359;5718.228039214736;5730.140478928194;5731.254936858182;5734.111212762028;5735.569832262514;4834.057358814997;4849.369581954324;4864.051509955525;4878.9512104878495;4887.071456423339;2997.2956355256497;3066.9386612268077;3090.3510262844607;3093.9535906961414;3116.407882502317;5479.506844383945;5482.396936337;5482.889087701264;5485.067538518461;5488.121900495901;5923.437273459014;5929.4070592941225;5931.08068249422;5934.050551911673;5934.495567876693;5435.891282174334;5474.315710536183;5475.6440831345835;5476.7535460903555;5481.835544933579;5646.689432081275;5771.480566749013;5784.623999440023;5785.623934444247;5787.913181302368;5414.160805075219;5485.259489968963;5573.749181286933;5639.971800140973;5650.717464126695;5425.077736784835;5451.991381594417;5465.808696695596;5475.835724928099;5476.972615136899;3771.0949372151035;3801.885943421702;3810.657040866335;3846.076941534068;3854.0557563397147;5657.915131272952;5791.681457519877;5791.797287094932;5792.797252096325;5792.971035144966;5535.640183388067;5542.307211598551;5542.3626282977975;5544.667319960654;5544.750486228048;5410.78356865721;5482.205080263419;5485.122380419114;5506.091494903296;5536.2249285100925;5360.785568577213;5383.784648614168;5394.406615272395;5394.487523685244;5395.811146610007;5525.834224973257;5532.834014979557;5555.666660000413;5590.748416321194;5598.244237027949;5344.919826202688;5444.373897001896;5460.044492213768;5460.808871689472;5466.508014278575 23:12:19 INFO - 2015-12-14 23:12:19,833 DEBUG : BROWSER_OUTPUT: |5;yui.html;623.2116372788423;730.5105579261894;739.4564994728873;776.6272189349115;785.6268272570529;11640.359780212095;11830.349330786803;11847.348395838226;11933.522659093636;11942.641720748381;13128.868711312884;13588.048836581444;13594.18434893907;13595.93202033991;13601.38793754281;625.5558553427072;632.7975047984647;815.47401925758;815.9306458950996;827.0695467598921;819.4714409206058;821.2690705272282;826.4421515477059;826.5701835045803;827.3794654009492;856.1395797223781;863.7279257034014;864.5806783709895;865.2385900407664;866.2593482572373;653.0400311542026;661.6526323680082;841.8484672758901;856.007031843059;858.1804376820185;634.0267689097213;634.9904751428733;635.028406537993;635.3709827270968;636.0110028905051;11447.484863181176;11557;11588.884111158864;11598.594049208237;11600.071994240441;10633.255672102956;11019;11036.227464077518;11267.21129520934;11627.12796540263;9202.30982676302;9410.952945235298;9505.619775208983;9565.856512152322;9709.757256068584;3168.255459966906;3193.680631936811;3248.123006788154;3275.5086736989642;3340.0981734931433;40995.38506922369;41410.79294603508;41658.583414165776;41698.79150604258;41814;9154.633814647472;9240;9369.625214991323;9396.436213827192;9428.905710942803;16023.519294421187;16048.438304659281;16049;16060.598485037734;16113.677726445405;6072.332043475302;6301.52738544611;6361.968190159112;6385.616862988236;6439.903401448982;3515.82420878955;3532.964670353315;3624.130208749881;3625.2930678517964;3630.1650620356936;2597.6882774067235;2653.4427770168095;2660.2019394181666;2664.7335266473583;2665.18711792905;454.58632644293533;454.6044940901437;471.28835458457974;476.52823704532955;479.70737849911524;483.845169545742;509.7647163629504;543.3886877263079;574.1932584718477;584.8888711144868;8374.665013399517;8390.160983901562;8494.108118647453;8645.740627781177;8815.647374105092;388.279741080292;482.48133256749134;583.5302581421911;585.9589828712035;615.8244900203421;3442.7762195457217;3644.562652481666;3674.210044840372;3733.813309334577;3850.557185923599;48080.5191948083;48336.27495587569;48487.51512484901;48619.5138048615;48626.756866215444;43598.56401435945;43941.560584393745;44205.336919946225;44573.33140002903;44816.77591612086;39702.40446393307;39714;39891.00272493153;40051.79974100111;40274.167099948194;7402.518836275625;7428.73999410018;7465.776026719207;7505.887411688938;7701.422393320636;29570.260743481584;29954.400911982073;30223.244418889703;30481.39037219199;30856;35122.12194695153;35696.64303357037;38553.373595168756;39103;39269;9387.671431500137;9410.764730881783;9448.811023779623;9576.952115239379;9691;10081.798364032826;10156.746081348025;10165.695029149138;10209.489525523546;10301.896981030393;9387;9490.28822838276;9637.9036209637;9639.132478077006;9682.70951871445;9771.951140244253;9864;9906.653267135616;9962.950185249318;9975.152112070266;9112.088791120836;9289.303302252223;9311.76720581991;9367.906320936703;9372.578233979624;8304.792380190544;8375.874361884698;8512.914870851213;8559.57202139903;8625.094365091574;7963.482373645695;8576.699815506427;8605.311575074104;8774.736757897273;8802.207801297658 23:12:19 INFO - 2015-12-14 23:12:19,834 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:12:19 INFO - 2015-12-14 23:12:19,834 DEBUG : BROWSER_OUTPUT: __start_cc_report 23:12:19 INFO - 2015-12-14 23:12:19,834 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,825 23:12:19 INFO - 2015-12-14 23:12:19,834 DEBUG : BROWSER_OUTPUT: __end_cc_report 23:12:19 INFO - 2015-12-14 23:12:19,834 DEBUG : BROWSER_OUTPUT: __startTimestamp1450163539825__endTimestamp 23:12:19 INFO - 2015-12-14 23:12:19,834 DEBUG : BROWSER_OUTPUT: 23:12:19 INFO - 2015-12-14 23:12:19,834 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:12:19 INFO - 2015-12-14 23:12:19,834 DEBUG : BROWSER_OUTPUT: Number of tests: 6 23:12:19 INFO - 2015-12-14 23:12:19,835 DEBUG : BROWSER_OUTPUT: 23:12:19 INFO - 2015-12-14 23:12:19,835 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4636.53 Median:4777.07 stddev:493.28 (10.3%) stddev-sans-first:467.73 23:12:19 INFO - 2015-12-14 23:12:19,835 DEBUG : BROWSER_OUTPUT: Values: 2582.3 2697.0 2697.8 2701.1 2707.2 4549.0 4630.0 4669.5 4677.1 4705.0 4541.6 4641.1 4694.5 4713.5 4717.4 4250.6 4265.0 4320.2 4377.1 4388.8 4310.8 4363.5 4380.4 4385.0 4421.2 4127.7 4231.7 4282.3 4337.1 4342.4 4292.3 4316.7 4317.3 4338.5 4351.8 4277.0 4283.1 4284.6 4284.7 4318.8 4386.1 4475.7 4499.2 4527.1 4689.7 5074.2 5075.7 5086.0 5088.1 5116.9 5099.1 5103.1 5103.7 5111.4 5151.4 4582.2 4688.3 4689.6 4690.2 4711.3 5060.9 5167.4 5169.0 5187.2 5197.7 4966.1 4986.6 4999.2 5006.7 5053.7 4891.8 5009.1 5088.1 5088.4 5101.3 4936.4 4978.4 5027.2 5044.6 5046.6 4986.4 4998.5 5006.3 5007.1 5050.5 4172.3 4204.3 4207.0 4207.4 4245.5 3541.2 3621.2 3646.5 3668.4 3721.0 4361.4 4369.0 4372.5 4373.7 4409.0 5068.3 5072.9 5077.5 5083.2 5093.0 4177.7 4265.9 4268.1 4271.7 4359.1 4502.1 4510.0 4521.7 4543.8 4560.3 4819.7 4821.8 4821.9 4832.4 4882.7 4874.8 4937.5 4975.5 4978.3 5104.5 4774.7 4776.6 4777.1 4825.4 4845.6 4978.3 4982.6 4991.9 5003.1 5029.0 4773.0 4935.9 4948.7 4954.1 5111.9 4850.3 4851.1 4878.4 4895.0 4935.5 4839.6 4840.8 4844.3 4859.6 4897.7 4528.4 4647.5 4680.6 4683.7 4786.0 4927.6 4935.6 4937.9 4938.6 5003.0 4827.2 4839.9 4843.0 4843.9 4883.1 23:12:19 INFO - 2015-12-14 23:12:19,835 DEBUG : BROWSER_OUTPUT: 23:12:19 INFO - 2015-12-14 23:12:19,835 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43714.69 Median:33320.08 stddev:74709.72 (224.2%) stddev-sans-first:74849.08 23:12:19 INFO - 2015-12-14 23:12:19,835 DEBUG : BROWSER_OUTPUT: Values: 570.9 572.8 578.2 582.3 585.8 27347.0 36538.5 37643.6 37661.0 37675.6 40490.4 41283.2 41320.2 41374.4 41381.2 6981.0 7106.5 7810.5 7972.2 7988.4 9910.5 10146.6 10154.8 10156.6 10170.9 10015.2 10115.9 10164.2 10174.0 10178.2 7158.7 7358.4 9776.7 10196.0 10431.4 9873.9 9986.3 9995.8 10008.5 10008.6 37684.2 38137.0 38189.6 38256.8 38293.6 2837.3 2842.0 2858.6 2878.1 2908.1 29025.4 29048.6 29154.6 29208.9 29852.6 3347.8 3381.9 3410.3 3445.7 3531.4 219263.0 219294.0 219454.0 220375.0 221161.0 47373.5 48647.0 57113.4 57337.0 57404.7 60572.0 61873.4 61899.7 61983.0 62054.4 14165.1 14495.9 14495.9 14598.4 14618.4 9916.3 9947.4 9951.9 9975.9 9989.9 19227.0 19268.5 19278.1 19350.0 19432.6 7299.6 7602.7 7616.7 7657.3 7743.6 819.3 837.6 948.1 986.5 1000.6 26488.0 26581.9 26728.7 26761.0 26914.7 913.5 950.1 951.9 980.9 1014.0 13824.2 13991.9 14041.8 14241.3 14258.6 268588.0 273404.0 273925.0 274466.0 275066.0 46229.5 46303.5 46519.3 46589.5 46680.3 1182.1 1193.8 1202.6 1212.2 1215.8 24846.1 25551.9 26306.0 26470.6 26572.2 40618.0 41306.6 41366.0 41411.2 41426.0 313358.0 324392.0 355316.0 368742.0 369151.0 26800.5 26869.3 26899.5 26956.0 26993.0 36881.3 39002.6 39293.8 40228.0 40231.0 29680.3 32299.5 33242.7 33480.0 33732.5 29575.0 29614.9 29806.6 29819.6 29875.7 33397.5 34002.8 34038.3 34567.0 34613.1 27339.0 28094.7 29772.7 29979.9 30030.4 21289.0 21501.4 21564.4 21569.6 21582.9 23:12:19 INFO - 2015-12-14 23:12:19,835 DEBUG : BROWSER_OUTPUT: 23:12:19 INFO - 2015-12-14 23:12:19,835 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25535.70 Median:4152.64 stddev:78451.52 (1889.2%) stddev-sans-first:78648.76 23:12:19 INFO - 2015-12-14 23:12:19,837 DEBUG : BROWSER_OUTPUT: Values: 325.3 329.6 333.3 334.6 339.2 12572.6 12966.7 15051.1 15531.0 16052.2 9651.4 9855.3 9879.0 14419.9 14842.2 3876.7 4631.3 4633.9 4634.2 4637.0 3459.6 3572.4 3573.6 3574.4 4800.5 3568.4 5112.9 5277.8 5278.7 5283.2 5131.3 5255.9 5269.6 5280.0 5285.4 5086.1 5092.7 5093.5 5097.7 5098.2 11463.3 12956.7 14382.6 14394.9 14402.6 1656.3 1705.2 1744.8 1769.9 1838.7 8865.0 8890.6 8941.9 9076.2 9158.7 1712.2 1714.9 1742.7 1784.8 1805.5 52590.7 55459.0 55920.7 56391.7 56413.0 9535.9 9680.7 9785.6 9812.8 9900.1 12402.3 12411.1 12424.6 12429.5 12434.3 6518.6 6747.9 6827.9 6939.9 7171.8 6690.5 6859.9 6870.8 6943.2 6951.1 4151.4 4153.9 4168.0 4176.2 4197.2 1617.7 1646.0 1666.3 1669.8 1736.1 364.8 366.6 380.0 763.6 850.3 9304.9 9663.0 9876.3 9926.5 9929.4 350.1 382.9 393.7 401.6 420.3 5530.0 5703.2 8977.8 9291.2 9367.8 474417.0 475635.0 476419.0 481904.0 488776.0 69886.7 71434.0 73569.6 73630.0 75266.6 1103.2 1105.6 1116.1 1133.8 1137.2 14667.7 14814.3 14876.0 15004.2 15385.0 33000.2 33202.2 33335.7 33849.7 34293.0 42186.8 44420.3 44667.8 44735.6 45619.3 8631.7 8774.8 8837.3 8874.6 8955.0 10332.4 10348.1 10384.8 10478.6 10480.9 13339.5 13886.7 13985.4 14343.6 14430.4 13029.3 13681.1 13714.1 13913.7 14142.6 11206.5 11454.3 14200.8 14319.9 14690.8 7273.8 8102.6 8717.7 8724.7 8977.9 12857.2 13008.2 13135.3 13284.8 13679.9 23:12:19 INFO - 2015-12-14 23:12:19,837 DEBUG : BROWSER_OUTPUT: 23:12:19 INFO - 2015-12-14 23:12:19,837 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4708.32 Median:5891.95 stddev:2418.43 (41.0%) stddev-sans-first:2411.39 23:12:19 INFO - 2015-12-14 23:12:19,837 DEBUG : BROWSER_OUTPUT: Values: 1267.3 1408.6 1425.2 1669.8 1736.4 5874.6 6421.9 6547.1 6561.6 6575.9 6606.2 6722.7 6742.2 6745.4 6753.5 1714.1 1748.9 1941.4 1969.2 1980.2 2035.0 2050.2 2051.0 2055.3 2056.9 1952.1 1978.7 2002.0 2002.8 2004.3 1992.1 2004.0 2031.3 2033.1 2048.8 2044.0 2068.5 2068.7 2069.2 2070.1 6680.7 6762.2 6765.1 6767.8 6771.0 3895.0 3987.4 3989.7 3994.2 3996.4 2486.7 2569.0 2573.2 2579.8 2595.7 810.9 814.3 825.2 844.8 879.5 8973.5 9008.7 9011.5 9017.7 9071.1 3637.1 3688.8 3737.3 3756.3 3757.2 7841.7 7851.9 7860.6 7863.1 7865.0 4057.4 4068.8 4111.8 4124.7 4125.5 3687.4 3695.7 3699.5 3717.2 3737.4 2855.5 2894.0 3153.4 3165.2 3257.9 1024.5 1039.4 1042.6 1045.2 1049.5 855.4 855.7 859.8 931.3 1001.3 5989.4 6000.8 6001.9 6007.3 6067.2 1030.1 1047.5 1063.3 1064.2 1086.7 4875.9 4911.3 4934.0 4942.5 4944.4 7934.6 7983.7 8169.2 8192.6 8234.7 8086.9 8164.2 8183.3 8202.6 8223.5 6414.6 6553.5 6556.5 6560.8 6563.5 5985.3 6191.9 6196.5 6200.1 6203.2 7160.3 7276.9 7312.1 7319.9 7386.2 7340.6 7517.7 7550.4 7573.8 7653.2 6030.8 6074.7 6090.9 6095.4 6096.4 5479.9 5787.9 5789.5 5839.9 6332.3 5987.9 5988.1 6047.4 6192.2 6217.6 5904.6 5906.5 6000.2 6035.4 6128.3 5812.5 5986.6 6018.8 6020.6 6035.3 5703.9 5761.8 5764.7 5768.7 5772.0 5838.4 5852.5 5876.6 5888.8 5895.1 23:12:19 INFO - 2015-12-14 23:12:19,837 DEBUG : BROWSER_OUTPUT: 23:12:19 INFO - 2015-12-14 23:12:19,837 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4587.61 Median:5210.87 stddev:1345.75 (25.8%) stddev-sans-first:1310.47 23:12:19 INFO - 2015-12-14 23:12:19,837 DEBUG : BROWSER_OUTPUT: Values: 299.3 301.0 301.8 302.3 306.0 5130.8 5209.0 5212.9 5233.2 5277.1 5067.2 5191.2 5212.8 5237.6 5242.0 4077.7 4088.3 4090.5 4095.3 4101.6 3890.4 3987.4 3998.5 4083.4 4093.5 4037.7 4042.4 4044.1 4050.3 4064.8 4031.6 4038.4 4045.6 4053.7 4066.1 3562.4 3570.8 3575.5 3575.9 3582.2 4975.2 5073.3 5074.1 5076.0 5133.6 4563.5 4565.2 4569.2 4578.8 4614.3 5530.0 5536.6 5540.4 5542.9 5546.6 3591.3 3683.8 3837.2 3899.9 3922.0 5693.6 5770.9 5780.3 5786.5 5792.0 4038.0 4045.5 4045.9 4049.0 4049.8 4097.7 4100.0 4108.1 4108.6 4115.7 4554.8 4656.3 4661.8 4665.7 4671.7 5502.1 5506.4 5509.8 5510.4 5511.2 1394.4 1453.6 1456.8 1457.6 1462.2 991.1 997.9 997.9 1006.9 1020.2 4886.4 4887.0 4887.8 4888.0 4894.3 5718.2 5730.1 5731.3 5734.1 5735.6 4834.1 4849.4 4864.1 4879.0 4887.1 2997.3 3066.9 3090.4 3094.0 3116.4 5479.5 5482.4 5482.9 5485.1 5488.1 5923.4 5929.4 5931.1 5934.1 5934.5 5435.9 5474.3 5475.6 5476.8 5481.8 5646.7 5771.5 5784.6 5785.6 5787.9 5414.2 5485.3 5573.7 5640.0 5650.7 5425.1 5452.0 5465.8 5475.8 5477.0 3771.1 3801.9 3810.7 3846.1 3854.1 5657.9 5791.7 5791.8 5792.8 5793.0 5535.6 5542.3 5542.4 5544.7 5544.8 5410.8 5482.2 5485.1 5506.1 5536.2 5360.8 5383.8 5394.4 5394.5 5395.8 5525.8 5532.8 5555.7 5590.7 5598.2 5344.9 5444.4 5460.0 5460.8 5466.5 23:12:19 INFO - 2015-12-14 23:12:19,837 DEBUG : BROWSER_OUTPUT: 23:12:19 INFO - 2015-12-14 23:12:19,837 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11994.77 Median:578.86 stddev:13591.16 (2347.9%) stddev-sans-first:13602.45 23:12:19 INFO - 2015-12-14 23:12:19,839 DEBUG : BROWSER_OUTPUT: Values: 623.2 730.5 739.5 776.6 785.6 11640.4 11830.3 11847.3 11933.5 11942.6 13128.9 13588.0 13594.2 13595.9 13601.4 625.6 632.8 815.5 815.9 827.1 819.5 821.3 826.4 826.6 827.4 856.1 863.7 864.6 865.2 866.3 653.0 661.7 841.8 856.0 858.2 634.0 635.0 635.0 635.4 636.0 11447.5 11557.0 11588.9 11598.6 11600.1 10633.3 11019.0 11036.2 11267.2 11627.1 9202.3 9411.0 9505.6 9565.9 9709.8 3168.3 3193.7 3248.1 3275.5 3340.1 40995.4 41410.8 41658.6 41698.8 41814.0 9154.6 9240.0 9369.6 9396.4 9428.9 16023.5 16048.4 16049.0 16060.6 16113.7 6072.3 6301.5 6362.0 6385.6 6439.9 3515.8 3533.0 3624.1 3625.3 3630.2 2597.7 2653.4 2660.2 2664.7 2665.2 454.6 454.6 471.3 476.5 479.7 483.8 509.8 543.4 574.2 584.9 8374.7 8390.2 8494.1 8645.7 8815.6 388.3 482.5 583.5 586.0 615.8 3442.8 3644.6 3674.2 3733.8 3850.6 48080.5 48336.3 48487.5 48619.5 48626.8 43598.6 43941.6 44205.3 44573.3 44816.8 39702.4 39714.0 39891.0 40051.8 40274.2 7402.5 7428.7 7465.8 7505.9 7701.4 29570.3 29954.4 30223.2 30481.4 30856.0 35122.1 35696.6 38553.4 39103.0 39269.0 9387.7 9410.8 9448.8 9577.0 9691.0 10081.8 10156.7 10165.7 10209.5 10301.9 9387.0 9490.3 9637.9 9639.1 9682.7 9772.0 9864.0 9906.7 9963.0 9975.2 9112.1 9289.3 9311.8 9367.9 9372.6 8304.8 8375.9 8512.9 8559.6 8625.1 7963.5 8576.7 8605.3 8774.7 8802.2 23:12:19 INFO - 2015-12-14 23:12:19,839 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:12:19 INFO - 2015-12-14 23:12:19,839 DEBUG : BROWSER_OUTPUT: 23:12:20 INFO - 2015-12-14 23:12:20,620 INFO : Browser exited with error code: 0 23:12:20 INFO - 2015-12-14 23:12:20,639 INFO : Completed test dromaeo_css (00:18:37) 23:12:20 INFO - 2015-12-14 23:12:20,639 INFO : Starting test kraken 23:12:20 INFO - 2015-12-14 23:12:20,639 DEBUG : operating with platform_type : linux_ 23:12:20 INFO - 2015-12-14 23:12:20,639 INFO : Initialising browser for kraken test... 23:12:20 INFO - 2015-12-14 23:12:20,645 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN2BUkO/profile http://localhost:40968/getInfo.html 23:12:25 INFO - 2015-12-14 23:12:25,461 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:12:25 INFO - 2015-12-14 23:12:25,461 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:12:25 INFO - 2015-12-14 23:12:25,462 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 23:12:25 INFO - 2015-12-14 23:12:25,462 DEBUG : BROWSER_OUTPUT: __metrics 23:12:25 INFO - 2015-12-14 23:12:25,563 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] 23:12:25 INFO - 2015-12-14 23:12:25,623 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] 23:12:25 ERROR - 2015-12-14 23:12:25,639 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 23:12:26 INFO - 2015-12-14 23:12:26,516 INFO : Browser initialized. 23:12:26 INFO - 2015-12-14 23:12:26,517 INFO : Running cycle 1/1 for kraken test... 23:12:26 INFO - 2015-12-14 23:12:26,517 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN2BUkO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:12:38 INFO - 2015-12-14 23:12:38,526 DEBUG : BROWSER_OUTPUT: RSS: Main: 143302656 23:12:38 INFO - 2015-12-14 23:12:38,526 DEBUG : BROWSER_OUTPUT: 23:12:41 INFO - 2015-12-14 23:12:41,129 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40968/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40968/tests/kraken/driver.html?testName=audio-beat-detection) 23:12:41 INFO - 2015-12-14 23:12:41,715 DEBUG : BROWSER_OUTPUT: RSS: Main: 179662848 23:12:41 INFO - 2015-12-14 23:12:41,715 DEBUG : BROWSER_OUTPUT: 23:12:44 INFO - 2015-12-14 23:12:44,465 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40968/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40968/tests/kraken/driver.html?testName=audio-dft) 23:12:45 INFO - 2015-12-14 23:12:45,047 DEBUG : BROWSER_OUTPUT: RSS: Main: 168546304 23:12:45 INFO - 2015-12-14 23:12:45,047 DEBUG : BROWSER_OUTPUT: 23:12:48 INFO - 2015-12-14 23:12:48,051 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40968/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40968/tests/kraken/driver.html?testName=audio-fft) 23:12:48 INFO - 2015-12-14 23:12:48,613 DEBUG : BROWSER_OUTPUT: RSS: Main: 153161728 23:12:48 INFO - 2015-12-14 23:12:48,613 DEBUG : BROWSER_OUTPUT: 23:12:50 INFO - 2015-12-14 23:12:50,632 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40968/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40968/tests/kraken/driver.html?testName=audio-oscillator) 23:12:51 INFO - 2015-12-14 23:12:51,206 DEBUG : BROWSER_OUTPUT: RSS: Main: 156078080 23:12:51 INFO - 2015-12-14 23:12:51,206 DEBUG : BROWSER_OUTPUT: 23:12:53 INFO - 2015-12-14 23:12:53,468 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40968/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40968/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:12:54 INFO - 2015-12-14 23:12:54,039 DEBUG : BROWSER_OUTPUT: RSS: Main: 156663808 23:12:54 INFO - 2015-12-14 23:12:54,040 DEBUG : BROWSER_OUTPUT: 23:12:57 INFO - 2015-12-14 23:12:57,047 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40968/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40968/tests/kraken/driver.html?testName=imaging-darkroom) 23:12:57 INFO - 2015-12-14 23:12:57,629 DEBUG : BROWSER_OUTPUT: RSS: Main: 157917184 23:12:57 INFO - 2015-12-14 23:12:57,629 DEBUG : BROWSER_OUTPUT: 23:13:00 INFO - 2015-12-14 23:13:00,996 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40968/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40968/tests/kraken/driver.html?testName=imaging-desaturate) 23:13:01 INFO - 2015-12-14 23:13:01,577 DEBUG : BROWSER_OUTPUT: RSS: Main: 159248384 23:13:01 INFO - 2015-12-14 23:13:01,577 DEBUG : BROWSER_OUTPUT: 23:13:04 INFO - 2015-12-14 23:13:04,469 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40968/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40968/tests/kraken/driver.html?testName=json-parse-financial) 23:13:05 INFO - 2015-12-14 23:13:05,042 DEBUG : BROWSER_OUTPUT: RSS: Main: 158797824 23:13:05 INFO - 2015-12-14 23:13:05,042 DEBUG : BROWSER_OUTPUT: 23:13:06 INFO - 2015-12-14 23:13:06,824 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40968/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40968/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:13:07 INFO - 2015-12-14 23:13:07,389 DEBUG : BROWSER_OUTPUT: RSS: Main: 166825984 23:13:07 INFO - 2015-12-14 23:13:07,389 DEBUG : BROWSER_OUTPUT: 23:13:09 INFO - 2015-12-14 23:13:09,280 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40968/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40968/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:13:09 INFO - 2015-12-14 23:13:09,878 DEBUG : BROWSER_OUTPUT: RSS: Main: 167198720 23:13:09 INFO - 2015-12-14 23:13:09,878 DEBUG : BROWSER_OUTPUT: 23:13:12 INFO - 2015-12-14 23:13:12,083 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40968/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40968/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:13:12 INFO - 2015-12-14 23:13:12,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 179662848 23:13:12 INFO - 2015-12-14 23:13:12,666 DEBUG : BROWSER_OUTPUT: 23:13:15 INFO - 2015-12-14 23:13:15,246 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40968/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40968/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:13:15 INFO - 2015-12-14 23:13:15,831 DEBUG : BROWSER_OUTPUT: RSS: Main: 184307712 23:13:15 INFO - 2015-12-14 23:13:15,832 DEBUG : BROWSER_OUTPUT: 23:13:18 INFO - 2015-12-14 23:13:18,534 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40968/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40968/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:13:19 INFO - 2015-12-14 23:13:19,120 DEBUG : BROWSER_OUTPUT: RSS: Main: 180674560 23:13:19 INFO - 2015-12-14 23:13:19,120 DEBUG : BROWSER_OUTPUT: 23:13:20 INFO - 2015-12-14 23:13:20,909 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40968/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40968/tests/kraken/driver.html?testName=ai-astar) 23:13:21 INFO - 2015-12-14 23:13:21,159 DEBUG : BROWSER_OUTPUT: RSS: Main: 239370240 23:13:21 INFO - 2015-12-14 23:13:21,160 DEBUG : BROWSER_OUTPUT: 23:13:21 INFO - 2015-12-14 23:13:21,161 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:13:21 INFO - 2015-12-14 23:13:21,161 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:13:21 INFO - 2015-12-14 23:13:21,162 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:13:21 INFO - 2015-12-14 23:13:21,163 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:13:21 INFO - 2015-12-14 23:13:21,163 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;116;107;113;114;114;103;115;112;121 23:13:21 INFO - 2015-12-14 23:13:21,163 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;162;128;163;165;132;157;152;131;168;131 23:13:21 INFO - 2015-12-14 23:13:21,164 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;160;161;161;161;162;161;161;162 23:13:21 INFO - 2015-12-14 23:13:21,164 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;85;88;72;78;75;99;89;73 23:13:21 INFO - 2015-12-14 23:13:21,164 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;133;93;94;95;128;94;95;130 23:13:21 INFO - 2015-12-14 23:13:21,164 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;110;109;109;109;109;110;109 23:13:21 INFO - 2015-12-14 23:13:21,165 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;147;146;147;147;146;147;146;147 23:13:21 INFO - 2015-12-14 23:13:21,165 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;96;95;95;96;95;95;95 23:13:21 INFO - 2015-12-14 23:13:21,165 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;73;72;72;72;73;73;81;70;72 23:13:21 INFO - 2015-12-14 23:13:21,165 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;70;68;68;69;70;69;69;68;69 23:13:21 INFO - 2015-12-14 23:13:21,165 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;88;88;87;99;87;88;88;88;88 23:13:21 INFO - 2015-12-14 23:13:21,166 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;130;119;119;133;123;121;133;126;121 23:13:21 INFO - 2015-12-14 23:13:21,166 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;146;147;158;157;164;146;170;155;154;143 23:13:21 INFO - 2015-12-14 23:13:21,166 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;71;72;71;74;71;72;73;74;71 23:13:21 INFO - 2015-12-14 23:13:21,166 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:13:21 INFO - 2015-12-14 23:13:21,167 DEBUG : BROWSER_OUTPUT: __start_cc_report 23:13:21 INFO - 2015-12-14 23:13:21,167 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,984 23:13:21 INFO - 2015-12-14 23:13:21,167 DEBUG : BROWSER_OUTPUT: __end_cc_report 23:13:21 INFO - 2015-12-14 23:13:21,167 DEBUG : BROWSER_OUTPUT: __startTimestamp1450163601160__endTimestamp 23:13:21 INFO - 2015-12-14 23:13:21,168 DEBUG : BROWSER_OUTPUT: 23:13:21 INFO - 2015-12-14 23:13:21,169 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:13:21 INFO - 2015-12-14 23:13:21,169 DEBUG : BROWSER_OUTPUT: Number of tests: 14 23:13:21 INFO - 2015-12-14 23:13:21,169 DEBUG : BROWSER_OUTPUT: 23:13:21 INFO - 2015-12-14 23:13:21,170 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.70 Median:114.00 stddev:4.90 (4.3%) stddev-sans-first:5.19 23:13:21 INFO - 2015-12-14 23:13:21,170 DEBUG : BROWSER_OUTPUT: Values: 112.0 116.0 107.0 113.0 114.0 114.0 103.0 115.0 112.0 121.0 23:13:21 INFO - 2015-12-14 23:13:21,170 DEBUG : BROWSER_OUTPUT: 23:13:21 INFO - 2015-12-14 23:13:21,171 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.90 Median:159.50 stddev:16.44 (10.3%) stddev-sans-first:16.74 23:13:21 INFO - 2015-12-14 23:13:21,171 DEBUG : BROWSER_OUTPUT: Values: 162.0 128.0 163.0 165.0 132.0 157.0 152.0 131.0 168.0 131.0 23:13:21 INFO - 2015-12-14 23:13:21,171 DEBUG : BROWSER_OUTPUT: 23:13:21 INFO - 2015-12-14 23:13:21,171 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 23:13:21 INFO - 2015-12-14 23:13:21,172 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 160.0 161.0 161.0 161.0 162.0 161.0 161.0 162.0 23:13:21 INFO - 2015-12-14 23:13:21,172 DEBUG : BROWSER_OUTPUT: 23:13:21 INFO - 2015-12-14 23:13:21,172 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.50 Median:81.50 stddev:9.24 (11.3%) stddev-sans-first:9.39 23:13:21 INFO - 2015-12-14 23:13:21,172 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 85.0 88.0 72.0 78.0 75.0 99.0 89.0 73.0 23:13:21 INFO - 2015-12-14 23:13:21,172 DEBUG : BROWSER_OUTPUT: 23:13:21 INFO - 2015-12-14 23:13:21,172 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.20 Median:94.50 stddev:17.40 (18.4%) stddev-sans-first:18.06 23:13:21 INFO - 2015-12-14 23:13:21,172 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 133.0 93.0 94.0 95.0 128.0 94.0 95.0 130.0 23:13:21 INFO - 2015-12-14 23:13:21,173 DEBUG : BROWSER_OUTPUT: 23:13:21 INFO - 2015-12-14 23:13:21,174 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 23:13:21 INFO - 2015-12-14 23:13:21,174 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 110.0 109.0 23:13:21 INFO - 2015-12-14 23:13:21,174 DEBUG : BROWSER_OUTPUT: 23:13:21 INFO - 2015-12-14 23:13:21,174 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 23:13:21 INFO - 2015-12-14 23:13:21,174 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 147.0 146.0 147.0 147.0 146.0 147.0 146.0 147.0 23:13:21 INFO - 2015-12-14 23:13:21,174 DEBUG : BROWSER_OUTPUT: 23:13:21 INFO - 2015-12-14 23:13:21,174 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 23:13:21 INFO - 2015-12-14 23:13:21,175 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 23:13:21 INFO - 2015-12-14 23:13:21,175 DEBUG : BROWSER_OUTPUT: 23:13:21 INFO - 2015-12-14 23:13:21,175 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.00 Median:72.50 stddev:2.94 (4.1%) stddev-sans-first:3.10 23:13:21 INFO - 2015-12-14 23:13:21,175 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 72.0 72.0 72.0 73.0 73.0 81.0 70.0 72.0 23:13:21 INFO - 2015-12-14 23:13:21,175 DEBUG : BROWSER_OUTPUT: 23:13:21 INFO - 2015-12-14 23:13:21,175 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:0.79 (1.1%) stddev-sans-first:0.78 23:13:21 INFO - 2015-12-14 23:13:21,175 DEBUG : BROWSER_OUTPUT: Values: 68.0 70.0 68.0 68.0 69.0 70.0 69.0 69.0 68.0 69.0 23:13:21 INFO - 2015-12-14 23:13:21,175 DEBUG : BROWSER_OUTPUT: 23:13:21 INFO - 2015-12-14 23:13:21,175 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.70 Median:88.00 stddev:3.68 (4.2%) stddev-sans-first:3.77 23:13:21 INFO - 2015-12-14 23:13:21,176 DEBUG : BROWSER_OUTPUT: Values: 86.0 88.0 88.0 87.0 99.0 87.0 88.0 88.0 88.0 88.0 23:13:21 INFO - 2015-12-14 23:13:21,176 DEBUG : BROWSER_OUTPUT: 23:13:21 INFO - 2015-12-14 23:13:21,176 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.40 Median:127.50 stddev:5.54 (4.3%) stddev-sans-first:5.72 23:13:21 INFO - 2015-12-14 23:13:21,176 DEBUG : BROWSER_OUTPUT: Values: 129.0 130.0 119.0 119.0 133.0 123.0 121.0 133.0 126.0 121.0 23:13:21 INFO - 2015-12-14 23:13:21,176 DEBUG : BROWSER_OUTPUT: 23:13:21 INFO - 2015-12-14 23:13:21,176 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.00 Median:156.00 stddev:8.69 (5.6%) stddev-sans-first:8.72 23:13:21 INFO - 2015-12-14 23:13:21,176 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 158.0 157.0 164.0 146.0 170.0 155.0 154.0 143.0 23:13:21 INFO - 2015-12-14 23:13:21,176 DEBUG : BROWSER_OUTPUT: 23:13:21 INFO - 2015-12-14 23:13:21,176 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:72.00 stddev:1.25 (1.7%) stddev-sans-first:1.27 23:13:21 INFO - 2015-12-14 23:13:21,176 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 72.0 71.0 74.0 71.0 72.0 73.0 74.0 71.0 23:13:21 INFO - 2015-12-14 23:13:21,177 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:13:21 INFO - 2015-12-14 23:13:21,177 DEBUG : BROWSER_OUTPUT: 23:13:22 INFO - 2015-12-14 23:13:22,104 INFO : Browser exited with error code: 0 23:13:22 INFO - 2015-12-14 23:13:22,160 INFO : Completed test kraken (00:01:01) 23:13:22 INFO - 2015-12-14 23:13:22,160 INFO : Starting test v8_7 23:13:22 INFO - 2015-12-14 23:13:22,160 DEBUG : operating with platform_type : linux_ 23:13:22 INFO - 2015-12-14 23:13:22,160 INFO : Initialising browser for v8_7 test... 23:13:22 INFO - 2015-12-14 23:13:22,166 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3XcZ8q/profile http://localhost:40968/getInfo.html 23:13:26 INFO - 2015-12-14 23:13:26,672 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:13:26 INFO - 2015-12-14 23:13:26,672 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:13:26 INFO - 2015-12-14 23:13:26,672 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 23:13:26 INFO - 2015-12-14 23:13:26,672 DEBUG : BROWSER_OUTPUT: __metrics 23:13:26 INFO - 2015-12-14 23:13:26,794 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] 23:13:26 INFO - 2015-12-14 23:13:26,891 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] 23:13:28 INFO - 2015-12-14 23:13:28,171 INFO : Browser initialized. 23:13:28 INFO - 2015-12-14 23:13:28,172 INFO : Running cycle 1/1 for v8_7 test... 23:13:28 INFO - 2015-12-14 23:13:28,172 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3XcZ8q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:13:40 INFO - 2015-12-14 23:13:40,177 DEBUG : BROWSER_OUTPUT: RSS: Main: 143319040 23:13:40 INFO - 2015-12-14 23:13:40,177 DEBUG : BROWSER_OUTPUT: 23:14:01 INFO - 2015-12-14 23:14:01,558 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40968/tests/v8_7/run.html (next: http://localhost:40968/tests/v8_7/run.html) 23:14:01 INFO - 2015-12-14 23:14:01,808 DEBUG : BROWSER_OUTPUT: RSS: Main: 443777024 23:14:01 INFO - 2015-12-14 23:14:01,808 DEBUG : BROWSER_OUTPUT: 23:14:01 INFO - 2015-12-14 23:14:01,809 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:14:01 INFO - 2015-12-14 23:14:01,810 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:14:01 INFO - 2015-12-14 23:14:01,810 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:14:01 INFO - 2015-12-14 23:14:01,810 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:14:01 INFO - 2015-12-14 23:14:01,810 DEBUG : BROWSER_OUTPUT: |0;Richards;166.38935108153078 23:14:01 INFO - 2015-12-14 23:14:01,810 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;190.94901661256444 23:14:01 INFO - 2015-12-14 23:14:01,810 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.6291446085261 23:14:01 INFO - 2015-12-14 23:14:01,810 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5170.103092783505 23:14:01 INFO - 2015-12-14 23:14:01,810 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1986.111111111111 23:14:01 INFO - 2015-12-14 23:14:01,810 DEBUG : BROWSER_OUTPUT: |5;Earley;788.0220646178093 23:14:01 INFO - 2015-12-14 23:14:01,810 DEBUG : BROWSER_OUTPUT: |6;Boyer;11988.095238095239 23:14:01 INFO - 2015-12-14 23:14:01,810 DEBUG : BROWSER_OUTPUT: |7;RegExp;26789.473684210527 23:14:01 INFO - 2015-12-14 23:14:01,810 DEBUG : BROWSER_OUTPUT: |8;Splay;621.8905472636816 23:14:01 INFO - 2015-12-14 23:14:01,810 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 23:14:01 INFO - 2015-12-14 23:14:01,811 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:14:01 INFO - 2015-12-14 23:14:01,811 DEBUG : BROWSER_OUTPUT: __startTimestamp1450163641809__endTimestamp 23:14:01 INFO - 2015-12-14 23:14:01,811 DEBUG : BROWSER_OUTPUT: 23:14:01 INFO - 2015-12-14 23:14:01,811 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:14:01 INFO - 2015-12-14 23:14:01,811 DEBUG : BROWSER_OUTPUT: Number of tests: 10 23:14:01 INFO - 2015-12-14 23:14:01,811 DEBUG : BROWSER_OUTPUT: 23:14:01 INFO - 2015-12-14 23:14:01,811 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.39 Median:166.39 stddev:0.00 (0.0%) 23:14:01 INFO - 2015-12-14 23:14:01,811 DEBUG : BROWSER_OUTPUT: Values: 166.4 23:14:01 INFO - 2015-12-14 23:14:01,811 DEBUG : BROWSER_OUTPUT: 23:14:01 INFO - 2015-12-14 23:14:01,811 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:190.95 Median:190.95 stddev:0.00 (0.0%) 23:14:01 INFO - 2015-12-14 23:14:01,811 DEBUG : BROWSER_OUTPUT: Values: 190.9 23:14:01 INFO - 2015-12-14 23:14:01,812 DEBUG : BROWSER_OUTPUT: 23:14:01 INFO - 2015-12-14 23:14:01,812 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.63 Median:278.63 stddev:0.00 (0.0%) 23:14:01 INFO - 2015-12-14 23:14:01,812 DEBUG : BROWSER_OUTPUT: Values: 278.6 23:14:01 INFO - 2015-12-14 23:14:01,812 DEBUG : BROWSER_OUTPUT: 23:14:01 INFO - 2015-12-14 23:14:01,813 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 23:14:01 INFO - 2015-12-14 23:14:01,814 DEBUG : BROWSER_OUTPUT: Values: 5170.1 23:14:01 INFO - 2015-12-14 23:14:01,814 DEBUG : BROWSER_OUTPUT: 23:14:01 INFO - 2015-12-14 23:14:01,814 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1986.11 Median:1986.11 stddev:0.00 (0.0%) 23:14:01 INFO - 2015-12-14 23:14:01,814 DEBUG : BROWSER_OUTPUT: Values: 1986.1 23:14:01 INFO - 2015-12-14 23:14:01,814 DEBUG : BROWSER_OUTPUT: 23:14:01 INFO - 2015-12-14 23:14:01,814 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:788.02 Median:788.02 stddev:0.00 (0.0%) 23:14:01 INFO - 2015-12-14 23:14:01,814 DEBUG : BROWSER_OUTPUT: Values: 788.0 23:14:01 INFO - 2015-12-14 23:14:01,814 DEBUG : BROWSER_OUTPUT: 23:14:01 INFO - 2015-12-14 23:14:01,815 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11988.10 Median:11988.10 stddev:0.00 (0.0%) 23:14:01 INFO - 2015-12-14 23:14:01,815 DEBUG : BROWSER_OUTPUT: Values: 11988.1 23:14:01 INFO - 2015-12-14 23:14:01,815 DEBUG : BROWSER_OUTPUT: 23:14:01 INFO - 2015-12-14 23:14:01,815 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26789.47 Median:26789.47 stddev:0.00 (0.0%) 23:14:01 INFO - 2015-12-14 23:14:01,815 DEBUG : BROWSER_OUTPUT: Values: 26789.5 23:14:01 INFO - 2015-12-14 23:14:01,815 DEBUG : BROWSER_OUTPUT: 23:14:01 INFO - 2015-12-14 23:14:01,815 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:621.89 Median:621.89 stddev:0.00 (0.0%) 23:14:01 INFO - 2015-12-14 23:14:01,816 DEBUG : BROWSER_OUTPUT: Values: 621.9 23:14:01 INFO - 2015-12-14 23:14:01,816 DEBUG : BROWSER_OUTPUT: 23:14:01 INFO - 2015-12-14 23:14:01,816 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 23:14:01 INFO - 2015-12-14 23:14:01,816 DEBUG : BROWSER_OUTPUT: Values: 4835.7 23:14:01 INFO - 2015-12-14 23:14:01,816 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:14:01 INFO - 2015-12-14 23:14:01,816 DEBUG : BROWSER_OUTPUT: 23:14:02 INFO - 2015-12-14 23:14:02,724 INFO : Browser exited with error code: 0 23:14:02 INFO - 2015-12-14 23:14:02,741 INFO : Completed test v8_7 (00:00:40) 23:14:02 INFO - 2015-12-14 23:14:02,855 INFO : Completed test suite (00:20:19) 23:14:02 INFO - 2015-12-14 23:14:02,856 DEBUG : Working with test: dromaeo_css 23:14:02 INFO - 2015-12-14 23:14:02,856 DEBUG : Generating results file: dromaeo_css 23:14:02 INFO - 2015-12-14 23:14:02,857 DEBUG : Working with test: kraken 23:14:02 INFO - 2015-12-14 23:14:02,857 DEBUG : Generating results file: kraken 23:14:02 INFO - 2015-12-14 23:14:02,857 INFO : javascript benchmark 23:14:02 INFO - 2015-12-14 23:14:02,858 DEBUG : Working with test: v8_7 23:14:02 INFO - 2015-12-14 23:14:02,858 DEBUG : Generating results file: v8_7 23:14:02 INFO - 2015-12-14 23:14:02,858 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:14:02 INFO - 2015-12-14 23:14:02,913 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 23:14:02 INFO - 2015-12-14 23:14:02,913 DEBUG : process_Request line: dromaeo_css 6154.64 graph.html#tests=[[72,132,35]] 23:14:02 INFO - 2015-12-14 23:14:02,913 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:14:02 INFO - 2015-12-14 23:14:02,943 DEBUG : process_Request line: kraken 1541.50 graph.html#tests=[[232,132,35]] 23:14:02 INFO - 2015-12-14 23:14:02,943 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:14:02 INFO - 2015-12-14 23:14:02,975 DEBUG : process_Request line: v8_7 19743.25 graph.html#tests=[[230,132,35]] 23:14:02 INFO - 2015-12-14 23:14:02,976 INFO : javascript benchmark 23:14:03 INFO - 2015-12-14 23:14:02,980 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2582.2511471673215, 2697.042549894788, 2697.784177265819, 2701.1356365962874, 2707.1607801581513, 4549.0, 4629.976850115749, 4669.463011753649, 4677.1347300749385, 4704.976475117628, 4541.636669066475, 4641.0949864776385, 4694.530546945304, 4713.457952335482, 4717.363155973942, 4250.61744443, 4265.0, 4320.222359975203, 4377.124575084979, 4388.780560971939, 4310.82756689732, 4363.454568178978, 4380.430544029272, 4385.0, 4421.182081314951, 4127.731697439672, 4231.70378073535, 4282.314829627245, 4337.110892267077, 4342.435483387171, 4292.270314046619, 4316.6978311518205, 4317.309230523133, 4338.479382474124, 4351.760653164075, 4276.957230427687, 4283.100548884707, 4284.5715428457215, 4284.721493102938, 4318.784060796947, 4386.100849325912, 4475.664325175625, 4499.212637788374, 4527.094581083797, 4689.718616882998, 5074.213496907985, 5075.670081444731, 5085.974570127163, 5088.0587091388215, 5116.897662046776, 5099.056674515226, 5103.055934652101, 5103.668261562986, 5111.361079865017, 5151.4333423323405, 4582.221022426195, 4688.343631891538, 4689.554492323224, 4690.202665546865, 4711.316859055452, 5060.898782024339, 5167.354080739908, 5169.043726910533, 5187.170052791535, 5197.7141257231215, 4966.056449274699, 4986.601071914238, 4999.200127979579, 5006.74966251686, 5053.69677819332, 4891.828785992473, 5009.073321435546, 5088.0587091388215, 5088.363954505687, 5101.285819985205, 4936.432310284364, 4978.377702787152, 5027.195648696191, 5044.596432285409, 5046.571041461517, 4986.401631804207, 4998.525140111684, 5006.299118123466, 5007.148784706608, 5050.4949505049935, 4172.311568591149, 4204.306289462204, 4207.0, 4207.431996680409, 4245.511766146933, 3541.1678255609913, 3621.2033352662897, 3646.4530320451613, 3668.4497325401403, 3721.0, 4361.433013708198, 4369.0, 4372.497162826252, 4373.671974601918, 4408.9859332353735, 5068.265101560253, 5072.873178170502, 5077.543021128043, 5083.161278389024, 5092.9745351273, 4177.665786737054, 4265.893352666209, 4268.08236229206, 4271.722338048079, 4359.149965756647, 4502.077074199781, 4509.954900451019, 4521.706089104264, 4543.795529201194, 4560.270356742905, 4819.7108173509705, 4821.831235906797, 4821.879453013633, 4832.395950506187, 4882.7314497701545, 4874.756262186947, 4937.456879743298, 4975.452700202903, 4978.27814966835, 5104.515071068243, 4774.665773395829, 4776.5701086902345, 4777.0684716479955, 4825.396825396825, 4845.563899249085, 4978.2781496682055, 4982.576480999156, 4991.900161996812, 5003.099442100457, 5029.044481548494, 4773.0, 4935.925961110514, 4948.727819969936, 4954.083494553375, 5111.87220319495, 4850.272459131017, 4851.078295123915, 4878.365812444502, 4894.975525122351, 4935.457099718957, 4839.637027222902, 4840.83057093, 4844.32179494864, 4859.611231101574, 4897.730624815669, 4528.366028756042, 4647.488776234544, 4680.578747912704, 4683.718976861399, 4786.042791441656, 4927.581155601814, 4935.605151587936, 4937.9259311109645, 4938.629602779878, 5003.024410239968, 4827.179379505563, 4839.903201936012, 4843.007183527298, 4843.903121937612, 4883.121038213014], "unit": "ms", "name": "dojo.html", "value": 4605.235178483742}, {"lowerIsBetter": false, "replicates": [570.8915306091842, 572.8138355034614, 578.22517826113, 582.3157789597224, 585.8330375842886, 27347.0, 36538.451923221175, 37643.623563764355, 37661.0, 37675.62324376756, 40490.39264411036, 41283.17433651325, 41320.173596528126, 41374.37938430926, 41381.17237655245, 6980.965095174517, 7106.467014973872, 7810.453268271209, 7972.202779722011, 7988.440809143333, 9910.504474776268, 10146.64486742964, 10154.847677284846, 10156.644517441891, 10170.9491452543, 10015.19878409729, 10115.898841011569, 10164.237682173829, 10174.03346682064, 10178.185745140408, 7158.749443769495, 7358.448116391239, 9776.657816976407, 10196.0, 10431.374117552896, 9873.864505581807, 9986.300958932878, 9995.75010624733, 10008.49957502122, 10008.59965601375, 37684.24631507382, 38137.0, 38189.61810381888, 38256.80871595624, 38293.61706382956, 2837.3048603092375, 2842.0, 2858.6283783108065, 2878.107786586144, 2908.0694177863093, 29025.41949161026, 29048.56427153573, 29154.562681559793, 29208.853955730297, 29852.55221171684, 3347.7991320520846, 3381.881634142818, 3410.300888317889, 3445.6898879101, 3531.3820081485637, 219263.0, 219294.0, 219454.0, 220374.9999999984, 221161.0, 47373.5262647376, 48647.0, 57113.42886571164, 57337.0, 57404.71297643485, 60572.0, 61873.381266187665, 61899.6905015481, 61983.0, 62054.37945620577, 14165.079269847427, 14495.855041449662, 14495.912806539553, 14598.41606335756, 14618.415263389557, 9916.25628077897, 9947.353422027545, 9951.850722239173, 9975.850362244571, 9989.850152247722, 19227.0, 19268.518287042654, 19278.13248403825, 19350.0, 19432.611347773247, 7299.598522081336, 7602.7339043133225, 7616.7334143304715, 7657.310842024244, 7743.574103424366, 819.2708489444399, 837.5560952695081, 948.0661548374845, 986.5166068626465, 1000.5947591225565, 26488.0, 26581.867090664422, 26728.732712673012, 26761.0, 26914.730852691613, 913.5477938420391, 950.1496160936061, 951.8952915179325, 980.8921018687938, 1013.9543720532594, 13824.239666818221, 13991.86008139926, 14041.78937315941, 14241.287935603179, 14258.643533911527, 268588.0, 273404.0, 273925.0, 274466.0, 275066.0, 46229.537704622526, 46303.5369646306, 46519.30221046687, 46589.5341046592, 46680.299795503095, 1182.0720734223764, 1193.8448001759716, 1202.60314096348, 1212.1999480342931, 1215.7629262293767, 24846.130385436423, 25551.872240638677, 26306.0, 26470.602940956287, 26572.202833915013, 40618.0, 41306.586934130275, 41366.0, 41411.1717765637, 41426.0, 313358.0, 324392.0, 355316.0, 368742.0, 369151.0, 26800.463990719687, 26869.328266793487, 26899.462010760068, 26956.0, 26993.0, 36881.26237475289, 39002.60997390103, 39293.803530982164, 40228.0, 40231.0, 29680.257993550335, 32299.51550726788, 33242.66757332395, 33480.0, 33732.49401258934, 29575.0, 29614.851925740233, 29806.552901706058, 29819.552706708982, 29875.70124298816, 33397.49903751494, 34002.829985849916, 34038.319233615686, 34567.0, 34613.13467163341, 27339.0, 28094.71905280921, 29772.702272976992, 29979.850100749358, 30030.3993920116, 21289.0, 21501.354959351243, 21564.35306940794, 21569.568608627425, 21582.8920855401], "unit": "ms", "name": "ext.html", "value": 17336.12033307728}, {"lowerIsBetter": false, "replicates": [325.2924888367801, 329.55180953902703, 333.25849983786065, 334.6168636910737, 339.2367173858818, 12572.622821315352, 12966.675833104176, 15051.096934183943, 15530.990485618428, 16052.197390130505, 9651.420914745102, 9855.310128291023, 9878.950605246964, 14419.855801441983, 14842.183679897602, 3876.6511014008734, 4631.328457373679, 4633.93049104262, 4634.165850146972, 4636.953630463686, 3459.636738142484, 3572.4462708280257, 3573.5533058367705, 3574.3566158091535, 4800.49594792547, 3568.4290513517844, 5112.8977420451565, 5277.8416647500635, 5278.736063196844, 5283.233931079991, 5131.281620573122, 5255.947440525603, 5269.6311258211945, 5280.023195708806, 5285.418603953562, 5086.084504789136, 5092.7453627318855, 5093.5415812576675, 5097.6941383517105, 5098.235264710286, 11463.31220126795, 12956.676083097904, 14382.568522944328, 14394.856051439561, 14402.567922962327, 1656.2960741684856, 1705.2326453096157, 1744.834240747127, 1769.8672599554957, 1838.7333836593752, 8864.955675221647, 8890.555472226428, 8941.865872011926, 9076.183143517115, 9158.679446219418, 1712.1952682239453, 1714.8885322454125, 1742.7473016412548, 1784.794748603901, 1805.494461550768, 52590.737046314905, 55458.9999999996, 55920.72039639817, 56391.71804140953, 56413.0, 9535.856962145574, 9680.661176858775, 9785.559649815776, 9812.754681132887, 9900.108990190773, 12402.317872516918, 12411.131220814637, 12424.56514022005, 12429.502819887104, 12434.316112613713, 6518.57629254097, 6747.932520674731, 6827.897581536281, 6939.861202775916, 7171.784846454615, 6690.498212634072, 6859.9314006860295, 6870.793876183722, 6943.236244013155, 6951.061606683134, 4151.3772934059525, 4153.896152596149, 4168.0, 4176.18564379943, 4197.223513649985, 1617.6683779825107, 1645.95885102871, 1666.3251383189827, 1669.7578851066528, 1736.0885535094176, 364.7756629672732, 366.5839272425816, 380.0062835684665, 763.5914785589794, 850.3197442046462, 9304.93273542595, 9663.0, 9876.308658393988, 9926.454045027593, 9929.404235745878, 350.14389816897443, 382.87747920665674, 393.6791514915335, 401.6224748736179, 420.26663472241137, 5529.972350138223, 5703.17303990919, 8977.775555611031, 9291.21024712907, 9367.765805854908, 474417.0, 475635.0, 476419.0, 481904.0, 488776.0, 69886.65056674786, 71434.0, 73569.63215183996, 73630.0, 75266.62366688241, 1103.150574057971, 1105.607509334207, 1116.1182665694173, 1133.8469306643663, 1137.181229514748, 14667.706645867236, 14814.333354999266, 14876.0, 15004.174770387734, 15385.0, 33000.174995625304, 33202.16994575155, 33335.66664333326, 33849.661503385636, 34293.0, 42186.78906605447, 44420.333694993955, 44667.776661116484, 44735.55264447314, 45619.315710263705, 8631.654733810577, 8774.837743384922, 8837.293016558788, 8874.60064297121, 8955.0, 10332.431716255678, 10348.120409765253, 10384.792304153723, 10478.637777089234, 10480.895191047992, 13339.466421343037, 13886.652833678834, 13985.370658320197, 14343.56969290923, 14430.42278308856, 13029.348532573144, 13681.110727802661, 13714.108582942077, 13913.652158696113, 14142.575722728334, 11206.495707693337, 11454.255473394536, 14200.786988195392, 14319.856801432268, 14690.779638305221, 7273.818154546178, 8102.635381407733, 8717.694880679146, 8724.69463568772, 8977.865332020156, 12857.228566286052, 13008.154469959421, 13135.277559734306, 13284.80072798928, 13679.86320136786], "unit": "ms", "name": "jquery.html", "value": 7529.3473955946265}, {"lowerIsBetter": false, "replicates": [1267.252321130533, 1408.6407965968683, 1425.2232533269366, 1669.8330166983299, 1736.366226327391, 5874.559408044398, 6421.871562568752, 6547.148870646809, 6561.6391098489685, 6575.901361479576, 6606.2072551293795, 6722.6974786134615, 6742.190937087556, 6745.426638735701, 6753.493487988409, 1714.1000974488431, 1748.9038102904335, 1941.4272789527124, 1969.2024729984307, 1980.2178139634836, 2034.9593008139827, 2050.179928028793, 2051.005262447719, 2055.2703790154505, 2056.938291851247, 1952.0532541717255, 1978.6834106542956, 2001.9699704504444, 2002.7696814866258, 2004.2584243829804, 1992.1234656751128, 2003.9599208015832, 2031.329661211804, 2033.054629597237, 2048.7541495020546, 2044.0188709419413, 2068.503559145809, 2068.6896965455153, 2069.151647824385, 2070.130545171032, 6680.665966701694, 6762.154730658668, 6765.086713293692, 6767.796966091025, 6770.966145169243, 3894.9805250973845, 3987.4018897165656, 3989.7207195496326, 3994.201159768029, 3996.440498330236, 2486.7015958084967, 2568.9871550642315, 2573.2280315905155, 2579.7678208961283, 2595.740425957408, 810.8580998325269, 814.2712272516125, 825.1748251748252, 844.8141408890034, 879.4503435352905, 8973.461592304417, 9008.729738107868, 9011.549422528913, 9017.684381046698, 9071.138241867078, 3637.1452708613456, 3688.797116158637, 3737.252549490113, 3756.2675278320467, 3757.1922036762226, 7841.686332546748, 7851.921480785233, 7860.567668778158, 7863.13505514393, 7865.0, 4057.350823868167, 4068.7762173080173, 4111.814968326433, 4124.731892426983, 4125.484314460692, 3687.4468829675225, 3695.667389934919, 3699.5190625218547, 3717.182219911615, 3737.364648009845, 2855.486012517725, 2894.0, 3153.44814657434, 3165.1612322734495, 3257.885973990899, 1024.5440778853338, 1039.4231201683137, 1042.5517027678172, 1045.1586472889246, 1049.5434485998614, 855.3713020929612, 855.6534603485599, 859.8065435277138, 931.3387494878712, 1001.3341128149699, 5989.371116032841, 6000.819975400657, 6001.939980600226, 6007.279126504847, 6067.180930574316, 1030.1192480429274, 1047.5181416548473, 1063.2982231727024, 1064.2284343850647, 1086.7011571817814, 4875.878103047381, 4911.263310503453, 4934.0, 4942.456329803718, 4944.3572335596145, 7934.642941067666, 7983.680652773824, 8169.223923727236, 8192.631331590093, 8234.670613175525, 8086.919130808734, 8164.183581641907, 8183.304419124441, 8202.630881610341, 8223.54770487629, 6414.647194404352, 6553.541252112402, 6556.475481961432, 6560.8359791005605, 6563.50773691975, 5985.341612422717, 6191.876162476815, 6196.47329976957, 6200.131981522501, 6203.16257305258, 7160.283971603007, 7276.854462910606, 7312.085989251344, 7319.890201647086, 7386.15059268191, 7340.632968351454, 7517.699292028257, 7550.3582195514, 7573.848523029619, 7653.158152603321, 6030.849228769141, 6074.696265186812, 6090.908636370546, 6095.420935011167, 6096.420840020191, 5479.890402192013, 5787.884242315215, 5789.507891829073, 5839.854003649943, 6332.271788744353, 5987.88024239504, 5988.131720900358, 6047.425494578008, 6192.164057852132, 6217.595856269328, 5904.61619994699, 5906.5233691577105, 6000.249968753906, 6035.426634469718, 6128.32588415265, 5812.476877081083, 5986.640801551921, 6018.849528761641, 6020.638761674313, 6035.336113027652, 5703.857403564944, 5761.798337058183, 5764.654120752601, 5768.711564421678, 5771.971140144273, 5838.4453476919625, 5852.473277405054, 5876.6180198288685, 5888.793892213752, 5895.115732639967], "unit": "ms", "name": "mootools.html", "value": 3882.949467537042}, {"lowerIsBetter": false, "replicates": [299.254855410029, 301.0351822409179, 301.820416851973, 302.2926352335534, 306.0451391658029, 5130.820421285246, 5208.973955130219, 5212.895742085161, 5233.241180028898, 5277.050130976423, 5067.163917953533, 5191.221316802482, 5212.76542555585, 5237.580993520519, 5241.973790131044, 4077.734947228428, 4088.2641124597562, 4090.5295890972475, 4095.344744840826, 4101.589841015904, 3890.3580909150096, 3987.3620220764683, 3998.480197574311, 4083.4079058536495, 4093.5087789465306, 4037.6971727120435, 4042.373432118012, 4044.1396957399634, 4050.3316952702767, 4064.756114633117, 4031.6371526562602, 4038.4346191533064, 4045.59544045596, 4053.736507127057, 4066.1257829566784, 3562.3943929532043, 3570.839312230956, 3575.4994300797907, 3575.928481430357, 3582.229820588586, 4975.228839529878, 5073.340465739467, 5074.0612986597225, 5076.035553244872, 5133.614978876599, 4563.452385713736, 4565.155446242423, 4569.154706379297, 4578.771061446914, 4614.30785382192, 5529.976954263434, 5536.584756143265, 5540.445955404468, 5542.91685624716, 5546.55627549795, 3591.2637909228547, 3683.778973261613, 3837.2325534892852, 3899.883003509871, 3922.0, 5693.601447898649, 5770.9422905770825, 5780.277465316835, 5786.47921687046, 5792.044312688401, 4038.0, 4045.4943132108488, 4045.939310910339, 4048.967513284094, 4049.7570145791346, 4097.733647312915, 4099.959000410017, 4108.137291168829, 4108.630223279919, 4115.670746340285, 4554.795034223468, 4656.301554766745, 4661.813527458864, 4665.6967297125575, 4671.672982891165, 5502.0921547944945, 5506.366767821672, 5509.807156749494, 5510.448955104457, 5511.22842802008, 1394.4491925689297, 1453.556665217119, 1456.8251809782894, 1457.5627311806415, 1462.1957923142443, 991.1179050644931, 997.8602995580625, 997.8902320744712, 1006.9144122749649, 1020.2297265564599, 4886.413630364308, 4887.047025829929, 4887.780049897763, 4888.046830868017, 4894.339264199359, 5718.228039214736, 5730.140478928194, 5731.254936858182, 5734.111212762028, 5735.569832262514, 4834.057358814997, 4849.369581954324, 4864.051509955525, 4878.9512104878495, 4887.071456423339, 2997.2956355256497, 3066.9386612268077, 3090.3510262844607, 3093.9535906961414, 3116.407882502317, 5479.506844383945, 5482.396936337, 5482.889087701264, 5485.067538518461, 5488.121900495901, 5923.437273459014, 5929.4070592941225, 5931.08068249422, 5934.050551911673, 5934.495567876693, 5435.891282174334, 5474.315710536183, 5475.6440831345835, 5476.7535460903555, 5481.835544933579, 5646.689432081275, 5771.480566749013, 5784.623999440023, 5785.623934444247, 5787.913181302368, 5414.160805075219, 5485.259489968963, 5573.749181286933, 5639.971800140973, 5650.717464126695, 5425.077736784835, 5451.991381594417, 5465.808696695596, 5475.835724928099, 5476.972615136899, 3771.0949372151035, 3801.885943421702, 3810.657040866335, 3846.076941534068, 3854.0557563397147, 5657.915131272952, 5791.681457519877, 5791.797287094932, 5792.797252096325, 5792.971035144966, 5535.640183388067, 5542.307211598551, 5542.3626282977975, 5544.667319960654, 5544.750486228048, 5410.78356865721, 5482.205080263419, 5485.122380419114, 5506.091494903296, 5536.2249285100925, 5360.785568577213, 5383.784648614168, 5394.406615272395, 5394.487523685244, 5395.811146610007, 5525.834224973257, 5532.834014979557, 5555.666660000413, 5590.748416321194, 5598.244237027949, 5344.919826202688, 5444.373897001896, 5460.044492213768, 5460.808871689472, 5466.508014278575], "unit": "ms", "name": "prototype.html", "value": 4159.036430930851}, {"lowerIsBetter": false, "replicates": [623.2116372788423, 730.5105579261894, 739.4564994728873, 776.6272189349115, 785.6268272570529, 11640.359780212095, 11830.349330786803, 11847.348395838226, 11933.522659093636, 11942.641720748381, 13128.868711312884, 13588.048836581444, 13594.18434893907, 13595.93202033991, 13601.38793754281, 625.5558553427072, 632.7975047984647, 815.47401925758, 815.9306458950996, 827.0695467598921, 819.4714409206058, 821.2690705272282, 826.4421515477059, 826.5701835045803, 827.3794654009492, 856.1395797223781, 863.7279257034014, 864.5806783709895, 865.2385900407664, 866.2593482572373, 653.0400311542026, 661.6526323680082, 841.8484672758901, 856.007031843059, 858.1804376820185, 634.0267689097213, 634.9904751428733, 635.028406537993, 635.3709827270968, 636.0110028905051, 11447.484863181176, 11557.0, 11588.884111158864, 11598.594049208237, 11600.071994240441, 10633.255672102956, 11019.0, 11036.227464077518, 11267.21129520934, 11627.12796540263, 9202.30982676302, 9410.952945235298, 9505.619775208983, 9565.856512152322, 9709.757256068584, 3168.255459966906, 3193.680631936811, 3248.123006788154, 3275.5086736989642, 3340.0981734931433, 40995.38506922369, 41410.79294603508, 41658.583414165776, 41698.79150604258, 41814.0, 9154.633814647472, 9240.0, 9369.625214991323, 9396.436213827192, 9428.905710942803, 16023.519294421187, 16048.438304659281, 16049.0, 16060.598485037734, 16113.677726445405, 6072.332043475302, 6301.52738544611, 6361.968190159112, 6385.616862988236, 6439.903401448982, 3515.82420878955, 3532.964670353315, 3624.130208749881, 3625.2930678517964, 3630.1650620356936, 2597.6882774067235, 2653.4427770168095, 2660.2019394181666, 2664.7335266473583, 2665.18711792905, 454.58632644293533, 454.6044940901437, 471.28835458457974, 476.52823704532955, 479.70737849911524, 483.845169545742, 509.7647163629504, 543.3886877263079, 574.1932584718477, 584.8888711144868, 8374.665013399517, 8390.160983901562, 8494.108118647453, 8645.740627781177, 8815.647374105092, 388.279741080292, 482.48133256749134, 583.5302581421911, 585.9589828712035, 615.8244900203421, 3442.7762195457217, 3644.562652481666, 3674.210044840372, 3733.813309334577, 3850.557185923599, 48080.5191948083, 48336.27495587569, 48487.51512484901, 48619.5138048615, 48626.756866215444, 43598.56401435945, 43941.560584393745, 44205.336919946225, 44573.33140002903, 44816.77591612086, 39702.40446393307, 39714.0, 39891.00272493153, 40051.79974100111, 40274.167099948194, 7402.518836275625, 7428.73999410018, 7465.776026719207, 7505.887411688938, 7701.422393320636, 29570.260743481584, 29954.400911982073, 30223.244418889703, 30481.39037219199, 30856.0, 35122.12194695153, 35696.64303357037, 38553.373595168756, 39103.0, 39269.0, 9387.671431500137, 9410.764730881783, 9448.811023779623, 9576.952115239379, 9691.0, 10081.798364032826, 10156.746081348025, 10165.695029149138, 10209.489525523546, 10301.896981030393, 9387.0, 9490.28822838276, 9637.9036209637, 9639.132478077006, 9682.70951871445, 9771.951140244253, 9864.0, 9906.653267135616, 9962.950185249318, 9975.152112070266, 9112.088791120836, 9289.303302252223, 9311.76720581991, 9367.906320936703, 9372.578233979624, 8304.792380190544, 8375.874361884698, 8512.914870851213, 8559.57202139903, 8625.094365091574, 7963.482373645695, 8576.699815506427, 8605.311575074104, 8774.736757897273, 8802.207801297658], "unit": "ms", "name": "yui.html", "value": 5598.264469873185}], "name": "dromaeo_css", "value": 6154.6411586121385}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 116.0, 107.0, 113.0, 114.0, 114.0, 103.0, 115.0, 112.0, 121.0], "unit": "ms", "name": "ai-astar", "value": 112.7}, {"lowerIsBetter": true, "replicates": [162.0, 128.0, 163.0, 165.0, 132.0, 157.0, 152.0, 131.0, 168.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.9}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 161.0, 161.0, 161.0, 162.0, 161.0, 161.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 85.0, 88.0, 72.0, 78.0, 75.0, 99.0, 89.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 80.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 133.0, 93.0, 94.0, 95.0, 128.0, 94.0, 95.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 105.2}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 146.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 72.0, 72.0, 72.0, 73.0, 73.0, 81.0, 70.0, 72.0], "unit": "ms", "name": "json-parse-financial", "value": 73.0}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 68.0, 68.0, 69.0, 70.0, 69.0, 69.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [86.0, 88.0, 88.0, 87.0, 99.0, 87.0, 88.0, 88.0, 88.0, 88.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 88.7}, {"lowerIsBetter": true, "replicates": [129.0, 130.0, 119.0, 119.0, 133.0, 123.0, 121.0, 133.0, 126.0, 121.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.4}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 158.0, 157.0, 164.0, 146.0, 170.0, 155.0, 154.0, 143.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 154.0}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 72.0, 71.0, 74.0, 71.0, 72.0, 73.0, 74.0, 71.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 72.0}], "name": "kraken", "value": 1541.5000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.38935108153078], "unit": "score", "name": "Richards", "value": 212.16501999999997}, {"lowerIsBetter": false, "replicates": [190.94901661256444], "unit": "score", "name": "DeltaBlue", "value": 346.2599660000002}, {"lowerIsBetter": false, "replicates": [278.6291446085261], "unit": "score", "name": "Encrypt", "value": 955.3236090000001}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [1986.111111111111], "unit": "score", "name": "RayTrace", "value": 372.5818741258742}, {"lowerIsBetter": false, "replicates": [788.0220646178093], "unit": "score", "name": "Earley", "value": 845.7415470000001}, {"lowerIsBetter": false, "replicates": [11988.095238095239], "unit": "score", "name": "Boyer", "value": 55.59373584905661}, {"lowerIsBetter": false, "replicates": [26789.473684210527], "unit": "score", "name": "RegExp", "value": 34.0053339882122}, {"lowerIsBetter": false, "replicates": [621.8905472636816], "unit": "score", "name": "Splay", "value": 131.03752799999995}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19743.248080800084}]} 23:14:03 INFO - RETURN: dromaeo_css: 6154.64 23:14:03 INFO - RETURN: kraken: 1541.50 23:14:03 INFO - RETURN: v8_7: 19743.25 23:14:03 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19743.25"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1541.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6154.64"}}} 23:14:03 INFO - Return code: 0 23:14:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:14:03 ERROR - # TBPL SUCCESS # 23:14:03 INFO - Running post-action listener: _resource_record_post_action 23:14:03 INFO - Running post-run listener: _resource_record_post_run 23:14:04 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 0; Write bytes: 505839616; Read time: 0; Write time: 522696 23:14:04 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 232083456; Read time: 0; Write time: 302004 23:14:04 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 0; Write bytes: 273756160; Read time: 0; Write time: 220692 23:14:04 INFO - Running post-run listener: _upload_blobber_files 23:14:04 INFO - Blob upload gear active. 23:14:04 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 23:14:04 INFO - Copying logs to upload dir... 23:14:04 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1284.615794 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2015-12-14 23:14:03.811970) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-14 23:14:03.815472) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1450152327.723067-1415303169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/2FdolsOWTOuZotw1PDf0cA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010243 build_url: 'https://queue.taskcluster.net/v1/task/2FdolsOWTOuZotw1PDf0cA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-14 23:14:03.866011) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 23:14:03.866334) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1450152327.723067-1415303169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004551 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 23:14:03.915900) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-14 23:14:03.916221) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-14 23:14:03.916502) ========= ========= Total master_lag: 0.28 =========