builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-025 starttime: 1450269634.11 results: success (0) buildid: 20151216030908 builduid: 39e0ad1119bc4e06a2c2d7de9dabc1c4 revision: 5fb09b81583111d48b827401905be0291a888094 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 04:40:34.108731) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 04:40:34.109161) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 04:40:34.109465) ========= 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=3cd289541638898829117e0a000001bd-1450269626.85246-914651853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006369 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 04:40:34.132378) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 04:40:34.132672) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 04:40:34.145779) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:40:34.146073) ========= 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=3cd289541638898829117e0a000001bd-1450269626.85246-914651853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004543 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:40:34.196046) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 04:40:34.196497) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 04:40:34.196989) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:40:34.197391) ========= 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=3cd289541638898829117e0a000001bd-1450269626.85246-914651853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-16 04:40:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.1M=0s 2015-12-16 04:40:34 (47.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.204086 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:40:34.414582) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:40:34.414962) ========= 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=3cd289541638898829117e0a000001bd-1450269626.85246-914651853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016280 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:40:34.464545) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-16 04:40:34.464989) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5fb09b81583111d48b827401905be0291a888094 --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 5fb09b81583111d48b827401905be0291a888094 --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=3cd289541638898829117e0a000001bd-1450269626.85246-914651853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-16 04:40:35,070 truncating revision to first 12 chars 2015-12-16 04:40:35,071 Setting DEBUG logging. 2015-12-16 04:40:35,071 attempt 1/10 2015-12-16 04:40:35,071 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5fb09b815831?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-16 04:40:36,107 unpacking tar archive at: fx-team-5fb09b815831/testing/mozharness/ program finished with exit code 0 elapsedTime=1.324720 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-16 04:40:35.805597) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 04:40:35.806153) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 04:40:35.818139) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 04:40:35.818636) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 04:40:35.819345) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-12-16 04:40:35.819848) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=3cd289541638898829117e0a000001bd-1450269626.85246-914651853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:40:36 INFO - MultiFileLogger online at 20151216 04:40:36 in /builds/slave/test 04:40:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 04:40:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:40:36 INFO - {'append_to_log': False, 04:40:36 INFO - 'base_work_dir': '/builds/slave/test', 04:40:36 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:40:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:40:36 INFO - 'branch': 'Fx-Team-Non-PGO', 04:40:36 INFO - 'buildbot_json_path': 'buildprops.json', 04:40:36 INFO - 'config_files': ('talos/linux_config.py',), 04:40:36 INFO - 'default_actions': ('clobber', 04:40:36 INFO - 'read-buildbot-config', 04:40:36 INFO - 'download-and-extract', 04:40:36 INFO - 'populate-webroot', 04:40:36 INFO - 'create-virtualenv', 04:40:36 INFO - 'install', 04:40:36 INFO - 'run-tests'), 04:40:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:40:36 INFO - 'download_minidump_stackwalk': True, 04:40:36 INFO - 'download_symbols': 'ondemand', 04:40:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:40:36 INFO - 'tooltool.py': '/tools/tooltool.py', 04:40:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:40:36 INFO - '/tools/misc-python/virtualenv.py')}, 04:40:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:40:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:40:36 INFO - 'installer_path': 'installer.exe', 04:40:36 INFO - 'log_level': 'info', 04:40:36 INFO - 'log_name': 'talos', 04:40:36 INFO - 'log_to_console': True, 04:40:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:40:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:40:36 INFO - 'opt_config_files': (), 04:40:36 INFO - 'pip_index': False, 04:40:36 INFO - 'sps_profile': False, 04:40:36 INFO - 'sps_profile_interval': 0, 04:40:36 INFO - 'suite': 'dromaeojs-e10s', 04:40:36 INFO - 'system_bits': '64', 04:40:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:40:36 INFO - 'title': 'talos-linux64-ix-025', 04:40:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:40:36 INFO - 'use_talos_json': True, 04:40:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:40:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:40:36 INFO - 'work_dir': 'build'} 04:40:36 INFO - ##### 04:40:36 INFO - ##### Running clobber step. 04:40:36 INFO - ##### 04:40:36 INFO - Running pre-action listener: _resource_record_pre_action 04:40:36 INFO - Running main action method: clobber 04:40:36 INFO - rmtree: /builds/slave/test/build 04:40:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:40:36 INFO - Running post-action listener: _resource_record_post_action 04:40:36 INFO - ##### 04:40:36 INFO - ##### Running read-buildbot-config step. 04:40:36 INFO - ##### 04:40:36 INFO - Running pre-action listener: _resource_record_pre_action 04:40:36 INFO - Running main action method: read_buildbot_config 04:40:36 INFO - Using buildbot properties: 04:40:36 INFO - { 04:40:36 INFO - "properties": { 04:40:36 INFO - "buildnumber": 581, 04:40:36 INFO - "product": "firefox", 04:40:36 INFO - "script_repo_revision": "production", 04:40:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 04:40:36 INFO - "repository": "", 04:40:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 04:40:36 INFO - "buildid": "20151216030908", 04:40:36 INFO - "slavename": "talos-linux64-ix-025", 04:40:36 INFO - "pgo_build": "False", 04:40:36 INFO - "basedir": "/builds/slave/test", 04:40:36 INFO - "project": "", 04:40:36 INFO - "platform": "ubuntu64_hw", 04:40:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:40:36 INFO - "slavebuilddir": "test", 04:40:36 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:40:36 INFO - "branch": "fx-team", 04:40:36 INFO - "repo_path": "integration/fx-team", 04:40:36 INFO - "stage_platform": "linux64", 04:40:36 INFO - "builduid": "39e0ad1119bc4e06a2c2d7de9dabc1c4", 04:40:36 INFO - "revision": "5fb09b81583111d48b827401905be0291a888094" 04:40:36 INFO - }, 04:40:36 INFO - "sourcestamp": { 04:40:36 INFO - "repository": "", 04:40:36 INFO - "hasPatch": false, 04:40:36 INFO - "project": "", 04:40:36 INFO - "branch": "fx-team-linux64-talos", 04:40:36 INFO - "changes": [ 04:40:36 INFO - { 04:40:36 INFO - "category": null, 04:40:36 INFO - "files": [ 04:40:36 INFO - { 04:40:36 INFO - "url": null, 04:40:36 INFO - "name": "https://queue.taskcluster.net/v1/task/K9hhvgk_Q-ywBVrXDcQ4kA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 04:40:36 INFO - } 04:40:36 INFO - ], 04:40:36 INFO - "repository": "", 04:40:36 INFO - "rev": "5fb09b81583111d48b827401905be0291a888094", 04:40:36 INFO - "who": "cbook@mozilla.com", 04:40:36 INFO - "when": 1450269001, 04:40:36 INFO - "number": 7365732, 04:40:36 INFO - "comments": "Merge mozilla-central to fx-team", 04:40:36 INFO - "project": "", 04:40:36 INFO - "at": "Wed 16 Dec 2015 04:30:01", 04:40:36 INFO - "branch": "fx-team-linux64-talos", 04:40:36 INFO - "revlink": "", 04:40:36 INFO - "properties": [ 04:40:36 INFO - [ 04:40:36 INFO - "buildid", 04:40:36 INFO - "20151216030908", 04:40:36 INFO - "Change" 04:40:36 INFO - ], 04:40:36 INFO - [ 04:40:36 INFO - "builduid", 04:40:36 INFO - "39e0ad1119bc4e06a2c2d7de9dabc1c4", 04:40:36 INFO - "Change" 04:40:36 INFO - ], 04:40:36 INFO - [ 04:40:36 INFO - "pgo_build", 04:40:36 INFO - "False", 04:40:36 INFO - "Change" 04:40:36 INFO - ] 04:40:36 INFO - ], 04:40:36 INFO - "revision": "5fb09b81583111d48b827401905be0291a888094" 04:40:36 INFO - } 04:40:36 INFO - ], 04:40:36 INFO - "revision": "5fb09b81583111d48b827401905be0291a888094" 04:40:36 INFO - } 04:40:36 INFO - } 04:40:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/K9hhvgk_Q-ywBVrXDcQ4kA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:40:36 INFO - Running post-action listener: _resource_record_post_action 04:40:36 INFO - ##### 04:40:36 INFO - ##### Running download-and-extract step. 04:40:36 INFO - ##### 04:40:36 INFO - Running pre-action listener: _resource_record_pre_action 04:40:36 INFO - Running main action method: download_and_extract 04:40:36 INFO - mkdir: /builds/slave/test/build/tests 04:40:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:36 INFO - https://queue.taskcluster.net/v1/task/K9hhvgk_Q-ywBVrXDcQ4kA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:40:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9hhvgk_Q-ywBVrXDcQ4kA/artifacts/public/build/test_packages.json 04:40:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9hhvgk_Q-ywBVrXDcQ4kA/artifacts/public/build/test_packages.json 04:40:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9hhvgk_Q-ywBVrXDcQ4kA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:40:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9hhvgk_Q-ywBVrXDcQ4kA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:40:37 INFO - Downloaded 1302 bytes. 04:40:37 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:40:37 INFO - Using the following test package requirements: 04:40:37 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:40:37 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:40:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:40:37 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:40:37 INFO - u'jsshell-linux-x86_64.zip'], 04:40:37 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:40:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:40:37 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:40:37 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:40:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:40:37 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:40:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:40:37 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:40:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:40:37 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:40:37 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:40:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:40:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:40:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:37 INFO - https://queue.taskcluster.net/v1/task/K9hhvgk_Q-ywBVrXDcQ4kA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:40:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9hhvgk_Q-ywBVrXDcQ4kA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:40:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9hhvgk_Q-ywBVrXDcQ4kA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:40:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9hhvgk_Q-ywBVrXDcQ4kA/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 04:40:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9hhvgk_Q-ywBVrXDcQ4kA/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 04:40:38 INFO - Downloaded 21869080 bytes. 04:40:38 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 04:40:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:40:38 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 04:40:39 INFO - Return code: 0 04:40:39 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 04:40:39 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')]} 04:40:39 INFO - https://queue.taskcluster.net/v1/task/K9hhvgk_Q-ywBVrXDcQ4kA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:40:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9hhvgk_Q-ywBVrXDcQ4kA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:40:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9hhvgk_Q-ywBVrXDcQ4kA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:40:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9hhvgk_Q-ywBVrXDcQ4kA/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 04:40:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9hhvgk_Q-ywBVrXDcQ4kA/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 04:40:40 INFO - Downloaded 21869080 bytes. 04:40:40 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 04:40:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:40:40 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 04:40:42 INFO - Return code: 0 04:40: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')]} 04:40:42 INFO - https://queue.taskcluster.net/v1/task/K9hhvgk_Q-ywBVrXDcQ4kA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:40:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9hhvgk_Q-ywBVrXDcQ4kA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:40:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9hhvgk_Q-ywBVrXDcQ4kA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:40:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9hhvgk_Q-ywBVrXDcQ4kA/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 04:40:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9hhvgk_Q-ywBVrXDcQ4kA/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 04:40:42 INFO - Downloaded 11132052 bytes. 04:40:42 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 04:40:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:40:42 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 04:40:43 INFO - Return code: 0 04:40:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:43 INFO - https://queue.taskcluster.net/v1/task/K9hhvgk_Q-ywBVrXDcQ4kA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:40:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9hhvgk_Q-ywBVrXDcQ4kA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:40:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9hhvgk_Q-ywBVrXDcQ4kA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:40:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9hhvgk_Q-ywBVrXDcQ4kA/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 04:40:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9hhvgk_Q-ywBVrXDcQ4kA/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 04:40:44 INFO - Downloaded 57746722 bytes. 04:40:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K9hhvgk_Q-ywBVrXDcQ4kA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:40:44 INFO - mkdir: /builds/slave/test/properties 04:40:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:40:44 INFO - Writing to file /builds/slave/test/properties/build_url 04:40:44 INFO - Contents: 04:40:44 INFO - build_url:https://queue.taskcluster.net/v1/task/K9hhvgk_Q-ywBVrXDcQ4kA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:40:44 INFO - Running post-action listener: _resource_record_post_action 04:40:44 INFO - Running post-action listener: set_extra_try_arguments 04:40:44 INFO - ##### 04:40:44 INFO - ##### Running populate-webroot step. 04:40:44 INFO - ##### 04:40:44 INFO - Running pre-action listener: _resource_record_pre_action 04:40:44 INFO - Running main action method: populate_webroot 04:40:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:40:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:40:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:40:44 INFO - '--tppagecycles', 04:40:44 INFO - '7'], 04:40:44 INFO - 'tests': ['tsvgm']}}, 04:40:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:40:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:40:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:40:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:40:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:40:44 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:40:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:40:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:44 INFO - 'talos_options': ['--e10s'], 04:40:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:40:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:44 INFO - 'tests': ['damp', 'tps']}, 04:40:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:44 INFO - 'talos_options': ['--e10s'], 04:40:44 INFO - 'tests': ['damp', 'tps']}, 04:40:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:40:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:40:44 INFO - 'other': {'tests': ['a11yr', 04:40:44 INFO - 'ts_paint', 04:40:44 INFO - 'tpaint', 04:40:44 INFO - 'sessionrestore', 04:40:44 INFO - 'sessionrestore_no_auto_restore']}, 04:40:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:40:44 INFO - 'tests': ['a11yr', 04:40:44 INFO - 'ts_paint', 04:40:44 INFO - 'tpaint', 04:40:44 INFO - 'sessionrestore', 04:40:44 INFO - 'sessionrestore_no_auto_restore']}, 04:40:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:40:44 INFO - 'tests': ['a11yr', 04:40:44 INFO - 'ts_paint', 04:40:44 INFO - 'tpaint', 04:40:44 INFO - 'sessionrestore', 04:40:44 INFO - 'sessionrestore_no_auto_restore']}, 04:40:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:40:44 INFO - 'tests': ['a11yr', 04:40:44 INFO - 'ts_paint', 04:40:44 INFO - 'tpaint', 04:40:44 INFO - 'sessionrestore', 04:40:44 INFO - 'sessionrestore_no_auto_restore']}, 04:40:44 INFO - 'other_l64': {'tests': ['a11yr', 04:40:44 INFO - 'ts_paint', 04:40:44 INFO - 'tpaint', 04:40:44 INFO - 'sessionrestore', 04:40:44 INFO - 'sessionrestore_no_auto_restore']}, 04:40:44 INFO - 'other_nol64': {'tests': ['a11yr', 04:40:44 INFO - 'ts_paint', 04:40:44 INFO - 'tpaint', 04:40:44 INFO - 'sessionrestore', 04:40:44 INFO - 'sessionrestore_no_auto_restore']}, 04:40:44 INFO - 'svgr': {'tests': ['tsvgx', 04:40:44 INFO - 'tsvgr_opacity', 04:40:44 INFO - 'tart', 04:40:44 INFO - 'tscrollx', 04:40:44 INFO - 'cart']}, 04:40:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:40:44 INFO - 'tests': ['tsvgx', 04:40:44 INFO - 'tsvgr_opacity', 04:40:44 INFO - 'tart', 04:40:44 INFO - 'tscrollx', 04:40:44 INFO - 'cart']}, 04:40:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:44 INFO - 'tests': ['tp5o']}, 04:40:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:44 INFO - 'talos_options': ['--e10s'], 04:40:44 INFO - 'tests': ['tp5o']}, 04:40:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:44 INFO - 'talos_options': ['--xperf_path', 04:40:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:40:44 INFO - 'tests': ['tp5n']}, 04:40:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:44 INFO - 'talos_options': ['--e10s', 04:40:44 INFO - '--xperf_path', 04:40:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:40:44 INFO - 'tests': ['tp5n']}}, 04:40:44 INFO - 'talos.zip': {'path': '', 04:40:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:40:44 INFO - Running post-action listener: _resource_record_post_action 04:40:44 INFO - ##### 04:40:44 INFO - ##### Running create-virtualenv step. 04:40:44 INFO - ##### 04:40:44 INFO - Running pre-action listener: _resource_record_pre_action 04:40:44 INFO - Running main action method: create_virtualenv 04:40:44 INFO - Creating virtualenv /builds/slave/test/build/venv 04:40:44 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 04:40:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:40:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:40:44 INFO - Using real prefix '/usr' 04:40:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:40:45 INFO - Installing distribute.............................................................................................................................................................................................done. 04:40:47 INFO - Installing pip.................done. 04:40:47 INFO - Return code: 0 04:40:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:40: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')]} 04:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40: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')]} 04:40:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:47 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 0x7f7d625fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb0240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3f0b0>, '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 0xf3ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf40440>, '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': '3cd289541638898829117e0a000001bd-1450269626.85246-914651853', '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 04:40:47 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 04:40:47 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 04:40:47 INFO - Using env: {'DISPLAY': ':0', 04:40:47 INFO - 'HOME': '/home/cltbld', 04:40:47 INFO - 'LANG': 'en_US.UTF-8', 04:40:47 INFO - 'LANGUAGE': 'en_US:en', 04:40:47 INFO - 'LOGNAME': 'cltbld', 04:40:47 INFO - 'MAIL': '/var/mail/cltbld', 04:40:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:47 INFO - 'MOZ_NO_REMOTE': '1', 04:40:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:47 INFO - 'NO_EM_RESTART': '1', 04:40:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:47 INFO - 'PWD': '/builds/slave/test', 04:40:47 INFO - 'SHELL': '/bin/bash', 04:40:47 INFO - 'SHLVL': '1', 04:40:47 INFO - 'TERM': 'linux', 04:40:47 INFO - 'TMOUT': '86400', 04:40:47 INFO - 'USER': 'cltbld', 04:40:47 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1450269626.85246-914651853', 04:40:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:47 INFO - '_': '/tools/buildbot/bin/python'} 04:40:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:47 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 04:40:47 INFO - Cleaning up... 04:40:47 INFO - Return code: 0 04:40:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:40: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')]} 04:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40: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')]} 04:40:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:47 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 0x7f7d625fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb0240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3f0b0>, '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 0xf3ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf40440>, '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': '3cd289541638898829117e0a000001bd-1450269626.85246-914651853', '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 04:40:47 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 04:40:47 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 04:40:47 INFO - Using env: {'DISPLAY': ':0', 04:40:47 INFO - 'HOME': '/home/cltbld', 04:40:47 INFO - 'LANG': 'en_US.UTF-8', 04:40:47 INFO - 'LANGUAGE': 'en_US:en', 04:40:47 INFO - 'LOGNAME': 'cltbld', 04:40:47 INFO - 'MAIL': '/var/mail/cltbld', 04:40:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:47 INFO - 'MOZ_NO_REMOTE': '1', 04:40:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:47 INFO - 'NO_EM_RESTART': '1', 04:40:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:47 INFO - 'PWD': '/builds/slave/test', 04:40:47 INFO - 'SHELL': '/bin/bash', 04:40:47 INFO - 'SHLVL': '1', 04:40:47 INFO - 'TERM': 'linux', 04:40:47 INFO - 'TMOUT': '86400', 04:40:47 INFO - 'USER': 'cltbld', 04:40:47 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1450269626.85246-914651853', 04:40:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:47 INFO - '_': '/tools/buildbot/bin/python'} 04:40:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:47 INFO - Downloading/unpacking psutil>=0.7.1 04:40:47 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 04:40:47 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 04:40:47 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 04:40:47 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 04:40:47 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 04:40:47 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 04:40:49 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:40:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:40:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:40:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:40:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:40:49 INFO - Installing collected packages: psutil 04:40:49 INFO - Running setup.py install for psutil 04:40:49 INFO - building 'psutil._psutil_linux' extension 04:40:49 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 04:40:49 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 04:40:49 INFO - building 'psutil._psutil_posix' extension 04:40:49 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 04:40:49 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 04:40:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:40:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:40:49 INFO - Successfully installed psutil 04:40:49 INFO - Cleaning up... 04:40:49 INFO - Return code: 0 04:40:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:40:49 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')]} 04:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:49 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')]} 04:40:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:49 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 0x7f7d625fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb0240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3f0b0>, '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 0xf3ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf40440>, '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': '3cd289541638898829117e0a000001bd-1450269626.85246-914651853', '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 04:40:49 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 04:40:49 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 04:40:49 INFO - Using env: {'DISPLAY': ':0', 04:40:49 INFO - 'HOME': '/home/cltbld', 04:40:49 INFO - 'LANG': 'en_US.UTF-8', 04:40:49 INFO - 'LANGUAGE': 'en_US:en', 04:40:49 INFO - 'LOGNAME': 'cltbld', 04:40:49 INFO - 'MAIL': '/var/mail/cltbld', 04:40:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:49 INFO - 'MOZ_NO_REMOTE': '1', 04:40:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:49 INFO - 'NO_EM_RESTART': '1', 04:40:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:49 INFO - 'PWD': '/builds/slave/test', 04:40:49 INFO - 'SHELL': '/bin/bash', 04:40:49 INFO - 'SHLVL': '1', 04:40:49 INFO - 'TERM': 'linux', 04:40:49 INFO - 'TMOUT': '86400', 04:40:49 INFO - 'USER': 'cltbld', 04:40:49 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1450269626.85246-914651853', 04:40:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:49 INFO - '_': '/tools/buildbot/bin/python'} 04:40:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:40:50 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 04:40:50 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 04:40:50 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 04:40:50 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 04:40:50 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 04:40:50 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 04:40:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:40:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:40:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:40:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:40:51 INFO - Installing collected packages: mozsystemmonitor 04:40:51 INFO - Running setup.py install for mozsystemmonitor 04:40:51 INFO - Successfully installed mozsystemmonitor 04:40:51 INFO - Cleaning up... 04:40:51 INFO - Return code: 0 04:40:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:40:51 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')]} 04:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:51 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')]} 04:40:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:51 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 0x7f7d625fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb0240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3f0b0>, '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 0xf3ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf40440>, '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': '3cd289541638898829117e0a000001bd-1450269626.85246-914651853', '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 04:40:51 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 04:40:51 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 04:40:51 INFO - Using env: {'DISPLAY': ':0', 04:40:51 INFO - 'HOME': '/home/cltbld', 04:40:51 INFO - 'LANG': 'en_US.UTF-8', 04:40:51 INFO - 'LANGUAGE': 'en_US:en', 04:40:51 INFO - 'LOGNAME': 'cltbld', 04:40:51 INFO - 'MAIL': '/var/mail/cltbld', 04:40:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:51 INFO - 'MOZ_NO_REMOTE': '1', 04:40:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:51 INFO - 'NO_EM_RESTART': '1', 04:40:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:51 INFO - 'PWD': '/builds/slave/test', 04:40:51 INFO - 'SHELL': '/bin/bash', 04:40:51 INFO - 'SHLVL': '1', 04:40:51 INFO - 'TERM': 'linux', 04:40:51 INFO - 'TMOUT': '86400', 04:40:51 INFO - 'USER': 'cltbld', 04:40:51 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1450269626.85246-914651853', 04:40:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:51 INFO - '_': '/tools/buildbot/bin/python'} 04:40:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:52 INFO - Downloading/unpacking blobuploader==1.2.4 04:40:52 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 04:40:52 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 04:40:52 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 04:40:52 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 04:40:52 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 04:40:52 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 04:40:53 INFO - Downloading blobuploader-1.2.4.tar.gz 04:40:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:40:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:40:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:40:53 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 04:40:53 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 04:40:53 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 04:40:53 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 04:40:53 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 04:40:53 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 04:40:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:40:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:40:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:40:54 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 04:40:54 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 04:40:54 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 04:40:54 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 04:40:54 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 04:40:54 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 04:40:54 INFO - Downloading docopt-0.6.1.tar.gz 04:40:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:40:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:40:54 INFO - Installing collected packages: blobuploader, requests, docopt 04:40:54 INFO - Running setup.py install for blobuploader 04:40:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:40:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:40:54 INFO - Running setup.py install for requests 04:40:54 INFO - Running setup.py install for docopt 04:40:55 INFO - Successfully installed blobuploader requests docopt 04:40:55 INFO - Cleaning up... 04:40:55 INFO - Return code: 0 04:40:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:55 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 0x7f7d625fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb0240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3f0b0>, '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 0xf3ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf40440>, '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': '3cd289541638898829117e0a000001bd-1450269626.85246-914651853', '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 04:40:55 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 04:40:55 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 04:40:55 INFO - Using env: {'DISPLAY': ':0', 04:40:55 INFO - 'HOME': '/home/cltbld', 04:40:55 INFO - 'LANG': 'en_US.UTF-8', 04:40:55 INFO - 'LANGUAGE': 'en_US:en', 04:40:55 INFO - 'LOGNAME': 'cltbld', 04:40:55 INFO - 'MAIL': '/var/mail/cltbld', 04:40:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:55 INFO - 'MOZ_NO_REMOTE': '1', 04:40:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:55 INFO - 'NO_EM_RESTART': '1', 04:40:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:55 INFO - 'PWD': '/builds/slave/test', 04:40:55 INFO - 'SHELL': '/bin/bash', 04:40:55 INFO - 'SHLVL': '1', 04:40:55 INFO - 'TERM': 'linux', 04:40:55 INFO - 'TMOUT': '86400', 04:40:55 INFO - 'USER': 'cltbld', 04:40:55 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1450269626.85246-914651853', 04:40:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:55 INFO - '_': '/tools/buildbot/bin/python'} 04:40:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:40:55 INFO - Running setup.py (path:/tmp/pip-fUW7XS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:40:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:40:55 INFO - Running setup.py (path:/tmp/pip-w_mXHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:40:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:40:55 INFO - Running setup.py (path:/tmp/pip-kaeHcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:40:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:40:55 INFO - Running setup.py (path:/tmp/pip-J0QPf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:40:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:40:55 INFO - Running setup.py (path:/tmp/pip-mNQfwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:40:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:40:55 INFO - Running setup.py (path:/tmp/pip-pj7WKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:40:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:40:55 INFO - Running setup.py (path:/tmp/pip-xz2VzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:40:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:40:55 INFO - Running setup.py (path:/tmp/pip-GeEoOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:40:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:40:55 INFO - Running setup.py (path:/tmp/pip-6a3vaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:40:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:40:55 INFO - Running setup.py (path:/tmp/pip-diYBy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:40:56 INFO - Running setup.py (path:/tmp/pip-i190Jv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:40:56 INFO - Running setup.py (path:/tmp/pip-IYCj2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:40:56 INFO - Running setup.py (path:/tmp/pip-wjU2xq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:40:56 INFO - Running setup.py (path:/tmp/pip-2rcKVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:40:56 INFO - Running setup.py (path:/tmp/pip-feV_0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:40:56 INFO - Running setup.py (path:/tmp/pip-otr3l6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:40:56 INFO - Running setup.py (path:/tmp/pip-bUB_11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:40:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:40:56 INFO - Running setup.py install for manifestparser 04:40:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:40:56 INFO - Running setup.py install for mozcrash 04:40:56 INFO - Running setup.py install for mozdebug 04:40:56 INFO - Running setup.py install for mozdevice 04:40:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:40:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:40:56 INFO - Running setup.py install for mozfile 04:40:57 INFO - Running setup.py install for mozhttpd 04:40:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:40:57 INFO - Running setup.py install for mozinfo 04:40:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:40:57 INFO - Running setup.py install for mozInstall 04:40:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:40:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:40:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:40:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:40:57 INFO - Running setup.py install for mozleak 04:40:57 INFO - Running setup.py install for mozlog 04:40:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:40:57 INFO - Running setup.py install for moznetwork 04:40:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:40:57 INFO - Running setup.py install for mozprocess 04:40:57 INFO - Running setup.py install for mozprofile 04:40:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:40:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:40:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:40:57 INFO - Running setup.py install for mozrunner 04:40:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:40:57 INFO - Running setup.py install for mozscreenshot 04:40:58 INFO - Running setup.py install for moztest 04:40:58 INFO - Running setup.py install for mozversion 04:40:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:40:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:40:58 INFO - Cleaning up... 04:40:58 INFO - Return code: 0 04:40:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:40:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:58 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 0x7f7d625fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb0240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3f0b0>, '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 0xf3ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf40440>, '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': '3cd289541638898829117e0a000001bd-1450269626.85246-914651853', '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 04:40:58 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 04:40:58 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 04:40:58 INFO - Using env: {'DISPLAY': ':0', 04:40:58 INFO - 'HOME': '/home/cltbld', 04:40:58 INFO - 'LANG': 'en_US.UTF-8', 04:40:58 INFO - 'LANGUAGE': 'en_US:en', 04:40:58 INFO - 'LOGNAME': 'cltbld', 04:40:58 INFO - 'MAIL': '/var/mail/cltbld', 04:40:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:58 INFO - 'MOZ_NO_REMOTE': '1', 04:40:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:58 INFO - 'NO_EM_RESTART': '1', 04:40:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:58 INFO - 'PWD': '/builds/slave/test', 04:40:58 INFO - 'SHELL': '/bin/bash', 04:40:58 INFO - 'SHLVL': '1', 04:40:58 INFO - 'TERM': 'linux', 04:40:58 INFO - 'TMOUT': '86400', 04:40:58 INFO - 'USER': 'cltbld', 04:40:58 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1450269626.85246-914651853', 04:40:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:58 INFO - '_': '/tools/buildbot/bin/python'} 04:40:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:40:58 INFO - Running setup.py (path:/tmp/pip-fUGpwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:40:58 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)) 04:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:40:58 INFO - Running setup.py (path:/tmp/pip-TdYOKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:40:58 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)) 04:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:40:58 INFO - Running setup.py (path:/tmp/pip-Q_C3es-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:40:58 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)) 04:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:40:58 INFO - Running setup.py (path:/tmp/pip-Wc5J0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:40:58 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)) 04:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:40:58 INFO - Running setup.py (path:/tmp/pip-_55F2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:40:58 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)) 04:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:40:58 INFO - Running setup.py (path:/tmp/pip-upEZtj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:40:58 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)) 04:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:40:58 INFO - Running setup.py (path:/tmp/pip-QzdXmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:40:59 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)) 04:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:40:59 INFO - Running setup.py (path:/tmp/pip-UOgnMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:40:59 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)) 04:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:40:59 INFO - Running setup.py (path:/tmp/pip-7fNMvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:40:59 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)) 04:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:40:59 INFO - Running setup.py (path:/tmp/pip-kGd4fD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:40:59 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)) 04:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:40:59 INFO - Running setup.py (path:/tmp/pip-DC6a81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:40:59 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)) 04:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:40:59 INFO - Running setup.py (path:/tmp/pip-jaupTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:40:59 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)) 04:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:40:59 INFO - Running setup.py (path:/tmp/pip-HViGup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:40:59 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)) 04:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:40:59 INFO - Running setup.py (path:/tmp/pip-T_lKNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:40:59 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)) 04:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:40:59 INFO - Running setup.py (path:/tmp/pip-Hin7e7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:40:59 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)) 04:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:40:59 INFO - Running setup.py (path:/tmp/pip-T0mZn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:40:59 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)) 04:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:40:59 INFO - Running setup.py (path:/tmp/pip-rvkUQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:40:59 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)) 04:40:59 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)) 04:40:59 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)) 04:40:59 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)) 04:40:59 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)) 04:40:59 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)) 04:40:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:40:59 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 04:40:59 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 04:40:59 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 04:40:59 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 04:40:59 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 04:40:59 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 04:41:01 INFO - Downloading blessings-1.5.1.tar.gz 04:41:01 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 04:41:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:41:01 INFO - Installing collected packages: blessings 04:41:01 INFO - Running setup.py install for blessings 04:41:01 INFO - Successfully installed blessings 04:41:01 INFO - Cleaning up... 04:41:01 INFO - Return code: 0 04:41:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:41:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:41:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:41:01 INFO - Reading from file tmpfile_stdout 04:41:01 INFO - Current package versions: 04:41:01 INFO - argparse == 1.2.1 04:41:01 INFO - blessings == 1.5.1 04:41:01 INFO - blobuploader == 1.2.4 04:41:01 INFO - docopt == 0.6.1 04:41:01 INFO - manifestparser == 1.1 04:41:01 INFO - mozInstall == 1.12 04:41:01 INFO - mozcrash == 0.16 04:41:01 INFO - mozdebug == 0.1 04:41:01 INFO - mozdevice == 0.47 04:41:01 INFO - mozfile == 1.2 04:41:01 INFO - mozhttpd == 0.7 04:41:01 INFO - mozinfo == 0.9 04:41:01 INFO - mozleak == 0.1 04:41:01 INFO - mozlog == 3.1 04:41:01 INFO - moznetwork == 0.27 04:41:01 INFO - mozprocess == 0.22 04:41:01 INFO - mozprofile == 0.27 04:41:01 INFO - mozrunner == 6.11 04:41:01 INFO - mozscreenshot == 0.1 04:41:01 INFO - mozsystemmonitor == 0.0 04:41:01 INFO - moztest == 0.7 04:41:01 INFO - mozversion == 1.4 04:41:01 INFO - psutil == 3.1.1 04:41:01 INFO - requests == 1.2.3 04:41:01 INFO - wsgiref == 0.1.2 04:41:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:41: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')]} 04:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41: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')]} 04:41:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f7d625fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb0240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3f0b0>, '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 0xf3ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf40440>, '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': '3cd289541638898829117e0a000001bd-1450269626.85246-914651853', '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 04:41:01 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 04:41:01 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 04:41:01 INFO - Using env: {'DISPLAY': ':0', 04:41:01 INFO - 'HOME': '/home/cltbld', 04:41:01 INFO - 'LANG': 'en_US.UTF-8', 04:41:01 INFO - 'LANGUAGE': 'en_US:en', 04:41:01 INFO - 'LOGNAME': 'cltbld', 04:41:01 INFO - 'MAIL': '/var/mail/cltbld', 04:41:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:01 INFO - 'MOZ_NO_REMOTE': '1', 04:41:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:01 INFO - 'NO_EM_RESTART': '1', 04:41:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:01 INFO - 'PWD': '/builds/slave/test', 04:41:01 INFO - 'SHELL': '/bin/bash', 04:41:01 INFO - 'SHLVL': '1', 04:41:01 INFO - 'TERM': 'linux', 04:41:01 INFO - 'TMOUT': '86400', 04:41:01 INFO - 'USER': 'cltbld', 04:41:01 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1450269626.85246-914651853', 04:41:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:01 INFO - '_': '/tools/buildbot/bin/python'} 04:41:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:02 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)) 04:41:02 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)) 04:41:02 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)) 04:41:02 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)) 04:41:02 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)) 04:41:02 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)) 04:41:02 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)) 04:41:02 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)) 04:41:02 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)) 04:41:02 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)) 04:41:02 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)) 04:41:02 INFO - Cleaning up... 04:41:02 INFO - Return code: 0 04:41:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:41: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')]} 04:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41: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')]} 04:41:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:02 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 0x7f7d625fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb0240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3f0b0>, '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 0xf3ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf40440>, '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': '3cd289541638898829117e0a000001bd-1450269626.85246-914651853', '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 04:41:02 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 04:41:02 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 04:41:02 INFO - Using env: {'DISPLAY': ':0', 04:41:02 INFO - 'HOME': '/home/cltbld', 04:41:02 INFO - 'LANG': 'en_US.UTF-8', 04:41:02 INFO - 'LANGUAGE': 'en_US:en', 04:41:02 INFO - 'LOGNAME': 'cltbld', 04:41:02 INFO - 'MAIL': '/var/mail/cltbld', 04:41:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:02 INFO - 'MOZ_NO_REMOTE': '1', 04:41:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:02 INFO - 'NO_EM_RESTART': '1', 04:41:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:02 INFO - 'PWD': '/builds/slave/test', 04:41:02 INFO - 'SHELL': '/bin/bash', 04:41:02 INFO - 'SHLVL': '1', 04:41:02 INFO - 'TERM': 'linux', 04:41:02 INFO - 'TMOUT': '86400', 04:41:02 INFO - 'USER': 'cltbld', 04:41:02 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1450269626.85246-914651853', 04:41:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:02 INFO - '_': '/tools/buildbot/bin/python'} 04:41:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:02 INFO - Downloading/unpacking jsonschema 04:41:02 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 04:41:02 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 04:41:02 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 04:41:02 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 04:41:02 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 04:41:02 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 04:41:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:41:03 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 04:41:03 INFO - Downloading/unpacking functools32 (from jsonschema) 04:41:03 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 04:41:03 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 04:41:03 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 04:41:03 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 04:41:03 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 04:41:03 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 04:41:04 INFO - Downloading functools32-3.2.3-2.tar.gz 04:41:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:41:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:41:04 INFO - warning: no files found matching '*.txt' 04:41:04 INFO - no previously-included directories found matching 'build' 04:41:04 INFO - no previously-included directories found matching 'dist' 04:41:04 INFO - no previously-included directories found matching '.git*' 04:41:04 INFO - Installing collected packages: jsonschema, functools32 04:41:04 INFO - Running setup.py install for functools32 04:41:04 INFO - warning: no files found matching '*.txt' 04:41:04 INFO - no previously-included directories found matching 'build' 04:41:04 INFO - no previously-included directories found matching 'dist' 04:41:04 INFO - no previously-included directories found matching '.git*' 04:41:04 INFO - Successfully installed jsonschema functools32 04:41:04 INFO - Cleaning up... 04:41:04 INFO - Return code: 0 04:41:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:41:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:04 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 0x7f7d625fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb0240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3f0b0>, '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 0xf3ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf40440>, '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': '3cd289541638898829117e0a000001bd-1450269626.85246-914651853', '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 04:41:04 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 04:41:04 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 04:41:04 INFO - Using env: {'DISPLAY': ':0', 04:41:04 INFO - 'HOME': '/home/cltbld', 04:41:04 INFO - 'LANG': 'en_US.UTF-8', 04:41:04 INFO - 'LANGUAGE': 'en_US:en', 04:41:04 INFO - 'LOGNAME': 'cltbld', 04:41:04 INFO - 'MAIL': '/var/mail/cltbld', 04:41:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:04 INFO - 'MOZ_NO_REMOTE': '1', 04:41:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:04 INFO - 'NO_EM_RESTART': '1', 04:41:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:04 INFO - 'PWD': '/builds/slave/test', 04:41:04 INFO - 'SHELL': '/bin/bash', 04:41:04 INFO - 'SHLVL': '1', 04:41:04 INFO - 'TERM': 'linux', 04:41:04 INFO - 'TMOUT': '86400', 04:41:04 INFO - 'USER': 'cltbld', 04:41:04 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1450269626.85246-914651853', 04:41:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:04 INFO - '_': '/tools/buildbot/bin/python'} 04:41:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:04 INFO - Downloading/unpacking flake8 04:41:04 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 04:41:04 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 04:41:04 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 04:41:04 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 04:41:04 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 04:41:04 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 04:41:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:41:06 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 04:41:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:41:06 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 04:41:06 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 04:41:06 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 04:41:06 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 04:41:06 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 04:41:06 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 04:41:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:41:06 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 04:41:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:41:06 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 04:41:06 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 04:41:06 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 04:41:06 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 04:41:06 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 04:41:06 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 04:41:06 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 04:41:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:41:06 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 04:41:06 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 04:41:06 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 04:41:06 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 04:41:06 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 04:41:06 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 04:41:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:41:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:41:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:41:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:41:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:41:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:41:06 INFO - no previously-included directories found matching 'docs/_build' 04:41:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:41:07 INFO - Running setup.py install for pep8 04:41:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:41:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:41:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:41:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:41:07 INFO - no previously-included directories found matching 'docs/_build' 04:41:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:41:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:41:07 INFO - Cleaning up... 04:41:07 INFO - Return code: 0 04:41:07 INFO - Running post-action listener: _resource_record_post_action 04:41:07 INFO - Running post-action listener: _start_resource_monitoring 04:41:07 INFO - Starting resource monitoring. 04:41:07 INFO - ##### 04:41:07 INFO - ##### Running install step. 04:41:07 INFO - ##### 04:41:07 INFO - Running pre-action listener: _resource_record_pre_action 04:41:07 INFO - Running main action method: install 04:41:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:41:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:41:07 INFO - Reading from file tmpfile_stdout 04:41:07 INFO - Detecting whether we're running mozinstall >=1.0... 04:41:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:41:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:41:07 INFO - Reading from file tmpfile_stdout 04:41:07 INFO - Output received: 04:41:07 INFO - Usage: mozinstall [options] installer 04:41:07 INFO - Options: 04:41:07 INFO - -h, --help show this help message and exit 04:41:07 INFO - -d DEST, --destination=DEST 04:41:07 INFO - Directory to install application into. [default: 04:41:07 INFO - "/builds/slave/test"] 04:41:07 INFO - --app=APP Application being installed. [default: firefox] 04:41:07 INFO - mkdir: /builds/slave/test/build/application 04:41:07 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'] 04:41:07 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 04:41:22 INFO - Reading from file tmpfile_stdout 04:41:22 INFO - Output received: 04:41:22 INFO - /builds/slave/test/build/application/firefox/firefox 04:41:22 INFO - Running post-action listener: _resource_record_post_action 04:41:22 INFO - ##### 04:41:22 INFO - ##### Running run-tests step. 04:41:22 INFO - ##### 04:41:22 INFO - Running pre-action listener: _resource_record_pre_action 04:41:22 INFO - Running main action method: run_tests 04:41:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:41:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:41:22 INFO - Python 2.7.3 04:41:22 INFO - Return code: 0 04:41:22 INFO - grabbing minidump binary from tooltool 04:41:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:22 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 0xf3f0b0>, '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 0xf3ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf40440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:41:22 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 04:41:22 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 04:41:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:41:22 INFO - Return code: 0 04:41:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:41:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:41:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:41:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:41:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:41:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:41:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:41:23 INFO - Return code: 0 04:41:23 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K9hhvgk_Q-ywBVrXDcQ4kA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost'] in /builds/slave/test/build 04:41:23 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/K9hhvgk_Q-ywBVrXDcQ4kA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost 04:41:23 INFO - Using env: {'DISPLAY': ':0', 04:41:23 INFO - 'HOME': '/home/cltbld', 04:41:23 INFO - 'LANG': 'en_US.UTF-8', 04:41:23 INFO - 'LANGUAGE': 'en_US:en', 04:41:23 INFO - 'LOGNAME': 'cltbld', 04:41:23 INFO - 'MAIL': '/var/mail/cltbld', 04:41:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:41:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:41:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:23 INFO - 'MOZ_NO_REMOTE': '1', 04:41:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:41:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:23 INFO - 'NO_EM_RESTART': '1', 04:41:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:23 INFO - 'PWD': '/builds/slave/test', 04:41:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:41:23 INFO - 'SHELL': '/bin/bash', 04:41:23 INFO - 'SHLVL': '1', 04:41:23 INFO - 'TERM': 'linux', 04:41:23 INFO - 'TMOUT': '86400', 04:41:23 INFO - 'USER': 'cltbld', 04:41:23 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1450269626.85246-914651853', 04:41:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:23 INFO - '_': '/tools/buildbot/bin/python'} 04:41:23 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K9hhvgk_Q-ywBVrXDcQ4kA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost'] with output_timeout 3600 04:41:23 INFO - mozversion INFO | application_buildid: 20151216030908 04:41:23 INFO - mozversion INFO | application_changeset: 5fb09b81583111d48b827401905be0291a888094 04:41:23 INFO - mozversion INFO | application_display_name: Nightly 04:41:23 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:41:23 INFO - mozversion INFO | application_name: Firefox 04:41:23 INFO - mozversion INFO | application_remotingname: firefox 04:41:23 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 04:41:23 INFO - mozversion INFO | application_vendor: Mozilla 04:41:23 INFO - mozversion INFO | application_version: 46.0a1 04:41:23 INFO - mozversion INFO | platform_buildid: 20151216030908 04:41:23 INFO - mozversion INFO | platform_changeset: 5fb09b81583111d48b827401905be0291a888094 04:41:23 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 04:41:23 INFO - mozversion INFO | platform_version: 46.0a1 04:41:23 INFO - 2015-12-16 04:41:23,291 DEBUG : using testdate: 1450269683 04:41:23 INFO - 2015-12-16 04:41:23,291 DEBUG : actual date: 1450269683 04:41:23 INFO - 2015-12-16 04:41:23,338 INFO : starting webserver on 'localhost:42359' 04:41:23 INFO - 2015-12-16 04:41:23,339 INFO : Starting test suite talos-linux64-ix-025.e 04:41:23 INFO - 2015-12-16 04:41:23,339 INFO : Starting test dromaeo_css 04:41:23 INFO - 2015-12-16 04:41:23,339 DEBUG : operating with platform_type : linux_ 04:41:23 INFO - 2015-12-16 04:41:23,340 INFO : Initialising browser for dromaeo_css test... 04:41:23 INFO - 2015-12-16 04:41:23,352 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph6CD0T/profile http://localhost:42359/getInfo.html 04:41:28 INFO - 2015-12-16 04:41:28,183 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:41:28 INFO - 2015-12-16 04:41:28,183 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:41:28 INFO - 2015-12-16 04:41:28,183 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:41:28 INFO - 2015-12-16 04:41:28,183 DEBUG : BROWSER_OUTPUT: __metrics 04:41:28 INFO - 2015-12-16 04:41:28,493 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] 04:41:28 INFO - 2015-12-16 04:41:28,614 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 04:41:29 INFO - 2015-12-16 04:41:29,414 INFO : Browser initialized. 04:41:29 INFO - 2015-12-16 04:41:29,414 INFO : Running cycle 1/1 for dromaeo_css test... 04:41:29 INFO - 2015-12-16 04:41:29,415 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph6CD0T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:41:41 INFO - 2015-12-16 04:41:41,468 DEBUG : BROWSER_OUTPUT: RSS: Main: 142548992 04:41:41 INFO - 2015-12-16 04:41:41,469 DEBUG : BROWSER_OUTPUT: 04:42:31 INFO - 2015-12-16 04:42:31,102 DEBUG : BROWSER_OUTPUT: 1450269751099 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] 04:44:42 INFO - 2015-12-16 04:44:42,695 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42359/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42359/tests/dromaeo/cssquery-ext.html) 04:44:43 INFO - 2015-12-16 04:44:43,779 DEBUG : BROWSER_OUTPUT: RSS: Main: 147972096 04:44:43 INFO - 2015-12-16 04:44:43,779 DEBUG : BROWSER_OUTPUT: 04:47:45 INFO - 2015-12-16 04:47:45,804 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42359/tests/dromaeo/cssquery-ext.html (next: http://localhost:42359/tests/dromaeo/cssquery-jquery.html) 04:47:46 INFO - 2015-12-16 04:47:46,405 DEBUG : BROWSER_OUTPUT: RSS: Main: 145084416 04:47:46 INFO - 2015-12-16 04:47:46,405 DEBUG : BROWSER_OUTPUT: 04:50:48 INFO - 2015-12-16 04:50:48,138 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42359/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42359/tests/dromaeo/cssquery-mootools.html) 04:50:48 INFO - 2015-12-16 04:50:48,740 DEBUG : BROWSER_OUTPUT: RSS: Main: 145866752 04:50:48 INFO - 2015-12-16 04:50:48,740 DEBUG : BROWSER_OUTPUT: 04:53:50 INFO - 2015-12-16 04:53:50,570 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42359/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42359/tests/dromaeo/cssquery-prototype.html) 04:53:51 INFO - 2015-12-16 04:53:51,183 DEBUG : BROWSER_OUTPUT: RSS: Main: 143880192 04:53:51 INFO - 2015-12-16 04:53:51,183 DEBUG : BROWSER_OUTPUT: 04:56:53 INFO - 2015-12-16 04:56:53,822 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42359/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42359/tests/dromaeo/cssquery-yui.html) 04:56:54 INFO - 2015-12-16 04:56:54,451 DEBUG : BROWSER_OUTPUT: RSS: Main: 143892480 04:56:54 INFO - 2015-12-16 04:56:54,451 DEBUG : BROWSER_OUTPUT: 04:59:56 INFO - 2015-12-16 04:59:56,859 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42359/tests/dromaeo/cssquery-yui.html (next: http://localhost:42359/tests/dromaeo/cssquery-dojo.html) 04:59:57 INFO - 2015-12-16 04:59:57,110 DEBUG : BROWSER_OUTPUT: RSS: Main: 147427328 04:59:57 INFO - 2015-12-16 04:59:57,110 DEBUG : BROWSER_OUTPUT: 04:59:57 INFO - 2015-12-16 04:59:57,111 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:59:57 INFO - 2015-12-16 04:59:57,111 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:59:57 INFO - 2015-12-16 04:59:57,112 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:59:57 INFO - 2015-12-16 04:59:57,112 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:59:57 INFO - 2015-12-16 04:59:57,113 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2708.201080681199;2738.3838636306846;2777.9166125211173;2782.956391353244;2798.2584615077003;4707.576318131368;4873.317735517026;4873.342098816659;4912.164931961566;4937.481564435732;4762.738049407281;4805.519448055193;4844.249141383082;4850.8059677612855;4861.4652388237355;4449.288113901776;4503.549645035487;4542.909141817162;4580.519045500225;4583.633309335261;4544.954550454503;4553;4596.126735920165;4596.21864283071;4604.907901841962;4259.957400426003;4358.716683415568;4416.514183439819;4522;4530.818767249306;4504.774761261957;4515.164694531522;4538.273876179828;4546.727196368229;4561.566651168134;4279.743215407086;4483.036147228361;4499.392582001421;4518.118966801475;4535.229011068126;4648.3259927310355;4659.370984917061;4741.762911854428;4745.905081898377;4750.857474275777;5183.222516622499;5191.974040129813;5199.896002079975;5220.791168353261;5228.660137091115;5027.949720502821;5163.432022477525;5241.8165364212455;5246.842594722164;5249.42256351801;4800.567948884617;4864.343313652683;4877.731724755173;4893.73084480357;4935.087008903329;5349.358077030781;5354.277172581729;5367.490088441592;5368.32895888014;5410.810621628224;4869.878253043702;4962.652614317035;4969.155243608595;5158.432572417031;5168.870778230575;5217.530422262014;5222.582193424517;5230.476952304739;5251.894962100737;5256.369235691665;5164.2770012198325;5177.119889618773;5184.844454666366;5199.428062913076;5222.138347172674;4933.531314525115;5071.721055341918;5077.7461126944245;5147.536721695065;5210.296609957683;4223.21870453967;4243.342281946303;4252.957470425318;4258.318669012943;4300.65594752419;3720.2001569662652;3732.0856390184035;3732.925341493209;3755.9248815023548;3757.94777462311;4303.117860838521;4362.541933097043;4387.692861499664;4459.955400446019;4495.865124046284;5206.609504287194;5217.739113044333;5249.763760630781;5293.655912365684;5324.387695415076;4263.168682107022;4507.8196872124745;4510.887227819265;4518.073794872043;4585.656075794329;4463.620592249695;4496.9100617988115;4497.977510112429;4537.523560026216;4563.794629241692;4884.9511504884495;4905.5094490550655;4952.628552858478;4961.875953101057;5005.074061298744;4962.801487940442;5094.745262736922;5234.345706786652;5236.764345604533;5290.28581141541;4774.7135171889795;4824.324594556695;4869.147899117711;4900.313956046085;4915.97542012302;5098.6309692777595;5179.689218646893;5180.378354597472;5181.1969144782615;5211;5036.345275114211;5181.53366197044;5192.428832828461;5231.39838918514;5266.473352664703;4913.164761990399;4919.942212424346;4927.384076990376;5004.574611158092;5054.16606259963;4983.950160498349;5056.82301119459;5064.594832413324;5066.670666406671;5113.3097031900215;4746.501617330131;4933.358663373739;4934.802607895644;4954.1825598775795;4965.280034395065;4949.28235405857;4968.751562421792;4995.62532810048;5006.749662516932;5053.2420136979745;4947.431045429822;4958.900821983612;4970.502949705001;5005.949940500694;5030.8239211627415 04:59:57 INFO - 2015-12-16 04:59:57,114 DEBUG : BROWSER_OUTPUT: |1;ext.html;531.595987049842;562.0725802425994;581.0818906128317;592.7332700284871;620.4942971478242;36069.81965090174;37122.25755484892;37227.627723722755;37302.25395492089;37318.253634927285;36900.446493302625;37376.999999999935;37653.43519847204;37711.057223569354;37731.24537509248;7764.340031097349;7955.124936257007;7962.363010959139;7970.561619110947;7980.720674776384;7576.545407275581;7697.307242348187;7701.191374905638;7706.537607743525;7717.228277172266;7830;7888.802779930519;7913.723019694312;7913.841723165533;7923.0888447828665;7810.297073263405;7828.647710852997;7900.683972641087;7921.128675845653;7924.088729796032;7737.419693522952;7834.529928204326;7861.528308301463;7869.527828330261;7874.409419293576;34960.300793984235;35251.29497410063;35361.64638353635;35391.82304088463;35557.1110722234;3036.316828713544;3092.7371173450283;3099.7830151889375;3330.0009997000802;3557.1462848916076;27686.584701229498;27840.860795696095;27927.779360248715;28166.71833281682;28553.428931421462;3165.8258795766224;3234.417804795136;3261.673832616743;3265.7713960022807;3285.0473362724783;202956;205082;206257;206771;206783;51566.48433515692;52381.738091310064;55448;63060.36939630637;64295;56453.15320270199;56824.715876420356;56837.14744278839;57023.42976570264;57121;13790.517331893336;13928.303584820718;13965.231912244924;13981.300934953211;14009.439622415193;11229.494672739746;11331.660050198507;11332.886671133349;11339.886601134049;11345.886541134483;19480.610387792163;19680.311189108597;19827.107780149927;19949.700754488695;20078.196872125245;7213.747518836815;7286.744963926343;7288.562686238843;7375.336219740249;7416.332530072319;834.5243211369583;873.3188113271658;915.33638112368;940.8541676040225;1080.3895798873612;22928.4267893304;22959.311220663407;23311.7668823313;24374.146904858244;24505.75494245035;940.9247260219166;956.9425834449955;1024.2113572549094;1118.7091356247433;1167.626359564948;13176.077674562688;13187.274699891597;13191.274479903506;13215.933920330337;14350.21073840928;257213;259095;259585;260035;261292;47754;48208;48236.517634823205;48266.75866620644;48341;1217.975640487203;1245.9501619935281;1251.030451400172;1270.1172684984033;1271.663009302554;27519;27554.311142221606;27800.443991120468;27802.16593502198;28091;41519.792401037805;41843;42207.155856883306;42329.15341693087;42369;237065;238654.84035478963;238743;239150;240931;28979.710202897702;29054.27364315909;29784;29841.55237671393;29896.402071958873;35341.64658353384;35343.939681809585;37528.81235593914;37779.81110094542;38230.2353952925;31706.365872681956;31870;32214.19464513406;32732.509012364357;33087.33825323432;31741.68258317387;32696.673033269362;32711.509327359632;32790.5081423774;33516.49725254074;29956.550651739806;30160.5475917857;30231.093067208018;30442.391152177275;30475.542866856573;27546.5868011984;28764;29512.409751805273;29704.257393565334;29785.25536861596;23390.766092338858;23572.174973875834;23662.450632405278;23968.76031239735;24014.27957161288 04:59:57 INFO - 2015-12-16 04:59:57,118 DEBUG : BROWSER_OUTPUT: |2;jquery.html;342.4760117020958;343.44019248624755;343.975921685482;344.74316634107595;345.03218472185523;15093.320800563974;15229.390824367027;15759.60600984976;16490.835091649078;16576.66846663066;15106.697866042672;15303.540893773177;15878.04731716098;15921;15925.522234332959;4256.531781504032;4376.912461750763;4376.956230437687;4383.167198232341;4407.382966384709;3434.8454319555553;4311.784410779464;4355.956440435587;4365.978170109161;4863.076015557051;4753.857384278477;4816.590589799871;4844.224924012159;4872.512748725117;4896.412430508344;4879.634027447938;4892.094962431962;4897.755112244374;4910.238912968495;5234.581233501311;5244.29202057725;5259.789608415659;5267.236250743621;5273.077211488013;5280.709560974145;10983.450827458595;11209.495572699248;15172.848271517365;18817.247310107578;18931.14809833561;1778.6353797471488;1815.5551889786955;1858.4517567317673;1873.4192400355796;1956.7358406615067;8698;8875.689350872753;9244.630214791401;10118.89881101187;13207.207567545882;1723.4312676816621;1739.3390511605635;1743.3462451580658;1793.9372121975669;1804.3233787329752;54617.453825462035;54929.45070549283;55128.448715513136;55487;55654.721726391515;9670.613175473043;9848.950755246178;9901.356411833352;9903.504824758733;9918.107370336704;12519.687007824878;12609.810852837214;12613.180143290656;12619.432125554373;12623.621291361274;6840.213375461885;6845.828854278683;6964;6974.163100427981;7026.613536255452;6520.152380190545;6525.119108920235;6539.934600654028;6555.508336874754;6568.343165683489;4187.246295666749;4223.239816832938;4229.830806767694;4240.787960601958;4242.257604919127;1755.6664233795539;1781.6169523552499;1809.222034525167;1824.5438640339914;1832.15720768448;807.7495976247264;855.7389996051264;883.2183517586982;922.8754118194092;954.9352471993677;15182.316795744218;15285;15399.615009624626;15841.683166336608;15900.840991590167;807.0920214758397;830.3149901331306;831.5218749219223;912.7261821453537;940.9508398136165;8870.467771933705;9024.729258122266;9239;9407.529623518796;9415.529223538795;501472;506483;513042;520502;521019;68936;69950;70199.64900175466;70527.64736176388;70903;1069.9144068474504;1112.6217086190734;1115.642994241835;1121.4785124916953;1172.7185475485992;13527.661808454868;14057.929710351384;14283.64290892736;14439.639009024859;14470.638234043812;31929.20176995501;31973.36053278968;32272.515912260864;32776.21402180746;32981.50527742038;38588;38885;40643;40706.1858762829;40995.79502102471;8486.363522735695;8517.23344898962;8632.654693812177;8986.730398088068;9012.86480702803;15842.366305348118;16097.275622596777;16118.274677639769;16120.516384508484;16315.18424078815;12894.388201474816;13427.328633568477;13542.729145417234;13915.791263130859;13923;10807.783844323227;13551.457941682222;13711.177329360271;14011.719765604834;14359.282035897955;12410.193337433038;13690.52083177084;13994.860051399763;14386.496472623408;14396.85603143955;8407.915920840713;8566.357523185661;8819.91180088191;8920.528112861306;8991.370604057653;9025.909740902769;9227.35408521424;9233.538323083952;12777.744445111231;13543.390547425193 04:59:57 INFO - 2015-12-16 04:59:57,119 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1382.5575815738969;1421.8364888037872;1449.7825326201075;1613.2982152763548;1688.662267546491;7171.641417929096;7324.853502929945;7409.333160015598;7487.2138425465355;7501.249875012496;7253.455990800685;7353.522021068627;7429.8885516717155;7433.405327573794;7454.030975973116;2074.8547601667888;2100.170432679091;2101.9789802102014;2112.302940029794;2115.925942592002;2133.0294715904224;2135.2740068376747;2140.625390556654;2149.580831737812;2175.3800166952424;1624.3177865296545;1657.1051632118701;2010.5074256807102;2085.259732794859;2124.72378590783;2053.5379539603546;2060.258307009475;2060.258307009475;2061.5979883922714;2063.1850419084526;2055.290924631;2056.92800751973;2082.6563617003176;2095.371388583419;2100.548382097841;7096;7227.457940654472;7252.492325537214;7257.274272572753;7289.307515785992;4162.167566486684;4174.248635245654;4200.894977625584;4241.045764702948;4246.426732391149;2748.9862550687317;2755.145904769528;2785.7075007124163;2816.0706966701146;2830.9150725478266;876.3252295732251;887.8446271902455;894.3650008493977;906.8265545065386;923.7275003873806;9797.461139637317;9835.45904975226;9859.556319965619;9863.30956833029;9918.900810991941;3726.2920045191327;3782.3380908341483;3822.827972741233;3840.8847734568008;3845.8461661533784;7641.083070031632;7672.616369181518;7686.500377475446;7712.190220026929;7753.379729621617;4228.894277643083;4231.280682284019;4236.046889449911;4239.300515414983;4254.3831144483875;3817.1602247505502;3820.3505404081375;3829.463875057494;3854.7494412863075;3876.903077423087;3111.9377612447624;3111.9533207001914;3142.5443310720275;3144.135362775255;3157.984210078981;924.0713083351189;928.6981730937338;928.8235235305406;933.0622724162174;934.7289286107089;837.0666706622072;941.2987324443334;998.6205242008135;1013.8479228115694;1211.0493262788668;6847.315268473212;6870.828229294208;6874.2782007889455;6882.69027893746;6914.792556223321;564.8305508347479;570.315621254488;581.2966310764023;581.6103210848742;726.1358982810439;5248.501392367719;5345;5364.383095943938;5370.113931201308;5377.489138531833;8469.576521173916;8960.820783584422;8985.550722463851;8990.190882820578;9082.727518174466;8831.205191532792;8853.29173666118;8892.421992570462;8936.106389361012;8939.73180804577;6597.076409302702;6746.392824645805;6766.966165169143;6797.320267973262;6968.79093627192;6944.756933507505;6961.234264231032;7015.824604384931;7060.576365418091;7064.258252883374;7723.382129429745;7912.525248485109;7942.761717148494;7970.601469926596;8093.55485448306;7829.843403131791;7911.643976021208;7930.841383172419;7947;7987.281144696773;6402.743890244338;6431.067495213074;6464.159659244457;6502.122213501117;6510.73957041713;6990.61551614666;7060.71757129709;7066.470014748812;7072.82317942035;7093.858122837618;6480.222373315232;6500.772472963424;6606;6636.104125943129;6676.56602320867;6240.500759939285;6292.370762923671;6336.7148478319505;6367.713452894724;6395.712192951235;6613.801585952429;6677.866442671217;6699.933000670126;6710.66446677674;6713.12729345182;6053.3946605339115;6081.209442772411;6156.26124865019;6165;6254.718537665725;6138.693065346804;6191.876162476635;6195.783147589993;6261.123442717932;6262.123302737711 04:59:57 INFO - 2015-12-16 04:59:57,119 DEBUG : BROWSER_OUTPUT: |4;prototype.html;299.15190435116443;304.8658590220304;309.6872159119289;310.2940809658028;310.30646505061185;5582.0789569721;5592.853465039667;5667.858303542408;5717.7998770043005;5745.36800951896;5600.4959553640165;5664.433556644333;5664.801731939383;5679.858003549903;5685.8578535536635;4148.730332528391;4234.470691163605;4306.418633484471;4308.116836048603;4309.3320535317;4220.620144187023;4229.767362795045;4230.97884510577;4244.1511697660435;4251.0860165064505;4192.727472714279;4192.805050560591;4211.68412369072;4213.073123912734;4216.978915105436;4196.664266858644;4206.390073439365;4209.894752631178;4212.641925436326;4219.683523735702;3620.837062332201;3659.8902032939054;3669.486271921933;3674.595794462607;3675.044488433;5227.817026404057;5332.440093790174;5353.973230133864;5386.946130538723;5409.594280428944;4850.951490485085;4884.5603895649565;4889.413270407538;4890.975545122252;4891.5353041461;5879.412058794129;5888.823335299948;5890.322612899528;5895.882082358372;5899.5870289079785;3884.9805750971063;4022.557518672944;4028.657564107025;4029.838806447768;4033.7983100845136;6124.234470691119;6129.570930034854;6174.567780255384;6180.474659653934;6191.25704915413;4063.837446502166;4097.528784189797;4100.708276892769;4100.712950093465;4100.958990410118;4142.91714165715;4155.376693495939;4169.041120542292;4171.687123465752;4176.2900306947895;4729.763511824395;4774.379330686988;4793.784279707422;4797.136515427256;4829.541193586604;5831.766729330864;5833.82498525045;5835.153902684087;5840.94159058404;5844.970775146182;1453.9709205816037;1471.720373129102;1473.6168596165073;1476.438953197778;1484.5917372722588;955.460165006769;984.5667906121283;986.6398764450923;1002.6240159940022;1010.5705075343096;5096.61775366849;5102.974485127551;5111.437741848394;5111.744412779346;5119.795208191631;6033.818985430444;6091.390860913873;6093.994490909039;6103.938960610426;6124.112003759519;5071.949280507221;5083.974580127076;5088.796448142033;5096.464871188472;5098.439171691111;3193.425183466998;3241;3270.918227044343;3293.2096296888576;3295.653956334598;5589.357223919302;5692.886142277214;5694.288213973254;5706.201131841545;5708.857278567986;6127.325994140641;6294.527910406738;6347.55567110307;6362.1093046973465;6399.64801935898;5764.855878603068;5785.3636100028125;5789.247397838254;5801.9419805802245;5803.187553742564;5955.5235581154275;6138.662373569497;6161.568690191643;6161.661108639068;6170.938290617037;6009.699515024318;6010;6010.2186715726675;6011.368806275278;6023.367546407564;5812.157237200498;5824.854378640568;5826.155207494974;5841.32824725162;5847.619904706351;4132.524759652679;4178.665706743514;4180.91638167241;4188.518320393194;4200.201961627281;6006.789762358471;6104.664243466652;6171.907421388593;6179.320274769681;6185.721642526007;5834.533237340917;5853.531717462508;5888.735006924613;5913.556483263858;5914.290285165807;5867.647941123546;5902.1736956826935;5922.318933322551;5925.555583331181;5928.584999050025;5631.915521267102;5790.594658373873;5795.043817770021;5798.652080875161;5803.738831752666;5968.432998865101;5973.432523910222;5983.521318294613;5988.251468566429;5997.520198384032;5830.970845145747;5833.883322333445;5836.678982655994;5837.562182836219;5838 04:59:57 INFO - 2015-12-16 04:59:57,120 DEBUG : BROWSER_OUTPUT: |5;yui.html;675.8918573028317;695.1484431571325;739.5230076600593;745.6160077560061;767.7389687506246;11481.942590287048;11653.883461165375;11674.591389301377;11713.882861171385;11790.410479476024;11379.146564007691;13294.534691285808;13561.728765424685;13634.29571303587;13634.795478067837;799.3285640062361;812.475953010311;813.3127507256359;814.1573471457043;822.9753107406788;824.4805772363403;826.4793180296435;827.962741676626;829.2288172000037;832.9208725171129;821.9506829590214;859.7979474823411;861.8104017116225;861.8965724113084;863.1109956744563;848.6393282854793;849.9150084991513;849.9787505312355;851.535912927456;854.2269246332111;632.914556534871;634.1565717595632;634.7524465458429;635.1584150999897;635.5328833307515;12311.19977201479;12392.876071239263;12396.690082747913;12408.317542535156;12434.502619895193;10850.511726972305;11029.779404411947;11088.55645774168;11262;11796.233244839059;9229.953850230706;9271.351005429622;9390.671326503609;9452.669156579486;9522.761930951781;3140.8272545010013;3188.505781603855;3196.1689960610174;3215.8552865121123;3239.8542065606866;40003.59996400028;40290.395644065364;40431.7978410109;40482;40580.18839623191;9366.812663746823;9556.569954352071;9603.711888643353;9664.516774161264;9770.804583908282;15840.366385344458;15966.441174559068;15989.680206395808;16011.359545618277;16019.038857668576;5877.235959325346;5926.851828704231;5944.910826337608;6024.759009639653;6074.392560743979;3520.471929210639;3580.964190358115;3586.55168103987;3587.582134656099;3629.038304849217;2589.6374507568958;2594.792416606667;2605.622184783234;2625.5799072148366;2627.356297707074;466.1190350238053;470.1912710138556;476.1239319651857;481.0643298783832;482.44759750085956;511.2739909328762;605.6396444115744;626.223482881224;634.6350848262175;635.9872802543923;7831.608419579112;7885.5662938538935;7980.441369104223;8003.559804210708;8092.271695547429;485.4950851114872;497.53729031999865;526.7945501254513;626.139058794158;628.7642134199675;3765.284595926765;3773.3208022556205;3784.848606055782;3805.2009078093356;3874.341361968472;50763;51187.9049676025;51212.48787512077;51538.48461515412;51618.741906290226;44812.55187448149;44838.55161448409;44925.775371123586;45073.77463112663;45469;42013.78993105015;42160.1567968645;42517;42530.57469425328;42735.35896961548;7687.961560192163;7822.608869556613;7852.6073696313815;7978.202179782207;8025.759227223192;28491;29020.854895725388;29191.270218244714;29331.560026600044;30657;35155.824220878734;35251.294974100885;35414.64585354114;36441.08897277589;39456.6054339453;9732.513374331396;10051.648192313234;10101.191904647463;10381.429021403896;10463.424511651932;11134.610288639858;11458.255213411101;11566.421678915853;11572.826407604061;11587.20398338259;10644.8935510647;10713.196510261918;11190.83213751778;11258.21192516516;11509.251898626562;10671.94664026675;10913.854045325126;10914.50884710174;10926.945365273123;11096.5561377544;10546.419946902686;10614.575416983234;10701.89298107009;10831.566737330419;11014.284071535325;9384.340107358272;9500.667476638284;9641.662541811003;9700.563474643517;9747.951260243937;9178.724638260863;9444.291678124031;9529.52352382392;9609.231261499202;9650.758731031781 04:59:57 INFO - 2015-12-16 04:59:57,120 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:59:57 INFO - 2015-12-16 04:59:57,121 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:59:57 INFO - 2015-12-16 04:59:57,121 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,338 04:59:57 INFO - 2015-12-16 04:59:57,121 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:59:57 INFO - 2015-12-16 04:59:57,121 DEBUG : BROWSER_OUTPUT: __startTimestamp1450270797111__endTimestamp 04:59:57 INFO - 2015-12-16 04:59:57,121 DEBUG : BROWSER_OUTPUT: 04:59:57 INFO - 2015-12-16 04:59:57,121 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:59:57 INFO - 2015-12-16 04:59:57,121 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:59:57 INFO - 2015-12-16 04:59:57,121 DEBUG : BROWSER_OUTPUT: 04:59:57 INFO - 2015-12-16 04:59:57,121 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4779.40 Median:4915.98 stddev:507.39 (10.3%) stddev-sans-first:482.23 04:59:57 INFO - 2015-12-16 04:59:57,121 DEBUG : BROWSER_OUTPUT: Values: 2708.2 2738.4 2777.9 2783.0 2798.3 4707.6 4873.3 4873.3 4912.2 4937.5 4762.7 4805.5 4844.2 4850.8 4861.5 4449.3 4503.5 4542.9 4580.5 4583.6 4545.0 4553.0 4596.1 4596.2 4604.9 4260.0 4358.7 4416.5 4522.0 4530.8 4504.8 4515.2 4538.3 4546.7 4561.6 4279.7 4483.0 4499.4 4518.1 4535.2 4648.3 4659.4 4741.8 4745.9 4750.9 5183.2 5192.0 5199.9 5220.8 5228.7 5027.9 5163.4 5241.8 5246.8 5249.4 4800.6 4864.3 4877.7 4893.7 4935.1 5349.4 5354.3 5367.5 5368.3 5410.8 4869.9 4962.7 4969.2 5158.4 5168.9 5217.5 5222.6 5230.5 5251.9 5256.4 5164.3 5177.1 5184.8 5199.4 5222.1 4933.5 5071.7 5077.7 5147.5 5210.3 4223.2 4243.3 4253.0 4258.3 4300.7 3720.2 3732.1 3732.9 3755.9 3757.9 4303.1 4362.5 4387.7 4460.0 4495.9 5206.6 5217.7 5249.8 5293.7 5324.4 4263.2 4507.8 4510.9 4518.1 4585.7 4463.6 4496.9 4498.0 4537.5 4563.8 4885.0 4905.5 4952.6 4961.9 5005.1 4962.8 5094.7 5234.3 5236.8 5290.3 4774.7 4824.3 4869.1 4900.3 4916.0 5098.6 5179.7 5180.4 5181.2 5211.0 5036.3 5181.5 5192.4 5231.4 5266.5 4913.2 4919.9 4927.4 5004.6 5054.2 4984.0 5056.8 5064.6 5066.7 5113.3 4746.5 4933.4 4934.8 4954.2 4965.3 4949.3 4968.8 4995.6 5006.7 5053.2 4947.4 4958.9 4970.5 5005.9 5030.8 04:59:57 INFO - 2015-12-16 04:59:57,121 DEBUG : BROWSER_OUTPUT: 04:59:57 INFO - 2015-12-16 04:59:57,121 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39644.73 Median:32704.09 stddev:61360.99 (187.6%) stddev-sans-first:61462.84 04:59:57 INFO - 2015-12-16 04:59:57,123 DEBUG : BROWSER_OUTPUT: Values: 531.6 562.1 581.1 592.7 620.5 36069.8 37122.3 37227.6 37302.3 37318.3 36900.4 37377.0 37653.4 37711.1 37731.2 7764.3 7955.1 7962.4 7970.6 7980.7 7576.5 7697.3 7701.2 7706.5 7717.2 7830.0 7888.8 7913.7 7913.8 7923.1 7810.3 7828.6 7900.7 7921.1 7924.1 7737.4 7834.5 7861.5 7869.5 7874.4 34960.3 35251.3 35361.6 35391.8 35557.1 3036.3 3092.7 3099.8 3330.0 3557.1 27686.6 27840.9 27927.8 28166.7 28553.4 3165.8 3234.4 3261.7 3265.8 3285.0 202956.0 205082.0 206257.0 206771.0 206783.0 51566.5 52381.7 55448.0 63060.4 64295.0 56453.2 56824.7 56837.1 57023.4 57121.0 13790.5 13928.3 13965.2 13981.3 14009.4 11229.5 11331.7 11332.9 11339.9 11345.9 19480.6 19680.3 19827.1 19949.7 20078.2 7213.7 7286.7 7288.6 7375.3 7416.3 834.5 873.3 915.3 940.9 1080.4 22928.4 22959.3 23311.8 24374.1 24505.8 940.9 956.9 1024.2 1118.7 1167.6 13176.1 13187.3 13191.3 13215.9 14350.2 257213.0 259095.0 259585.0 260035.0 261292.0 47754.0 48208.0 48236.5 48266.8 48341.0 1218.0 1246.0 1251.0 1270.1 1271.7 27519.0 27554.3 27800.4 27802.2 28091.0 41519.8 41843.0 42207.2 42329.2 42369.0 237065.0 238654.8 238743.0 239150.0 240931.0 28979.7 29054.3 29784.0 29841.6 29896.4 35341.6 35343.9 37528.8 37779.8 38230.2 31706.4 31870.0 32214.2 32732.5 33087.3 31741.7 32696.7 32711.5 32790.5 33516.5 29956.6 30160.5 30231.1 30442.4 30475.5 27546.6 28764.0 29512.4 29704.3 29785.3 23390.8 23572.2 23662.5 23968.8 24014.3 04:59:57 INFO - 2015-12-16 04:59:57,123 DEBUG : BROWSER_OUTPUT: 04:59:57 INFO - 2015-12-16 04:59:57,123 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26747.09 Median:4205.24 stddev:83650.28 (1989.2%) stddev-sans-first:83861.44 04:59:57 INFO - 2015-12-16 04:59:57,124 DEBUG : BROWSER_OUTPUT: Values: 342.5 343.4 344.0 344.7 345.0 15093.3 15229.4 15759.6 16490.8 16576.7 15106.7 15303.5 15878.0 15921.0 15925.5 4256.5 4376.9 4377.0 4383.2 4407.4 3434.8 4311.8 4356.0 4366.0 4863.1 4753.9 4816.6 4844.2 4872.5 4896.4 4879.6 4892.1 4897.8 4910.2 5234.6 5244.3 5259.8 5267.2 5273.1 5280.7 10983.5 11209.5 15172.8 18817.2 18931.1 1778.6 1815.6 1858.5 1873.4 1956.7 8698.0 8875.7 9244.6 10118.9 13207.2 1723.4 1739.3 1743.3 1793.9 1804.3 54617.5 54929.5 55128.4 55487.0 55654.7 9670.6 9849.0 9901.4 9903.5 9918.1 12519.7 12609.8 12613.2 12619.4 12623.6 6840.2 6845.8 6964.0 6974.2 7026.6 6520.2 6525.1 6539.9 6555.5 6568.3 4187.2 4223.2 4229.8 4240.8 4242.3 1755.7 1781.6 1809.2 1824.5 1832.2 807.7 855.7 883.2 922.9 954.9 15182.3 15285.0 15399.6 15841.7 15900.8 807.1 830.3 831.5 912.7 941.0 8870.5 9024.7 9239.0 9407.5 9415.5 501472.0 506483.0 513042.0 520502.0 521019.0 68936.0 69950.0 70199.6 70527.6 70903.0 1069.9 1112.6 1115.6 1121.5 1172.7 13527.7 14057.9 14283.6 14439.6 14470.6 31929.2 31973.4 32272.5 32776.2 32981.5 38588.0 38885.0 40643.0 40706.2 40995.8 8486.4 8517.2 8632.7 8986.7 9012.9 15842.4 16097.3 16118.3 16120.5 16315.2 12894.4 13427.3 13542.7 13915.8 13923.0 10807.8 13551.5 13711.2 14011.7 14359.3 12410.2 13690.5 13994.9 14386.5 14396.9 8407.9 8566.4 8819.9 8920.5 8991.4 9025.9 9227.4 9233.5 12777.7 13543.4 04:59:57 INFO - 2015-12-16 04:59:57,124 DEBUG : BROWSER_OUTPUT: 04:59:57 INFO - 2015-12-16 04:59:57,124 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5052.13 Median:6501.45 stddev:2686.20 (41.3%) stddev-sans-first:2679.58 04:59:57 INFO - 2015-12-16 04:59:57,124 DEBUG : BROWSER_OUTPUT: Values: 1382.6 1421.8 1449.8 1613.3 1688.7 7171.6 7324.9 7409.3 7487.2 7501.2 7253.5 7353.5 7429.9 7433.4 7454.0 2074.9 2100.2 2102.0 2112.3 2115.9 2133.0 2135.3 2140.6 2149.6 2175.4 1624.3 1657.1 2010.5 2085.3 2124.7 2053.5 2060.3 2060.3 2061.6 2063.2 2055.3 2056.9 2082.7 2095.4 2100.5 7096.0 7227.5 7252.5 7257.3 7289.3 4162.2 4174.2 4200.9 4241.0 4246.4 2749.0 2755.1 2785.7 2816.1 2830.9 876.3 887.8 894.4 906.8 923.7 9797.5 9835.5 9859.6 9863.3 9918.9 3726.3 3782.3 3822.8 3840.9 3845.8 7641.1 7672.6 7686.5 7712.2 7753.4 4228.9 4231.3 4236.0 4239.3 4254.4 3817.2 3820.4 3829.5 3854.7 3876.9 3111.9 3112.0 3142.5 3144.1 3158.0 924.1 928.7 928.8 933.1 934.7 837.1 941.3 998.6 1013.8 1211.0 6847.3 6870.8 6874.3 6882.7 6914.8 564.8 570.3 581.3 581.6 726.1 5248.5 5345.0 5364.4 5370.1 5377.5 8469.6 8960.8 8985.6 8990.2 9082.7 8831.2 8853.3 8892.4 8936.1 8939.7 6597.1 6746.4 6767.0 6797.3 6968.8 6944.8 6961.2 7015.8 7060.6 7064.3 7723.4 7912.5 7942.8 7970.6 8093.6 7829.8 7911.6 7930.8 7947.0 7987.3 6402.7 6431.1 6464.2 6502.1 6510.7 6990.6 7060.7 7066.5 7072.8 7093.9 6480.2 6500.8 6606.0 6636.1 6676.6 6240.5 6292.4 6336.7 6367.7 6395.7 6613.8 6677.9 6699.9 6710.7 6713.1 6053.4 6081.2 6156.3 6165.0 6254.7 6138.7 6191.9 6195.8 6261.1 6262.1 04:59:57 INFO - 2015-12-16 04:59:57,125 DEBUG : BROWSER_OUTPUT: 04:59:57 INFO - 2015-12-16 04:59:57,125 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4854.66 Median:5616.21 stddev:1459.43 (26.0%) stddev-sans-first:1422.90 04:59:57 INFO - 2015-12-16 04:59:57,128 DEBUG : BROWSER_OUTPUT: Values: 299.2 304.9 309.7 310.3 310.3 5582.1 5592.9 5667.9 5717.8 5745.4 5600.5 5664.4 5664.8 5679.9 5685.9 4148.7 4234.5 4306.4 4308.1 4309.3 4220.6 4229.8 4231.0 4244.2 4251.1 4192.7 4192.8 4211.7 4213.1 4217.0 4196.7 4206.4 4209.9 4212.6 4219.7 3620.8 3659.9 3669.5 3674.6 3675.0 5227.8 5332.4 5354.0 5386.9 5409.6 4851.0 4884.6 4889.4 4891.0 4891.5 5879.4 5888.8 5890.3 5895.9 5899.6 3885.0 4022.6 4028.7 4029.8 4033.8 6124.2 6129.6 6174.6 6180.5 6191.3 4063.8 4097.5 4100.7 4100.7 4101.0 4142.9 4155.4 4169.0 4171.7 4176.3 4729.8 4774.4 4793.8 4797.1 4829.5 5831.8 5833.8 5835.2 5840.9 5845.0 1454.0 1471.7 1473.6 1476.4 1484.6 955.5 984.6 986.6 1002.6 1010.6 5096.6 5103.0 5111.4 5111.7 5119.8 6033.8 6091.4 6094.0 6103.9 6124.1 5071.9 5084.0 5088.8 5096.5 5098.4 3193.4 3241.0 3270.9 3293.2 3295.7 5589.4 5692.9 5694.3 5706.2 5708.9 6127.3 6294.5 6347.6 6362.1 6399.6 5764.9 5785.4 5789.2 5801.9 5803.2 5955.5 6138.7 6161.6 6161.7 6170.9 6009.7 6010.0 6010.2 6011.4 6023.4 5812.2 5824.9 5826.2 5841.3 5847.6 4132.5 4178.7 4180.9 4188.5 4200.2 6006.8 6104.7 6171.9 6179.3 6185.7 5834.5 5853.5 5888.7 5913.6 5914.3 5867.6 5902.2 5922.3 5925.6 5928.6 5631.9 5790.6 5795.0 5798.7 5803.7 5968.4 5973.4 5983.5 5988.3 5997.5 5831.0 5833.9 5836.7 5837.6 5838.0 04:59:57 INFO - 2015-12-16 04:59:57,128 DEBUG : BROWSER_OUTPUT: 04:59:57 INFO - 2015-12-16 04:59:57,129 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12298.04 Median:44882.16 stddev:13809.24 (30.8%) stddev-sans-first:13820.40 04:59:57 INFO - 2015-12-16 04:59:57,129 DEBUG : BROWSER_OUTPUT: Values: 675.9 695.1 739.5 745.6 767.7 11481.9 11653.9 11674.6 11713.9 11790.4 11379.1 13294.5 13561.7 13634.3 13634.8 799.3 812.5 813.3 814.2 823.0 824.5 826.5 828.0 829.2 832.9 822.0 859.8 861.8 861.9 863.1 848.6 849.9 850.0 851.5 854.2 632.9 634.2 634.8 635.2 635.5 12311.2 12392.9 12396.7 12408.3 12434.5 10850.5 11029.8 11088.6 11262.0 11796.2 9230.0 9271.4 9390.7 9452.7 9522.8 3140.8 3188.5 3196.2 3215.9 3239.9 40003.6 40290.4 40431.8 40482.0 40580.2 9366.8 9556.6 9603.7 9664.5 9770.8 15840.4 15966.4 15989.7 16011.4 16019.0 5877.2 5926.9 5944.9 6024.8 6074.4 3520.5 3581.0 3586.6 3587.6 3629.0 2589.6 2594.8 2605.6 2625.6 2627.4 466.1 470.2 476.1 481.1 482.4 511.3 605.6 626.2 634.6 636.0 7831.6 7885.6 7980.4 8003.6 8092.3 485.5 497.5 526.8 626.1 628.8 3765.3 3773.3 3784.8 3805.2 3874.3 50763.0 51187.9 51212.5 51538.5 51618.7 44812.6 44838.6 44925.8 45073.8 45469.0 42013.8 42160.2 42517.0 42530.6 42735.4 7688.0 7822.6 7852.6 7978.2 8025.8 28491.0 29020.9 29191.3 29331.6 30657.0 35155.8 35251.3 35414.6 36441.1 39456.6 9732.5 10051.6 10101.2 10381.4 10463.4 11134.6 11458.3 11566.4 11572.8 11587.2 10644.9 10713.2 11190.8 11258.2 11509.3 10671.9 10913.9 10914.5 10926.9 11096.6 10546.4 10614.6 10701.9 10831.6 11014.3 9384.3 9500.7 9641.7 9700.6 9748.0 9178.7 9444.3 9529.5 9609.2 9650.8 04:59:57 INFO - 2015-12-16 04:59:57,129 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:59:57 INFO - 2015-12-16 04:59:57,129 DEBUG : BROWSER_OUTPUT: 04:59:57 INFO - 2015-12-16 04:59:57,876 INFO : Browser exited with error code: 0 04:59:57 INFO - 2015-12-16 04:59:57,901 INFO : Completed test dromaeo_css (00:18:34) 04:59:57 INFO - 2015-12-16 04:59:57,901 INFO : Starting test kraken 04:59:57 INFO - 2015-12-16 04:59:57,901 DEBUG : operating with platform_type : linux_ 04:59:57 INFO - 2015-12-16 04:59:57,901 INFO : Initialising browser for kraken test... 04:59:57 INFO - 2015-12-16 04:59:57,907 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppOhBt7/profile http://localhost:42359/getInfo.html 05:00:02 INFO - 2015-12-16 05:00:02,650 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:00:02 INFO - 2015-12-16 05:00:02,650 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:00:02 INFO - 2015-12-16 05:00:02,650 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:00:02 INFO - 2015-12-16 05:00:02,650 DEBUG : BROWSER_OUTPUT: __metrics 05:00:02 INFO - 2015-12-16 05:00:02,759 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] 05:00:03 INFO - 2015-12-16 05:00:03,698 INFO : Browser initialized. 05:00:03 INFO - 2015-12-16 05:00:03,698 INFO : Running cycle 1/1 for kraken test... 05:00:03 INFO - 2015-12-16 05:00:03,699 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppOhBt7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:00:15 INFO - 2015-12-16 05:00:15,712 DEBUG : BROWSER_OUTPUT: RSS: Main: 143704064 05:00:15 INFO - 2015-12-16 05:00:15,713 DEBUG : BROWSER_OUTPUT: 05:00:18 INFO - 2015-12-16 05:00:18,328 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42359/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42359/tests/kraken/driver.html?testName=audio-beat-detection) 05:00:18 INFO - 2015-12-16 05:00:18,950 DEBUG : BROWSER_OUTPUT: RSS: Main: 142770176 05:00:18 INFO - 2015-12-16 05:00:18,950 DEBUG : BROWSER_OUTPUT: 05:00:21 INFO - 2015-12-16 05:00:21,702 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42359/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42359/tests/kraken/driver.html?testName=audio-dft) 05:00:22 INFO - 2015-12-16 05:00:22,295 DEBUG : BROWSER_OUTPUT: RSS: Main: 143466496 05:00:22 INFO - 2015-12-16 05:00:22,295 DEBUG : BROWSER_OUTPUT: 05:00:25 INFO - 2015-12-16 05:00:25,186 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42359/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42359/tests/kraken/driver.html?testName=audio-fft) 05:00:25 INFO - 2015-12-16 05:00:25,788 DEBUG : BROWSER_OUTPUT: RSS: Main: 137633792 05:00:25 INFO - 2015-12-16 05:00:25,788 DEBUG : BROWSER_OUTPUT: 05:00:27 INFO - 2015-12-16 05:00:27,866 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42359/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42359/tests/kraken/driver.html?testName=audio-oscillator) 05:00:28 INFO - 2015-12-16 05:00:28,451 DEBUG : BROWSER_OUTPUT: RSS: Main: 138858496 05:00:28 INFO - 2015-12-16 05:00:28,451 DEBUG : BROWSER_OUTPUT: 05:00:30 INFO - 2015-12-16 05:00:30,738 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42359/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42359/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:00:31 INFO - 2015-12-16 05:00:31,320 DEBUG : BROWSER_OUTPUT: RSS: Main: 140374016 05:00:31 INFO - 2015-12-16 05:00:31,320 DEBUG : BROWSER_OUTPUT: 05:00:34 INFO - 2015-12-16 05:00:34,421 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42359/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42359/tests/kraken/driver.html?testName=imaging-darkroom) 05:00:35 INFO - 2015-12-16 05:00:35,029 DEBUG : BROWSER_OUTPUT: RSS: Main: 141017088 05:00:35 INFO - 2015-12-16 05:00:35,029 DEBUG : BROWSER_OUTPUT: 05:00:38 INFO - 2015-12-16 05:00:38,512 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42359/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42359/tests/kraken/driver.html?testName=imaging-desaturate) 05:00:39 INFO - 2015-12-16 05:00:39,102 DEBUG : BROWSER_OUTPUT: RSS: Main: 138743808 05:00:39 INFO - 2015-12-16 05:00:39,102 DEBUG : BROWSER_OUTPUT: 05:00:42 INFO - 2015-12-16 05:00:42,073 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42359/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42359/tests/kraken/driver.html?testName=json-parse-financial) 05:00:42 INFO - 2015-12-16 05:00:42,667 DEBUG : BROWSER_OUTPUT: RSS: Main: 139571200 05:00:42 INFO - 2015-12-16 05:00:42,667 DEBUG : BROWSER_OUTPUT: 05:00:44 INFO - 2015-12-16 05:00:44,448 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42359/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42359/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:00:45 INFO - 2015-12-16 05:00:45,035 DEBUG : BROWSER_OUTPUT: RSS: Main: 140914688 05:00:45 INFO - 2015-12-16 05:00:45,035 DEBUG : BROWSER_OUTPUT: 05:00:46 INFO - 2015-12-16 05:00:46,930 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42359/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42359/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:00:47 INFO - 2015-12-16 05:00:47,536 DEBUG : BROWSER_OUTPUT: RSS: Main: 140365824 05:00:47 INFO - 2015-12-16 05:00:47,537 DEBUG : BROWSER_OUTPUT: 05:00:49 INFO - 2015-12-16 05:00:49,775 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42359/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42359/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:00:50 INFO - 2015-12-16 05:00:50,376 DEBUG : BROWSER_OUTPUT: RSS: Main: 140038144 05:00:50 INFO - 2015-12-16 05:00:50,376 DEBUG : BROWSER_OUTPUT: 05:00:52 INFO - 2015-12-16 05:00:52,972 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42359/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42359/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:00:53 INFO - 2015-12-16 05:00:53,574 DEBUG : BROWSER_OUTPUT: RSS: Main: 140333056 05:00:53 INFO - 2015-12-16 05:00:53,574 DEBUG : BROWSER_OUTPUT: 05:00:56 INFO - 2015-12-16 05:00:56,217 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42359/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42359/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:00:56 INFO - 2015-12-16 05:00:56,811 DEBUG : BROWSER_OUTPUT: RSS: Main: 140083200 05:00:56 INFO - 2015-12-16 05:00:56,811 DEBUG : BROWSER_OUTPUT: 05:00:58 INFO - 2015-12-16 05:00:58,572 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42359/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42359/tests/kraken/driver.html?testName=ai-astar) 05:00:58 INFO - 2015-12-16 05:00:58,830 DEBUG : BROWSER_OUTPUT: RSS: Main: 140857344 05:00:58 INFO - 2015-12-16 05:00:58,830 DEBUG : BROWSER_OUTPUT: 05:00:58 INFO - 2015-12-16 05:00:58,830 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:00:58 INFO - 2015-12-16 05:00:58,830 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:00:58 INFO - 2015-12-16 05:00:58,830 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:00:58 INFO - 2015-12-16 05:00:58,831 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:00:58 INFO - 2015-12-16 05:00:58,831 DEBUG : BROWSER_OUTPUT: |0;ai-astar;118;109;115;114;116;127;113;113;116;114 05:00:58 INFO - 2015-12-16 05:00:58,831 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;132;158;175;132;161;165;138;169;139 05:00:58 INFO - 2015-12-16 05:00:58,831 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;165;164;162;162;164;166;161;164;161 05:00:58 INFO - 2015-12-16 05:00:58,831 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;71;73;83;72;139;73;78;74;72 05:00:58 INFO - 2015-12-16 05:00:58,831 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;94;130;97;96;94;139;96;96;131 05:00:58 INFO - 2015-12-16 05:00:58,831 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;110;111;110;110;110;110;111 05:00:58 INFO - 2015-12-16 05:00:58,831 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;149;149;148;148;149;148;148;147 05:00:58 INFO - 2015-12-16 05:00:58,832 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;98;95;95;96;96;96;96;97;95 05:00:58 INFO - 2015-12-16 05:00:58,832 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;76;74;74;74;75;73;77;77;76 05:00:58 INFO - 2015-12-16 05:00:58,832 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;68;69;68;68;68;70;68 05:00:58 INFO - 2015-12-16 05:00:58,832 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;88;85;85;94;87;86;87;93;94 05:00:58 INFO - 2015-12-16 05:00:58,832 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;130;126;120;130;128;133;139;132;122;123 05:00:58 INFO - 2015-12-16 05:00:58,832 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;142;156;150;155;143;141;156;152;162;141 05:00:58 INFO - 2015-12-16 05:00:58,832 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;73;72;71;71;71;71;76;71;70;74 05:00:58 INFO - 2015-12-16 05:00:58,832 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:00:58 INFO - 2015-12-16 05:00:58,833 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:00:58 INFO - 2015-12-16 05:00:58,833 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,801 05:00:58 INFO - 2015-12-16 05:00:58,833 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:00:58 INFO - 2015-12-16 05:00:58,833 DEBUG : BROWSER_OUTPUT: __startTimestamp1450270858825__endTimestamp 05:00:58 INFO - 2015-12-16 05:00:58,833 DEBUG : BROWSER_OUTPUT: 05:00:58 INFO - 2015-12-16 05:00:58,834 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:00:58 INFO - 2015-12-16 05:00:58,834 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:00:58 INFO - 2015-12-16 05:00:58,835 DEBUG : BROWSER_OUTPUT: 05:00:58 INFO - 2015-12-16 05:00:58,835 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:115.50 Median:115.50 stddev:4.70 (4.1%) stddev-sans-first:4.89 05:00:58 INFO - 2015-12-16 05:00:58,835 DEBUG : BROWSER_OUTPUT: Values: 118.0 109.0 115.0 114.0 116.0 127.0 113.0 113.0 116.0 114.0 05:00:58 INFO - 2015-12-16 05:00:58,835 DEBUG : BROWSER_OUTPUT: 05:00:58 INFO - 2015-12-16 05:00:58,835 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:152.50 Median:159.50 stddev:15.93 (10.0%) stddev-sans-first:16.84 05:00:58 INFO - 2015-12-16 05:00:58,835 DEBUG : BROWSER_OUTPUT: Values: 156.0 132.0 158.0 175.0 132.0 161.0 165.0 138.0 169.0 139.0 05:00:58 INFO - 2015-12-16 05:00:58,835 DEBUG : BROWSER_OUTPUT: 05:00:58 INFO - 2015-12-16 05:00:58,835 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.30 Median:164.00 stddev:1.70 (1.0%) stddev-sans-first:1.79 05:00:58 INFO - 2015-12-16 05:00:58,835 DEBUG : BROWSER_OUTPUT: Values: 164.0 165.0 164.0 162.0 162.0 164.0 166.0 161.0 164.0 161.0 05:00:58 INFO - 2015-12-16 05:00:58,835 DEBUG : BROWSER_OUTPUT: 05:00:58 INFO - 2015-12-16 05:00:58,835 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.70 Median:73.00 stddev:20.81 (28.5%) stddev-sans-first:21.83 05:00:58 INFO - 2015-12-16 05:00:58,835 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 73.0 83.0 72.0 139.0 73.0 78.0 74.0 72.0 05:00:58 INFO - 2015-12-16 05:00:58,836 DEBUG : BROWSER_OUTPUT: 05:00:58 INFO - 2015-12-16 05:00:58,836 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.90 Median:96.00 stddev:18.41 (19.2%) stddev-sans-first:19.10 05:00:58 INFO - 2015-12-16 05:00:58,836 DEBUG : BROWSER_OUTPUT: Values: 96.0 94.0 130.0 97.0 96.0 94.0 139.0 96.0 96.0 131.0 05:00:58 INFO - 2015-12-16 05:00:58,836 DEBUG : BROWSER_OUTPUT: 05:00:58 INFO - 2015-12-16 05:00:58,836 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 05:00:58 INFO - 2015-12-16 05:00:58,836 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 110.0 111.0 110.0 110.0 110.0 110.0 111.0 05:00:58 INFO - 2015-12-16 05:00:58,836 DEBUG : BROWSER_OUTPUT: 05:00:58 INFO - 2015-12-16 05:00:58,836 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 05:00:58 INFO - 2015-12-16 05:00:58,837 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 149.0 149.0 148.0 148.0 149.0 148.0 148.0 147.0 05:00:58 INFO - 2015-12-16 05:00:58,837 DEBUG : BROWSER_OUTPUT: 05:00:58 INFO - 2015-12-16 05:00:58,837 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.94 (1.0%) stddev-sans-first:1.00 05:00:58 INFO - 2015-12-16 05:00:58,837 DEBUG : BROWSER_OUTPUT: Values: 96.0 98.0 95.0 95.0 96.0 96.0 96.0 96.0 97.0 95.0 05:00:58 INFO - 2015-12-16 05:00:58,837 DEBUG : BROWSER_OUTPUT: 05:00:58 INFO - 2015-12-16 05:00:58,837 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.90 Median:75.50 stddev:1.52 (2.0%) stddev-sans-first:1.45 05:00:58 INFO - 2015-12-16 05:00:58,837 DEBUG : BROWSER_OUTPUT: Values: 73.0 76.0 74.0 74.0 74.0 75.0 73.0 77.0 77.0 76.0 05:00:58 INFO - 2015-12-16 05:00:58,837 DEBUG : BROWSER_OUTPUT: 05:00:58 INFO - 2015-12-16 05:00:58,837 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 05:00:58 INFO - 2015-12-16 05:00:58,838 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 68.0 69.0 68.0 68.0 68.0 70.0 68.0 05:00:58 INFO - 2015-12-16 05:00:58,838 DEBUG : BROWSER_OUTPUT: 05:00:58 INFO - 2015-12-16 05:00:58,838 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:87.50 stddev:3.78 (4.3%) stddev-sans-first:3.80 05:00:58 INFO - 2015-12-16 05:00:58,838 DEBUG : BROWSER_OUTPUT: Values: 85.0 88.0 85.0 85.0 94.0 87.0 86.0 87.0 93.0 94.0 05:00:58 INFO - 2015-12-16 05:00:58,838 DEBUG : BROWSER_OUTPUT: 05:00:58 INFO - 2015-12-16 05:00:58,838 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:128.30 Median:130.00 stddev:5.76 (4.4%) stddev-sans-first:6.07 05:00:58 INFO - 2015-12-16 05:00:58,838 DEBUG : BROWSER_OUTPUT: Values: 130.0 126.0 120.0 130.0 128.0 133.0 139.0 132.0 122.0 123.0 05:00:58 INFO - 2015-12-16 05:00:58,838 DEBUG : BROWSER_OUTPUT: 05:00:58 INFO - 2015-12-16 05:00:58,838 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.80 Median:153.50 stddev:7.60 (4.9%) stddev-sans-first:7.52 05:00:58 INFO - 2015-12-16 05:00:58,838 DEBUG : BROWSER_OUTPUT: Values: 142.0 156.0 150.0 155.0 143.0 141.0 156.0 152.0 162.0 141.0 05:00:58 INFO - 2015-12-16 05:00:58,838 DEBUG : BROWSER_OUTPUT: 05:00:58 INFO - 2015-12-16 05:00:58,838 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:71.50 stddev:1.83 (2.6%) stddev-sans-first:1.90 05:00:58 INFO - 2015-12-16 05:00:58,839 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 71.0 71.0 71.0 71.0 76.0 71.0 70.0 74.0 05:00:58 INFO - 2015-12-16 05:00:58,839 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:00:58 INFO - 2015-12-16 05:00:58,839 DEBUG : BROWSER_OUTPUT: 05:00:59 INFO - 2015-12-16 05:00:59,770 INFO : Browser exited with error code: 0 05:00:59 INFO - 2015-12-16 05:00:59,821 INFO : Completed test kraken (00:01:01) 05:00:59 INFO - 2015-12-16 05:00:59,821 INFO : Starting test v8_7 05:00:59 INFO - 2015-12-16 05:00:59,821 DEBUG : operating with platform_type : linux_ 05:00:59 INFO - 2015-12-16 05:00:59,821 INFO : Initialising browser for v8_7 test... 05:00:59 INFO - 2015-12-16 05:00:59,827 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1UOZP4/profile http://localhost:42359/getInfo.html 05:01:04 INFO - 2015-12-16 05:01:04,568 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:01:04 INFO - 2015-12-16 05:01:04,569 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:01:04 INFO - 2015-12-16 05:01:04,569 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:01:04 INFO - 2015-12-16 05:01:04,569 DEBUG : BROWSER_OUTPUT: __metrics 05:01:04 INFO - 2015-12-16 05:01:04,686 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] 05:01:05 INFO - 2015-12-16 05:01:05,574 INFO : Browser initialized. 05:01:05 INFO - 2015-12-16 05:01:05,574 INFO : Running cycle 1/1 for v8_7 test... 05:01:05 INFO - 2015-12-16 05:01:05,575 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1UOZP4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:01:17 INFO - 2015-12-16 05:01:17,636 DEBUG : BROWSER_OUTPUT: RSS: Main: 142561280 05:01:17 INFO - 2015-12-16 05:01:17,636 DEBUG : BROWSER_OUTPUT: 05:01:39 INFO - 2015-12-16 05:01:39,057 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42359/tests/v8_7/run.html (next: http://localhost:42359/tests/v8_7/run.html) 05:01:39 INFO - 2015-12-16 05:01:39,307 DEBUG : BROWSER_OUTPUT: RSS: Main: 137531392 05:01:39 INFO - 2015-12-16 05:01:39,308 DEBUG : BROWSER_OUTPUT: 05:01:39 INFO - 2015-12-16 05:01:39,308 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:01:39 INFO - 2015-12-16 05:01:39,308 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:01:39 INFO - 2015-12-16 05:01:39,308 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:01:39 INFO - 2015-12-16 05:01:39,308 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:01:39 INFO - 2015-12-16 05:01:39,308 DEBUG : BROWSER_OUTPUT: |0;Richards;165.8649859014762 05:01:39 INFO - 2015-12-16 05:01:39,309 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;187.72292096865027 05:01:39 INFO - 2015-12-16 05:01:39,309 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.623542476402 05:01:39 INFO - 2015-12-16 05:01:39,309 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5207.253886010362 05:01:39 INFO - 2015-12-16 05:01:39,309 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1063.8297872340424 05:01:39 INFO - 2015-12-16 05:01:39,309 DEBUG : BROWSER_OUTPUT: |5;Earley;701.2622720897616 05:01:39 INFO - 2015-12-16 05:01:39,310 DEBUG : BROWSER_OUTPUT: |6;Boyer;12341.463414634147 05:01:39 INFO - 2015-12-16 05:01:39,310 DEBUG : BROWSER_OUTPUT: |7;RegExp;26657.894736842107 05:01:39 INFO - 2015-12-16 05:01:39,310 DEBUG : BROWSER_OUTPUT: |8;Splay;609.3845216331505 05:01:39 INFO - 2015-12-16 05:01:39,310 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 05:01:39 INFO - 2015-12-16 05:01:39,310 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:01:39 INFO - 2015-12-16 05:01:39,310 DEBUG : BROWSER_OUTPUT: __startTimestamp1450270899307__endTimestamp 05:01:39 INFO - 2015-12-16 05:01:39,310 DEBUG : BROWSER_OUTPUT: 05:01:39 INFO - 2015-12-16 05:01:39,310 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:01:39 INFO - 2015-12-16 05:01:39,310 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:01:39 INFO - 2015-12-16 05:01:39,310 DEBUG : BROWSER_OUTPUT: 05:01:39 INFO - 2015-12-16 05:01:39,310 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.86 Median:165.86 stddev:0.00 (0.0%) 05:01:39 INFO - 2015-12-16 05:01:39,312 DEBUG : BROWSER_OUTPUT: Values: 165.9 05:01:39 INFO - 2015-12-16 05:01:39,312 DEBUG : BROWSER_OUTPUT: 05:01:39 INFO - 2015-12-16 05:01:39,312 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:187.72 Median:187.72 stddev:0.00 (0.0%) 05:01:39 INFO - 2015-12-16 05:01:39,312 DEBUG : BROWSER_OUTPUT: Values: 187.7 05:01:39 INFO - 2015-12-16 05:01:39,312 DEBUG : BROWSER_OUTPUT: 05:01:39 INFO - 2015-12-16 05:01:39,312 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.62 Median:277.62 stddev:0.00 (0.0%) 05:01:39 INFO - 2015-12-16 05:01:39,312 DEBUG : BROWSER_OUTPUT: Values: 277.6 05:01:39 INFO - 2015-12-16 05:01:39,312 DEBUG : BROWSER_OUTPUT: 05:01:39 INFO - 2015-12-16 05:01:39,312 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5207.25 Median:5207.25 stddev:0.00 (0.0%) 05:01:39 INFO - 2015-12-16 05:01:39,312 DEBUG : BROWSER_OUTPUT: Values: 5207.3 05:01:39 INFO - 2015-12-16 05:01:39,312 DEBUG : BROWSER_OUTPUT: 05:01:39 INFO - 2015-12-16 05:01:39,312 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1063.83 Median:1063.83 stddev:0.00 (0.0%) 05:01:39 INFO - 2015-12-16 05:01:39,312 DEBUG : BROWSER_OUTPUT: Values: 1063.8 05:01:39 INFO - 2015-12-16 05:01:39,313 DEBUG : BROWSER_OUTPUT: 05:01:39 INFO - 2015-12-16 05:01:39,313 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:701.26 Median:701.26 stddev:0.00 (0.0%) 05:01:39 INFO - 2015-12-16 05:01:39,313 DEBUG : BROWSER_OUTPUT: Values: 701.3 05:01:39 INFO - 2015-12-16 05:01:39,313 DEBUG : BROWSER_OUTPUT: 05:01:39 INFO - 2015-12-16 05:01:39,313 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12341.46 Median:12341.46 stddev:0.00 (0.0%) 05:01:39 INFO - 2015-12-16 05:01:39,313 DEBUG : BROWSER_OUTPUT: Values: 12341.5 05:01:39 INFO - 2015-12-16 05:01:39,313 DEBUG : BROWSER_OUTPUT: 05:01:39 INFO - 2015-12-16 05:01:39,313 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26657.89 Median:26657.89 stddev:0.00 (0.0%) 05:01:39 INFO - 2015-12-16 05:01:39,313 DEBUG : BROWSER_OUTPUT: Values: 26657.9 05:01:39 INFO - 2015-12-16 05:01:39,313 DEBUG : BROWSER_OUTPUT: 05:01:39 INFO - 2015-12-16 05:01:39,314 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:609.38 Median:609.38 stddev:0.00 (0.0%) 05:01:39 INFO - 2015-12-16 05:01:39,314 DEBUG : BROWSER_OUTPUT: Values: 609.4 05:01:39 INFO - 2015-12-16 05:01:39,314 DEBUG : BROWSER_OUTPUT: 05:01:39 INFO - 2015-12-16 05:01:39,314 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 05:01:39 INFO - 2015-12-16 05:01:39,314 DEBUG : BROWSER_OUTPUT: Values: 4835.7 05:01:39 INFO - 2015-12-16 05:01:39,314 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:01:39 INFO - 2015-12-16 05:01:39,314 DEBUG : BROWSER_OUTPUT: 05:01:40 INFO - 2015-12-16 05:01:40,294 INFO : Browser exited with error code: 0 05:01:40 INFO - 2015-12-16 05:01:40,308 INFO : Completed test v8_7 (00:00:40) 05:01:40 INFO - 2015-12-16 05:01:40,808 INFO : Completed test suite (00:20:17) 05:01:40 INFO - 2015-12-16 05:01:40,808 DEBUG : Working with test: dromaeo_css 05:01:40 INFO - 2015-12-16 05:01:40,808 DEBUG : Generating results file: dromaeo_css 05:01:40 INFO - 2015-12-16 05:01:40,810 DEBUG : Working with test: kraken 05:01:40 INFO - 2015-12-16 05:01:40,810 DEBUG : Generating results file: kraken 05:01:40 INFO - 2015-12-16 05:01:40,810 INFO : javascript benchmark 05:01:40 INFO - 2015-12-16 05:01:40,810 DEBUG : Working with test: v8_7 05:01:40 INFO - 2015-12-16 05:01:40,810 DEBUG : Generating results file: v8_7 05:01:40 INFO - 2015-12-16 05:01:40,811 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:01:40 INFO - 2015-12-16 05:01:40,871 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 05:01:40 INFO - 2015-12-16 05:01:40,871 DEBUG : process_Request line: dromaeo_css 6367.15 graph.html#tests=[[72,132,43]] 05:01:40 INFO - 2015-12-16 05:01:40,871 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:01:40 INFO - 2015-12-16 05:01:40,902 DEBUG : process_Request line: kraken 1554.70 graph.html#tests=[[232,132,43]] 05:01:40 INFO - 2015-12-16 05:01:40,902 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:01:40 INFO - 2015-12-16 05:01:40,933 DEBUG : process_Request line: v8_7 21294.52 graph.html#tests=[[230,132,43]] 05:01:40 INFO - 2015-12-16 05:01:40,935 INFO : javascript benchmark 05:01:40 INFO - 2015-12-16 05:01:40,938 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2708.201080681199, 2738.3838636306846, 2777.9166125211173, 2782.956391353244, 2798.2584615077003, 4707.576318131368, 4873.317735517026, 4873.342098816659, 4912.164931961566, 4937.481564435732, 4762.738049407281, 4805.519448055193, 4844.249141383082, 4850.8059677612855, 4861.4652388237355, 4449.288113901776, 4503.549645035487, 4542.909141817162, 4580.519045500225, 4583.633309335261, 4544.954550454503, 4553.0, 4596.126735920165, 4596.21864283071, 4604.907901841962, 4259.957400426003, 4358.716683415568, 4416.514183439819, 4522.0, 4530.818767249306, 4504.774761261957, 4515.164694531522, 4538.273876179828, 4546.727196368229, 4561.566651168134, 4279.743215407086, 4483.036147228361, 4499.392582001421, 4518.118966801475, 4535.229011068126, 4648.3259927310355, 4659.370984917061, 4741.762911854428, 4745.905081898377, 4750.857474275777, 5183.222516622499, 5191.974040129813, 5199.896002079975, 5220.791168353261, 5228.660137091115, 5027.949720502821, 5163.432022477525, 5241.8165364212455, 5246.842594722164, 5249.42256351801, 4800.567948884617, 4864.343313652683, 4877.731724755173, 4893.73084480357, 4935.087008903329, 5349.358077030781, 5354.277172581729, 5367.490088441592, 5368.32895888014, 5410.810621628224, 4869.878253043702, 4962.652614317035, 4969.155243608595, 5158.432572417031, 5168.870778230575, 5217.530422262014, 5222.582193424517, 5230.476952304739, 5251.894962100737, 5256.369235691665, 5164.2770012198325, 5177.119889618773, 5184.844454666366, 5199.428062913076, 5222.138347172674, 4933.531314525115, 5071.721055341918, 5077.7461126944245, 5147.536721695065, 5210.296609957683, 4223.21870453967, 4243.342281946303, 4252.957470425318, 4258.318669012943, 4300.65594752419, 3720.2001569662652, 3732.0856390184035, 3732.925341493209, 3755.9248815023548, 3757.94777462311, 4303.117860838521, 4362.541933097043, 4387.692861499664, 4459.955400446019, 4495.865124046284, 5206.609504287194, 5217.739113044333, 5249.763760630781, 5293.655912365684, 5324.387695415076, 4263.168682107022, 4507.8196872124745, 4510.887227819265, 4518.073794872043, 4585.656075794329, 4463.620592249695, 4496.9100617988115, 4497.977510112429, 4537.523560026216, 4563.794629241692, 4884.9511504884495, 4905.5094490550655, 4952.628552858478, 4961.875953101057, 5005.074061298744, 4962.801487940442, 5094.745262736922, 5234.345706786652, 5236.764345604533, 5290.28581141541, 4774.7135171889795, 4824.324594556695, 4869.147899117711, 4900.313956046085, 4915.97542012302, 5098.6309692777595, 5179.689218646893, 5180.378354597472, 5181.1969144782615, 5211.0, 5036.345275114211, 5181.53366197044, 5192.428832828461, 5231.39838918514, 5266.473352664703, 4913.164761990399, 4919.942212424346, 4927.384076990376, 5004.574611158092, 5054.16606259963, 4983.950160498349, 5056.82301119459, 5064.594832413324, 5066.670666406671, 5113.3097031900215, 4746.501617330131, 4933.358663373739, 4934.802607895644, 4954.1825598775795, 4965.280034395065, 4949.28235405857, 4968.751562421792, 4995.62532810048, 5006.749662516932, 5053.2420136979745, 4947.431045429822, 4958.900821983612, 4970.502949705001, 5005.949940500694, 5030.8239211627415], "unit": "score", "name": "dojo.html", "value": 4747.367800478869}, {"lowerIsBetter": false, "replicates": [531.595987049842, 562.0725802425994, 581.0818906128317, 592.7332700284871, 620.4942971478242, 36069.81965090174, 37122.25755484892, 37227.627723722755, 37302.25395492089, 37318.253634927285, 36900.446493302625, 37376.999999999935, 37653.43519847204, 37711.057223569354, 37731.24537509248, 7764.340031097349, 7955.124936257007, 7962.363010959139, 7970.561619110947, 7980.720674776384, 7576.545407275581, 7697.307242348187, 7701.191374905638, 7706.537607743525, 7717.228277172266, 7830.0, 7888.802779930519, 7913.723019694312, 7913.841723165533, 7923.0888447828665, 7810.297073263405, 7828.647710852997, 7900.683972641087, 7921.128675845653, 7924.088729796032, 7737.419693522952, 7834.529928204326, 7861.528308301463, 7869.527828330261, 7874.409419293576, 34960.300793984235, 35251.29497410063, 35361.64638353635, 35391.82304088463, 35557.1110722234, 3036.316828713544, 3092.7371173450283, 3099.7830151889375, 3330.0009997000802, 3557.1462848916076, 27686.584701229498, 27840.860795696095, 27927.779360248715, 28166.71833281682, 28553.428931421462, 3165.8258795766224, 3234.417804795136, 3261.673832616743, 3265.7713960022807, 3285.0473362724783, 202956.0, 205082.0, 206257.0, 206771.0, 206783.0, 51566.48433515692, 52381.738091310064, 55448.0, 63060.36939630637, 64295.0, 56453.15320270199, 56824.715876420356, 56837.14744278839, 57023.42976570264, 57121.0, 13790.517331893336, 13928.303584820718, 13965.231912244924, 13981.300934953211, 14009.439622415193, 11229.494672739746, 11331.660050198507, 11332.886671133349, 11339.886601134049, 11345.886541134483, 19480.610387792163, 19680.311189108597, 19827.107780149927, 19949.700754488695, 20078.196872125245, 7213.747518836815, 7286.744963926343, 7288.562686238843, 7375.336219740249, 7416.332530072319, 834.5243211369583, 873.3188113271658, 915.33638112368, 940.8541676040225, 1080.3895798873612, 22928.4267893304, 22959.311220663407, 23311.7668823313, 24374.146904858244, 24505.75494245035, 940.9247260219166, 956.9425834449955, 1024.2113572549094, 1118.7091356247433, 1167.626359564948, 13176.077674562688, 13187.274699891597, 13191.274479903506, 13215.933920330337, 14350.21073840928, 257213.0, 259095.0, 259585.0, 260035.0, 261292.0, 47754.0, 48208.0, 48236.517634823205, 48266.75866620644, 48341.0, 1217.975640487203, 1245.9501619935281, 1251.030451400172, 1270.1172684984033, 1271.663009302554, 27519.0, 27554.311142221606, 27800.443991120468, 27802.16593502198, 28091.0, 41519.792401037805, 41843.0, 42207.155856883306, 42329.15341693087, 42369.0, 237065.0, 238654.84035478963, 238743.0, 239150.0, 240931.0, 28979.710202897702, 29054.27364315909, 29784.0, 29841.55237671393, 29896.402071958873, 35341.64658353384, 35343.939681809585, 37528.81235593914, 37779.81110094542, 38230.2353952925, 31706.365872681956, 31870.0, 32214.19464513406, 32732.509012364357, 33087.33825323432, 31741.68258317387, 32696.673033269362, 32711.509327359632, 32790.5081423774, 33516.49725254074, 29956.550651739806, 30160.5475917857, 30231.093067208018, 30442.391152177275, 30475.542866856573, 27546.5868011984, 28764.0, 29512.409751805273, 29704.257393565334, 29785.25536861596, 23390.766092338858, 23572.174973875834, 23662.450632405278, 23968.76031239735, 24014.27957161288], "unit": "score", "name": "ext.html", "value": 16770.202114329823}, {"lowerIsBetter": false, "replicates": [342.4760117020958, 343.44019248624755, 343.975921685482, 344.74316634107595, 345.03218472185523, 15093.320800563974, 15229.390824367027, 15759.60600984976, 16490.835091649078, 16576.66846663066, 15106.697866042672, 15303.540893773177, 15878.04731716098, 15921.0, 15925.522234332959, 4256.531781504032, 4376.912461750763, 4376.956230437687, 4383.167198232341, 4407.382966384709, 3434.8454319555553, 4311.784410779464, 4355.956440435587, 4365.978170109161, 4863.076015557051, 4753.857384278477, 4816.590589799871, 4844.224924012159, 4872.512748725117, 4896.412430508344, 4879.634027447938, 4892.094962431962, 4897.755112244374, 4910.238912968495, 5234.581233501311, 5244.29202057725, 5259.789608415659, 5267.236250743621, 5273.077211488013, 5280.709560974145, 10983.450827458595, 11209.495572699248, 15172.848271517365, 18817.247310107578, 18931.14809833561, 1778.6353797471488, 1815.5551889786955, 1858.4517567317673, 1873.4192400355796, 1956.7358406615067, 8698.0, 8875.689350872753, 9244.630214791401, 10118.89881101187, 13207.207567545882, 1723.4312676816621, 1739.3390511605635, 1743.3462451580658, 1793.9372121975669, 1804.3233787329752, 54617.453825462035, 54929.45070549283, 55128.448715513136, 55487.0, 55654.721726391515, 9670.613175473043, 9848.950755246178, 9901.356411833352, 9903.504824758733, 9918.107370336704, 12519.687007824878, 12609.810852837214, 12613.180143290656, 12619.432125554373, 12623.621291361274, 6840.213375461885, 6845.828854278683, 6964.0, 6974.163100427981, 7026.613536255452, 6520.152380190545, 6525.119108920235, 6539.934600654028, 6555.508336874754, 6568.343165683489, 4187.246295666749, 4223.239816832938, 4229.830806767694, 4240.787960601958, 4242.257604919127, 1755.6664233795539, 1781.6169523552499, 1809.222034525167, 1824.5438640339914, 1832.15720768448, 807.7495976247264, 855.7389996051264, 883.2183517586982, 922.8754118194092, 954.9352471993677, 15182.316795744218, 15285.0, 15399.615009624626, 15841.683166336608, 15900.840991590167, 807.0920214758397, 830.3149901331306, 831.5218749219223, 912.7261821453537, 940.9508398136165, 8870.467771933705, 9024.729258122266, 9239.0, 9407.529623518796, 9415.529223538795, 501472.0, 506483.0, 513042.0, 520502.0, 521019.0, 68936.0, 69950.0, 70199.64900175466, 70527.64736176388, 70903.0, 1069.9144068474504, 1112.6217086190734, 1115.642994241835, 1121.4785124916953, 1172.7185475485992, 13527.661808454868, 14057.929710351384, 14283.64290892736, 14439.639009024859, 14470.638234043812, 31929.20176995501, 31973.36053278968, 32272.515912260864, 32776.21402180746, 32981.50527742038, 38588.0, 38885.0, 40643.0, 40706.1858762829, 40995.79502102471, 8486.363522735695, 8517.23344898962, 8632.654693812177, 8986.730398088068, 9012.86480702803, 15842.366305348118, 16097.275622596777, 16118.274677639769, 16120.516384508484, 16315.18424078815, 12894.388201474816, 13427.328633568477, 13542.729145417234, 13915.791263130859, 13923.0, 10807.783844323227, 13551.457941682222, 13711.177329360271, 14011.719765604834, 14359.282035897955, 12410.193337433038, 13690.52083177084, 13994.860051399763, 14386.496472623408, 14396.85603143955, 8407.915920840713, 8566.357523185661, 8819.91180088191, 8920.528112861306, 8991.370604057653, 9025.909740902769, 9227.35408521424, 9233.538323083952, 12777.744445111231, 13543.390547425193], "unit": "score", "name": "jquery.html", "value": 8143.701452670273}, {"lowerIsBetter": false, "replicates": [1382.5575815738969, 1421.8364888037872, 1449.7825326201075, 1613.2982152763548, 1688.662267546491, 7171.641417929096, 7324.853502929945, 7409.333160015598, 7487.2138425465355, 7501.249875012496, 7253.455990800685, 7353.522021068627, 7429.8885516717155, 7433.405327573794, 7454.030975973116, 2074.8547601667888, 2100.170432679091, 2101.9789802102014, 2112.302940029794, 2115.925942592002, 2133.0294715904224, 2135.2740068376747, 2140.625390556654, 2149.580831737812, 2175.3800166952424, 1624.3177865296545, 1657.1051632118701, 2010.5074256807102, 2085.259732794859, 2124.72378590783, 2053.5379539603546, 2060.258307009475, 2060.258307009475, 2061.5979883922714, 2063.1850419084526, 2055.290924631, 2056.92800751973, 2082.6563617003176, 2095.371388583419, 2100.548382097841, 7096.0, 7227.457940654472, 7252.492325537214, 7257.274272572753, 7289.307515785992, 4162.167566486684, 4174.248635245654, 4200.894977625584, 4241.045764702948, 4246.426732391149, 2748.9862550687317, 2755.145904769528, 2785.7075007124163, 2816.0706966701146, 2830.9150725478266, 876.3252295732251, 887.8446271902455, 894.3650008493977, 906.8265545065386, 923.7275003873806, 9797.461139637317, 9835.45904975226, 9859.556319965619, 9863.30956833029, 9918.900810991941, 3726.2920045191327, 3782.3380908341483, 3822.827972741233, 3840.8847734568008, 3845.8461661533784, 7641.083070031632, 7672.616369181518, 7686.500377475446, 7712.190220026929, 7753.379729621617, 4228.894277643083, 4231.280682284019, 4236.046889449911, 4239.300515414983, 4254.3831144483875, 3817.1602247505502, 3820.3505404081375, 3829.463875057494, 3854.7494412863075, 3876.903077423087, 3111.9377612447624, 3111.9533207001914, 3142.5443310720275, 3144.135362775255, 3157.984210078981, 924.0713083351189, 928.6981730937338, 928.8235235305406, 933.0622724162174, 934.7289286107089, 837.0666706622072, 941.2987324443334, 998.6205242008135, 1013.8479228115694, 1211.0493262788668, 6847.315268473212, 6870.828229294208, 6874.2782007889455, 6882.69027893746, 6914.792556223321, 564.8305508347479, 570.315621254488, 581.2966310764023, 581.6103210848742, 726.1358982810439, 5248.501392367719, 5345.0, 5364.383095943938, 5370.113931201308, 5377.489138531833, 8469.576521173916, 8960.820783584422, 8985.550722463851, 8990.190882820578, 9082.727518174466, 8831.205191532792, 8853.29173666118, 8892.421992570462, 8936.106389361012, 8939.73180804577, 6597.076409302702, 6746.392824645805, 6766.966165169143, 6797.320267973262, 6968.79093627192, 6944.756933507505, 6961.234264231032, 7015.824604384931, 7060.576365418091, 7064.258252883374, 7723.382129429745, 7912.525248485109, 7942.761717148494, 7970.601469926596, 8093.55485448306, 7829.843403131791, 7911.643976021208, 7930.841383172419, 7947.0, 7987.281144696773, 6402.743890244338, 6431.067495213074, 6464.159659244457, 6502.122213501117, 6510.73957041713, 6990.61551614666, 7060.71757129709, 7066.470014748812, 7072.82317942035, 7093.858122837618, 6480.222373315232, 6500.772472963424, 6606.0, 6636.104125943129, 6676.56602320867, 6240.500759939285, 6292.370762923671, 6336.7148478319505, 6367.713452894724, 6395.712192951235, 6613.801585952429, 6677.866442671217, 6699.933000670126, 6710.66446677674, 6713.12729345182, 6053.3946605339115, 6081.209442772411, 6156.26124865019, 6165.0, 6254.718537665725, 6138.693065346804, 6191.876162476635, 6195.783147589993, 6261.123442717932, 6262.123302737711], "unit": "score", "name": "mootools.html", "value": 4059.0006538630173}, {"lowerIsBetter": false, "replicates": [299.15190435116443, 304.8658590220304, 309.6872159119289, 310.2940809658028, 310.30646505061185, 5582.0789569721, 5592.853465039667, 5667.858303542408, 5717.7998770043005, 5745.36800951896, 5600.4959553640165, 5664.433556644333, 5664.801731939383, 5679.858003549903, 5685.8578535536635, 4148.730332528391, 4234.470691163605, 4306.418633484471, 4308.116836048603, 4309.3320535317, 4220.620144187023, 4229.767362795045, 4230.97884510577, 4244.1511697660435, 4251.0860165064505, 4192.727472714279, 4192.805050560591, 4211.68412369072, 4213.073123912734, 4216.978915105436, 4196.664266858644, 4206.390073439365, 4209.894752631178, 4212.641925436326, 4219.683523735702, 3620.837062332201, 3659.8902032939054, 3669.486271921933, 3674.595794462607, 3675.044488433, 5227.817026404057, 5332.440093790174, 5353.973230133864, 5386.946130538723, 5409.594280428944, 4850.951490485085, 4884.5603895649565, 4889.413270407538, 4890.975545122252, 4891.5353041461, 5879.412058794129, 5888.823335299948, 5890.322612899528, 5895.882082358372, 5899.5870289079785, 3884.9805750971063, 4022.557518672944, 4028.657564107025, 4029.838806447768, 4033.7983100845136, 6124.234470691119, 6129.570930034854, 6174.567780255384, 6180.474659653934, 6191.25704915413, 4063.837446502166, 4097.528784189797, 4100.708276892769, 4100.712950093465, 4100.958990410118, 4142.91714165715, 4155.376693495939, 4169.041120542292, 4171.687123465752, 4176.2900306947895, 4729.763511824395, 4774.379330686988, 4793.784279707422, 4797.136515427256, 4829.541193586604, 5831.766729330864, 5833.82498525045, 5835.153902684087, 5840.94159058404, 5844.970775146182, 1453.9709205816037, 1471.720373129102, 1473.6168596165073, 1476.438953197778, 1484.5917372722588, 955.460165006769, 984.5667906121283, 986.6398764450923, 1002.6240159940022, 1010.5705075343096, 5096.61775366849, 5102.974485127551, 5111.437741848394, 5111.744412779346, 5119.795208191631, 6033.818985430444, 6091.390860913873, 6093.994490909039, 6103.938960610426, 6124.112003759519, 5071.949280507221, 5083.974580127076, 5088.796448142033, 5096.464871188472, 5098.439171691111, 3193.425183466998, 3241.0, 3270.918227044343, 3293.2096296888576, 3295.653956334598, 5589.357223919302, 5692.886142277214, 5694.288213973254, 5706.201131841545, 5708.857278567986, 6127.325994140641, 6294.527910406738, 6347.55567110307, 6362.1093046973465, 6399.64801935898, 5764.855878603068, 5785.3636100028125, 5789.247397838254, 5801.9419805802245, 5803.187553742564, 5955.5235581154275, 6138.662373569497, 6161.568690191643, 6161.661108639068, 6170.938290617037, 6009.699515024318, 6010.0, 6010.2186715726675, 6011.368806275278, 6023.367546407564, 5812.157237200498, 5824.854378640568, 5826.155207494974, 5841.32824725162, 5847.619904706351, 4132.524759652679, 4178.665706743514, 4180.91638167241, 4188.518320393194, 4200.201961627281, 6006.789762358471, 6104.664243466652, 6171.907421388593, 6179.320274769681, 6185.721642526007, 5834.533237340917, 5853.531717462508, 5888.735006924613, 5913.556483263858, 5914.290285165807, 5867.647941123546, 5902.1736956826935, 5922.318933322551, 5925.555583331181, 5928.584999050025, 5631.915521267102, 5790.594658373873, 5795.043817770021, 5798.652080875161, 5803.738831752666, 5968.432998865101, 5973.432523910222, 5983.521318294613, 5988.251468566429, 5997.520198384032, 5830.970845145747, 5833.883322333445, 5836.678982655994, 5837.562182836219, 5838.0], "unit": "score", "name": "prototype.html", "value": 4380.11797930626}, {"lowerIsBetter": false, "replicates": [675.8918573028317, 695.1484431571325, 739.5230076600593, 745.6160077560061, 767.7389687506246, 11481.942590287048, 11653.883461165375, 11674.591389301377, 11713.882861171385, 11790.410479476024, 11379.146564007691, 13294.534691285808, 13561.728765424685, 13634.29571303587, 13634.795478067837, 799.3285640062361, 812.475953010311, 813.3127507256359, 814.1573471457043, 822.9753107406788, 824.4805772363403, 826.4793180296435, 827.962741676626, 829.2288172000037, 832.9208725171129, 821.9506829590214, 859.7979474823411, 861.8104017116225, 861.8965724113084, 863.1109956744563, 848.6393282854793, 849.9150084991513, 849.9787505312355, 851.535912927456, 854.2269246332111, 632.914556534871, 634.1565717595632, 634.7524465458429, 635.1584150999897, 635.5328833307515, 12311.19977201479, 12392.876071239263, 12396.690082747913, 12408.317542535156, 12434.502619895193, 10850.511726972305, 11029.779404411947, 11088.55645774168, 11262.0, 11796.233244839059, 9229.953850230706, 9271.351005429622, 9390.671326503609, 9452.669156579486, 9522.761930951781, 3140.8272545010013, 3188.505781603855, 3196.1689960610174, 3215.8552865121123, 3239.8542065606866, 40003.59996400028, 40290.395644065364, 40431.7978410109, 40482.0, 40580.18839623191, 9366.812663746823, 9556.569954352071, 9603.711888643353, 9664.516774161264, 9770.804583908282, 15840.366385344458, 15966.441174559068, 15989.680206395808, 16011.359545618277, 16019.038857668576, 5877.235959325346, 5926.851828704231, 5944.910826337608, 6024.759009639653, 6074.392560743979, 3520.471929210639, 3580.964190358115, 3586.55168103987, 3587.582134656099, 3629.038304849217, 2589.6374507568958, 2594.792416606667, 2605.622184783234, 2625.5799072148366, 2627.356297707074, 466.1190350238053, 470.1912710138556, 476.1239319651857, 481.0643298783832, 482.44759750085956, 511.2739909328762, 605.6396444115744, 626.223482881224, 634.6350848262175, 635.9872802543923, 7831.608419579112, 7885.5662938538935, 7980.441369104223, 8003.559804210708, 8092.271695547429, 485.4950851114872, 497.53729031999865, 526.7945501254513, 626.139058794158, 628.7642134199675, 3765.284595926765, 3773.3208022556205, 3784.848606055782, 3805.2009078093356, 3874.341361968472, 50763.0, 51187.9049676025, 51212.48787512077, 51538.48461515412, 51618.741906290226, 44812.55187448149, 44838.55161448409, 44925.775371123586, 45073.77463112663, 45469.0, 42013.78993105015, 42160.1567968645, 42517.0, 42530.57469425328, 42735.35896961548, 7687.961560192163, 7822.608869556613, 7852.6073696313815, 7978.202179782207, 8025.759227223192, 28491.0, 29020.854895725388, 29191.270218244714, 29331.560026600044, 30657.0, 35155.824220878734, 35251.294974100885, 35414.64585354114, 36441.08897277589, 39456.6054339453, 9732.513374331396, 10051.648192313234, 10101.191904647463, 10381.429021403896, 10463.424511651932, 11134.610288639858, 11458.255213411101, 11566.421678915853, 11572.826407604061, 11587.20398338259, 10644.8935510647, 10713.196510261918, 11190.83213751778, 11258.21192516516, 11509.251898626562, 10671.94664026675, 10913.854045325126, 10914.50884710174, 10926.945365273123, 11096.5561377544, 10546.419946902686, 10614.575416983234, 10701.89298107009, 10831.566737330419, 11014.284071535325, 9384.340107358272, 9500.667476638284, 9641.662541811003, 9700.563474643517, 9747.951260243937, 9178.724638260863, 9444.291678124031, 9529.52352382392, 9609.231261499202, 9650.758731031781], "unit": "score", "name": "yui.html", "value": 5779.7671126294}], "name": "dromaeo_css", "value": 6367.15130020444}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [118.0, 109.0, 115.0, 114.0, 116.0, 127.0, 113.0, 113.0, 116.0, 114.0], "unit": "score", "name": "ai-astar", "value": 115.5}, {"lowerIsBetter": true, "replicates": [156.0, 132.0, 158.0, 175.0, 132.0, 161.0, 165.0, 138.0, 169.0, 139.0], "unit": "score", "name": "audio-beat-detection", "value": 152.5}, {"lowerIsBetter": true, "replicates": [164.0, 165.0, 164.0, 162.0, 162.0, 164.0, 166.0, 161.0, 164.0, 161.0], "unit": "score", "name": "audio-dft", "value": 163.3}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 73.0, 83.0, 72.0, 139.0, 73.0, 78.0, 74.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.7}, {"lowerIsBetter": true, "replicates": [96.0, 94.0, 130.0, 97.0, 96.0, 94.0, 139.0, 96.0, 96.0, 131.0], "unit": "score", "name": "audio-oscillator", "value": 106.9}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 110.0, 110.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 149.0, 149.0, 148.0, 148.0, 149.0, 148.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 148.0}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 97.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [73.0, 76.0, 74.0, 74.0, 74.0, 75.0, 73.0, 77.0, 77.0, 76.0], "unit": "score", "name": "json-parse-financial", "value": 74.9}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0, 70.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [85.0, 88.0, 85.0, 85.0, 94.0, 87.0, 86.0, 87.0, 93.0, 94.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.4}, {"lowerIsBetter": true, "replicates": [130.0, 126.0, 120.0, 130.0, 128.0, 133.0, 139.0, 132.0, 122.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.3}, {"lowerIsBetter": true, "replicates": [142.0, 156.0, 150.0, 155.0, 143.0, 141.0, 156.0, 152.0, 162.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.8}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 71.0, 71.0, 71.0, 71.0, 76.0, 71.0, 70.0, 74.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.0}], "name": "kraken", "value": 1554.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.8649859014762], "unit": "score", "name": "Richards", "value": 212.835758}, {"lowerIsBetter": false, "replicates": [187.72292096865027], "unit": "score", "name": "DeltaBlue", "value": 352.210586}, {"lowerIsBetter": false, "replicates": [277.623542476402], "unit": "score", "name": "Encrypt", "value": 958.7839620000002}, {"lowerIsBetter": false, "replicates": [5207.253886010362], "unit": "score", "name": "Decrypt", "value": 51.11734626865668}, {"lowerIsBetter": false, "replicates": [1063.8297872340424], "unit": "score", "name": "RayTrace", "value": 695.5896600000003}, {"lowerIsBetter": false, "replicates": [701.2622720897616], "unit": "score", "name": "Earley", "value": 950.3762380000003}, {"lowerIsBetter": false, "replicates": [12341.463414634147], "unit": "score", "name": "Boyer", "value": 54.00194268774702}, {"lowerIsBetter": false, "replicates": [26657.894736842107], "unit": "score", "name": "RegExp", "value": 34.173178677196454}, {"lowerIsBetter": false, "replicates": [609.3845216331505], "unit": "score", "name": "Splay", "value": 133.72673099999997}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21294.520745575745}]} 05:01:40 INFO - RETURN: dromaeo_css: 6367.15 05:01:40 INFO - RETURN: kraken: 1554.70 05:01:40 INFO - RETURN: v8_7: 21294.52 05:01:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21294.52"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1554.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6367.15"}}} 05:01:41 INFO - Return code: 0 05:01:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:01:41 INFO - # TBPL SUCCESS # 05:01:41 INFO - Running post-action listener: _resource_record_post_action 05:01:41 INFO - Running post-run listener: _resource_record_post_run 05:01:42 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 4096; Write bytes: 510550016; Read time: 20; Write time: 525432 05:01:42 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 235667456; Read time: 0; Write time: 357088 05:01:42 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 4096; Write bytes: 274882560; Read time: 20; Write time: 168344 05:01:42 INFO - Running post-run listener: _upload_blobber_files 05:01:42 INFO - Blob upload gear active. 05:01:42 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:01:42 INFO - Copying logs to upload dir... 05:01:42 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1265.823005 ========= master_lag: 14.74 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-12-16 05:01:56.380503) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 05:01:56.383766) ========= 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=3cd289541638898829117e0a000001bd-1450269626.85246-914651853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/K9hhvgk_Q-ywBVrXDcQ4kA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010053 build_url: 'https://queue.taskcluster.net/v1/task/K9hhvgk_Q-ywBVrXDcQ4kA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.45 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 05:01:56.844660) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 05:01:56.845143) ========= 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=3cd289541638898829117e0a000001bd-1450269626.85246-914651853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004348 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 05:01:56.859115) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 05:01:56.862691) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 05:01:56.864248) ========= ========= Total master_lag: 15.32 =========