builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-008 starttime: 1449902377.61 results: success (0) buildid: 20151211211932 builduid: f615cd706c214757a31fbf47f9c70f64 revision: d8ce27c85590380ef025bb4ed66e564a4dff9bff ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-11 22:39:37.607743) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-11 22:39:37.608240) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-11 22:39:37.608550) ========= 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=7d909545e45784438f4e8e36000001b3-1449899851.818762-2064488871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004800 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-11 22:39:37.664952) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-11 22:39:37.665241) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-11 22:39:37.738247) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 22:39:37.738556) ========= 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=7d909545e45784438f4e8e36000001b3-1449899851.818762-2064488871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.035652 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 22:39:37.797606) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-11 22:39:37.797903) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-11 22:39:37.798288) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 22:39:37.798568) ========= 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=7d909545e45784438f4e8e36000001b3-1449899851.818762-2064488871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-11 22:39:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2015-12-11 22:39:38 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.221160 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 22:39:38.034717) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 22:39:38.035026) ========= 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=7d909545e45784438f4e8e36000001b3-1449899851.818762-2064488871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.220079 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 22:39:38.266521) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 22:39:38.266870) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d8ce27c85590380ef025bb4ed66e564a4dff9bff --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev d8ce27c85590380ef025bb4ed66e564a4dff9bff --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=7d909545e45784438f4e8e36000001b3-1449899851.818762-2064488871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-11 22:39:38,360 truncating revision to first 12 chars 2015-12-11 22:39:38,360 Setting DEBUG logging. 2015-12-11 22:39:38,360 attempt 1/10 2015-12-11 22:39:38,360 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d8ce27c85590?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-11 22:39:38,581 unpacking tar archive at: mozilla-central-d8ce27c85590/testing/mozharness/ program finished with exit code 0 elapsedTime=0.480175 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 22:39:38.761024) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-11 22:39:38.761330) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-11 22:39:38.769979) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-11 22:39:38.770336) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-11 22:39:38.770805) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2015-12-11 22:39:38.771187) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=7d909545e45784438f4e8e36000001b3-1449899851.818762-2064488871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:39:39 INFO - MultiFileLogger online at 20151211 22:39:39 in /builds/slave/test 22:39:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 22:39:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:39:39 INFO - {'append_to_log': False, 22:39:39 INFO - 'base_work_dir': '/builds/slave/test', 22:39:39 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 22:39:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:39:39 INFO - 'branch': 'Firefox-Non-PGO', 22:39:39 INFO - 'buildbot_json_path': 'buildprops.json', 22:39:39 INFO - 'config_files': ('talos/linux_config.py',), 22:39:39 INFO - 'default_actions': ('clobber', 22:39:39 INFO - 'read-buildbot-config', 22:39:39 INFO - 'download-and-extract', 22:39:39 INFO - 'populate-webroot', 22:39:39 INFO - 'create-virtualenv', 22:39:39 INFO - 'install', 22:39:39 INFO - 'run-tests'), 22:39:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:39:39 INFO - 'download_minidump_stackwalk': True, 22:39:39 INFO - 'download_symbols': 'ondemand', 22:39:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:39:39 INFO - 'tooltool.py': '/tools/tooltool.py', 22:39:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:39:39 INFO - '/tools/misc-python/virtualenv.py')}, 22:39:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:39:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:39:39 INFO - 'installer_path': 'installer.exe', 22:39:39 INFO - 'log_level': 'info', 22:39:39 INFO - 'log_name': 'talos', 22:39:39 INFO - 'log_to_console': True, 22:39:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:39:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:39:39 INFO - 'opt_config_files': (), 22:39:39 INFO - 'pip_index': False, 22:39:39 INFO - 'sps_profile': False, 22:39:39 INFO - 'sps_profile_interval': 0, 22:39:39 INFO - 'suite': 'dromaeojs-e10s', 22:39:39 INFO - 'system_bits': '64', 22:39:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:39:39 INFO - 'title': 'talos-linux64-ix-008', 22:39:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:39:39 INFO - 'use_talos_json': True, 22:39:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:39:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:39:39 INFO - 'work_dir': 'build'} 22:39:39 INFO - ##### 22:39:39 INFO - ##### Running clobber step. 22:39:39 INFO - ##### 22:39:39 INFO - Running pre-action listener: _resource_record_pre_action 22:39:39 INFO - Running main action method: clobber 22:39:39 INFO - rmtree: /builds/slave/test/build 22:39:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:39:44 INFO - Running post-action listener: _resource_record_post_action 22:39:44 INFO - ##### 22:39:44 INFO - ##### Running read-buildbot-config step. 22:39:44 INFO - ##### 22:39:44 INFO - Running pre-action listener: _resource_record_pre_action 22:39:44 INFO - Running main action method: read_buildbot_config 22:39:44 INFO - Using buildbot properties: 22:39:44 INFO - { 22:39:44 INFO - "properties": { 22:39:44 INFO - "buildnumber": 167, 22:39:44 INFO - "product": "firefox", 22:39:44 INFO - "script_repo_revision": "production", 22:39:44 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 22:39:44 INFO - "repository": "", 22:39:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 22:39:44 INFO - "buildid": "20151211211932", 22:39:44 INFO - "slavename": "talos-linux64-ix-008", 22:39:44 INFO - "pgo_build": "False", 22:39:44 INFO - "basedir": "/builds/slave/test", 22:39:44 INFO - "project": "", 22:39:44 INFO - "platform": "ubuntu64_hw", 22:39:44 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:39:44 INFO - "slavebuilddir": "test", 22:39:44 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 22:39:44 INFO - "branch": "mozilla-central", 22:39:44 INFO - "repo_path": "mozilla-central", 22:39:44 INFO - "stage_platform": "linux64", 22:39:44 INFO - "builduid": "f615cd706c214757a31fbf47f9c70f64", 22:39:44 INFO - "revision": "d8ce27c85590380ef025bb4ed66e564a4dff9bff" 22:39:44 INFO - }, 22:39:44 INFO - "sourcestamp": { 22:39:44 INFO - "repository": "", 22:39:44 INFO - "hasPatch": false, 22:39:44 INFO - "project": "", 22:39:44 INFO - "branch": "mozilla-central-linux64-talos", 22:39:44 INFO - "changes": [ 22:39:44 INFO - { 22:39:44 INFO - "category": null, 22:39:44 INFO - "files": [ 22:39:44 INFO - { 22:39:44 INFO - "url": null, 22:39:44 INFO - "name": "https://queue.taskcluster.net/v1/task/OaIiKuxuQG-t9e8TfQKtfw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 22:39:44 INFO - } 22:39:44 INFO - ], 22:39:44 INFO - "repository": "", 22:39:44 INFO - "rev": "d8ce27c85590380ef025bb4ed66e564a4dff9bff", 22:39:44 INFO - "who": "philringnalda@gmail.com", 22:39:44 INFO - "when": 1449902347, 22:39:44 INFO - "number": 7354663, 22:39:44 INFO - "comments": "Bug 1229874: Support defineLazyServiceGetter in components-import eslint helper. r=miker", 22:39:44 INFO - "project": "", 22:39:44 INFO - "at": "Fri 11 Dec 2015 22:39:07", 22:39:44 INFO - "branch": "mozilla-central-linux64-talos", 22:39:44 INFO - "revlink": "", 22:39:44 INFO - "properties": [ 22:39:44 INFO - [ 22:39:44 INFO - "buildid", 22:39:44 INFO - "20151211211932", 22:39:44 INFO - "Change" 22:39:44 INFO - ], 22:39:44 INFO - [ 22:39:44 INFO - "builduid", 22:39:44 INFO - "f615cd706c214757a31fbf47f9c70f64", 22:39:44 INFO - "Change" 22:39:44 INFO - ], 22:39:44 INFO - [ 22:39:44 INFO - "pgo_build", 22:39:44 INFO - "False", 22:39:44 INFO - "Change" 22:39:44 INFO - ] 22:39:44 INFO - ], 22:39:44 INFO - "revision": "d8ce27c85590380ef025bb4ed66e564a4dff9bff" 22:39:44 INFO - } 22:39:44 INFO - ], 22:39:44 INFO - "revision": "d8ce27c85590380ef025bb4ed66e564a4dff9bff" 22:39:44 INFO - } 22:39:44 INFO - } 22:39:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/OaIiKuxuQG-t9e8TfQKtfw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 22:39:44 INFO - Running post-action listener: _resource_record_post_action 22:39:44 INFO - ##### 22:39:44 INFO - ##### Running download-and-extract step. 22:39:44 INFO - ##### 22:39:44 INFO - Running pre-action listener: _resource_record_pre_action 22:39:44 INFO - Running main action method: download_and_extract 22:39:44 INFO - mkdir: /builds/slave/test/build/tests 22:39:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:39:44 INFO - https://queue.taskcluster.net/v1/task/OaIiKuxuQG-t9e8TfQKtfw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:39:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OaIiKuxuQG-t9e8TfQKtfw/artifacts/public/build/test_packages.json 22:39:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OaIiKuxuQG-t9e8TfQKtfw/artifacts/public/build/test_packages.json 22:39:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OaIiKuxuQG-t9e8TfQKtfw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 22:39:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OaIiKuxuQG-t9e8TfQKtfw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 22:39:48 INFO - Downloaded 1302 bytes. 22:39:48 INFO - Reading from file /builds/slave/test/build/test_packages.json 22:39:48 INFO - Using the following test package requirements: 22:39:48 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:39:48 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:39:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:39:48 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:39:48 INFO - u'jsshell-linux-x86_64.zip'], 22:39:48 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:39:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:39:48 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:39:48 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:39:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:39:48 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:39:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:39:48 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:39:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:39:48 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:39:48 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:39:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:39:48 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:39:48 INFO - https://queue.taskcluster.net/v1/task/OaIiKuxuQG-t9e8TfQKtfw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:39:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OaIiKuxuQG-t9e8TfQKtfw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:39:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OaIiKuxuQG-t9e8TfQKtfw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:39:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OaIiKuxuQG-t9e8TfQKtfw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:39:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OaIiKuxuQG-t9e8TfQKtfw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:39:55 INFO - Downloaded 21874224 bytes. 22:39:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 22:39:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:39:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:39:56 INFO - Return code: 0 22:39:56 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:39:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:39:56 INFO - https://queue.taskcluster.net/v1/task/OaIiKuxuQG-t9e8TfQKtfw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:39:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OaIiKuxuQG-t9e8TfQKtfw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:39:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OaIiKuxuQG-t9e8TfQKtfw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:39:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OaIiKuxuQG-t9e8TfQKtfw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:39:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OaIiKuxuQG-t9e8TfQKtfw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:40:00 INFO - Downloaded 21874224 bytes. 22:40:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 22:40:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:40:00 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:40:01 INFO - Return code: 0 22:40:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:40:01 INFO - https://queue.taskcluster.net/v1/task/OaIiKuxuQG-t9e8TfQKtfw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:40:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OaIiKuxuQG-t9e8TfQKtfw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:40:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OaIiKuxuQG-t9e8TfQKtfw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:40:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OaIiKuxuQG-t9e8TfQKtfw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:40:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OaIiKuxuQG-t9e8TfQKtfw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:40:03 INFO - Downloaded 11132038 bytes. 22:40:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 22:40:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:40:03 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 22:40:03 INFO - Return code: 0 22:40:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:40:03 INFO - https://queue.taskcluster.net/v1/task/OaIiKuxuQG-t9e8TfQKtfw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:40:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OaIiKuxuQG-t9e8TfQKtfw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:40:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OaIiKuxuQG-t9e8TfQKtfw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:40:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OaIiKuxuQG-t9e8TfQKtfw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:40:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OaIiKuxuQG-t9e8TfQKtfw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:40:04 INFO - Downloaded 57729803 bytes. 22:40:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OaIiKuxuQG-t9e8TfQKtfw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:40:04 INFO - mkdir: /builds/slave/test/properties 22:40:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:40:04 INFO - Writing to file /builds/slave/test/properties/build_url 22:40:04 INFO - Contents: 22:40:04 INFO - build_url:https://queue.taskcluster.net/v1/task/OaIiKuxuQG-t9e8TfQKtfw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:40:04 INFO - Running post-action listener: _resource_record_post_action 22:40:04 INFO - Running post-action listener: set_extra_try_arguments 22:40:04 INFO - ##### 22:40:04 INFO - ##### Running populate-webroot step. 22:40:04 INFO - ##### 22:40:04 INFO - Running pre-action listener: _resource_record_pre_action 22:40:04 INFO - Running main action method: populate_webroot 22:40:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:40:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:40:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:40:04 INFO - '--tppagecycles', 22:40:04 INFO - '7'], 22:40:04 INFO - 'tests': ['tsvgm']}}, 22:40:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:40:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:40:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:40:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:40:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:40:04 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:40:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:40:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:40:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:40:04 INFO - 'talos_options': ['--e10s'], 22:40:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:40:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:40:04 INFO - 'tests': ['damp', 'tps']}, 22:40:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:40:04 INFO - 'talos_options': ['--e10s'], 22:40:04 INFO - 'tests': ['damp', 'tps']}, 22:40:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:40:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:40:04 INFO - 'other': {'tests': ['a11yr', 22:40:04 INFO - 'ts_paint', 22:40:04 INFO - 'tpaint', 22:40:04 INFO - 'sessionrestore', 22:40:04 INFO - 'sessionrestore_no_auto_restore']}, 22:40:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:40:04 INFO - 'tests': ['a11yr', 22:40:04 INFO - 'ts_paint', 22:40:04 INFO - 'tpaint', 22:40:04 INFO - 'sessionrestore', 22:40:04 INFO - 'sessionrestore_no_auto_restore']}, 22:40:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:40:04 INFO - 'tests': ['a11yr', 22:40:04 INFO - 'ts_paint', 22:40:04 INFO - 'tpaint', 22:40:04 INFO - 'sessionrestore', 22:40:04 INFO - 'sessionrestore_no_auto_restore']}, 22:40:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:40:04 INFO - 'tests': ['a11yr', 22:40:04 INFO - 'ts_paint', 22:40:04 INFO - 'tpaint', 22:40:04 INFO - 'sessionrestore', 22:40:04 INFO - 'sessionrestore_no_auto_restore']}, 22:40:04 INFO - 'other_l64': {'tests': ['a11yr', 22:40:04 INFO - 'ts_paint', 22:40:04 INFO - 'tpaint', 22:40:04 INFO - 'sessionrestore', 22:40:04 INFO - 'sessionrestore_no_auto_restore']}, 22:40:04 INFO - 'other_nol64': {'tests': ['a11yr', 22:40:04 INFO - 'ts_paint', 22:40:04 INFO - 'tpaint', 22:40:04 INFO - 'sessionrestore', 22:40:04 INFO - 'sessionrestore_no_auto_restore']}, 22:40:04 INFO - 'svgr': {'tests': ['tsvgx', 22:40:04 INFO - 'tsvgr_opacity', 22:40:04 INFO - 'tart', 22:40:04 INFO - 'tscrollx', 22:40:04 INFO - 'cart']}, 22:40:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:40:04 INFO - 'tests': ['tsvgx', 22:40:04 INFO - 'tsvgr_opacity', 22:40:04 INFO - 'tart', 22:40:04 INFO - 'tscrollx', 22:40:04 INFO - 'cart']}, 22:40:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:40:04 INFO - 'tests': ['tp5o']}, 22:40:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:40:04 INFO - 'talos_options': ['--e10s'], 22:40:04 INFO - 'tests': ['tp5o']}, 22:40:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:40:04 INFO - 'talos_options': ['--xperf_path', 22:40:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:40:04 INFO - 'tests': ['tp5n']}, 22:40:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:40:04 INFO - 'talos_options': ['--e10s', 22:40:04 INFO - '--xperf_path', 22:40:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:40:04 INFO - 'tests': ['tp5n']}}, 22:40:04 INFO - 'talos.zip': {'path': '', 22:40:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:40:04 INFO - Running post-action listener: _resource_record_post_action 22:40:04 INFO - ##### 22:40:04 INFO - ##### Running create-virtualenv step. 22:40:04 INFO - ##### 22:40:04 INFO - Running pre-action listener: _resource_record_pre_action 22:40:04 INFO - Running main action method: create_virtualenv 22:40:04 INFO - Creating virtualenv /builds/slave/test/build/venv 22:40:04 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 22:40:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:40:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:40:04 INFO - Using real prefix '/usr' 22:40:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:40:05 INFO - Installing distribute.............................................................................................................................................................................................done. 22:40:07 INFO - Installing pip.................done. 22:40:07 INFO - Return code: 0 22:40:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:40:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:40:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:40:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:40:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd813527f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c60240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cef0b0>, '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 0x2ceffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf0440>, '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': '7d909545e45784438f4e8e36000001b3-1449899851.818762-2064488871', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:40:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:40:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:40:07 INFO - Using env: {'DISPLAY': ':0', 22:40:07 INFO - 'HOME': '/home/cltbld', 22:40:07 INFO - 'LANG': 'en_US.UTF-8', 22:40:07 INFO - 'LANGUAGE': 'en_US:en', 22:40:07 INFO - 'LOGNAME': 'cltbld', 22:40:07 INFO - 'MAIL': '/var/mail/cltbld', 22:40:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:40:07 INFO - 'MOZ_NO_REMOTE': '1', 22:40:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:40:07 INFO - 'NO_EM_RESTART': '1', 22:40:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:40:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:40:07 INFO - 'PWD': '/builds/slave/test', 22:40:07 INFO - 'SHELL': '/bin/bash', 22:40:07 INFO - 'SHLVL': '1', 22:40:07 INFO - 'TERM': 'linux', 22:40:07 INFO - 'TMOUT': '86400', 22:40:07 INFO - 'USER': 'cltbld', 22:40:07 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1449899851.818762-2064488871', 22:40:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:40:07 INFO - '_': '/tools/buildbot/bin/python'} 22:40:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:40:07 INFO - Cleaning up... 22:40:07 INFO - Return code: 0 22:40:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:40:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:40:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:40:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:40:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd813527f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c60240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cef0b0>, '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 0x2ceffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf0440>, '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': '7d909545e45784438f4e8e36000001b3-1449899851.818762-2064488871', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:40:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 22:40:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:40:07 INFO - Using env: {'DISPLAY': ':0', 22:40:07 INFO - 'HOME': '/home/cltbld', 22:40:07 INFO - 'LANG': 'en_US.UTF-8', 22:40:07 INFO - 'LANGUAGE': 'en_US:en', 22:40:07 INFO - 'LOGNAME': 'cltbld', 22:40:07 INFO - 'MAIL': '/var/mail/cltbld', 22:40:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:40:07 INFO - 'MOZ_NO_REMOTE': '1', 22:40:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:40:07 INFO - 'NO_EM_RESTART': '1', 22:40:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:40:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:40:07 INFO - 'PWD': '/builds/slave/test', 22:40:07 INFO - 'SHELL': '/bin/bash', 22:40:07 INFO - 'SHLVL': '1', 22:40:07 INFO - 'TERM': 'linux', 22:40:07 INFO - 'TMOUT': '86400', 22:40:07 INFO - 'USER': 'cltbld', 22:40:07 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1449899851.818762-2064488871', 22:40:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:40:07 INFO - '_': '/tools/buildbot/bin/python'} 22:40:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:40:08 INFO - Downloading/unpacking psutil>=0.7.1 22:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:40:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:40:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:40:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:40:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:40:10 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 22:40:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:40:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:40:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:40:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:40:10 INFO - Installing collected packages: psutil 22:40:10 INFO - Running setup.py install for psutil 22:40:10 INFO - building 'psutil._psutil_linux' extension 22:40:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:40:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:40:11 INFO - building 'psutil._psutil_posix' extension 22:40:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:40:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:40:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:40:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:40:11 INFO - Successfully installed psutil 22:40:11 INFO - Cleaning up... 22:40:11 INFO - Return code: 0 22:40:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:40:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:40:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:40:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:40:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd813527f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c60240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cef0b0>, '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 0x2ceffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf0440>, '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': '7d909545e45784438f4e8e36000001b3-1449899851.818762-2064488871', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:40:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 22:40:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:40:11 INFO - Using env: {'DISPLAY': ':0', 22:40:11 INFO - 'HOME': '/home/cltbld', 22:40:11 INFO - 'LANG': 'en_US.UTF-8', 22:40:11 INFO - 'LANGUAGE': 'en_US:en', 22:40:11 INFO - 'LOGNAME': 'cltbld', 22:40:11 INFO - 'MAIL': '/var/mail/cltbld', 22:40:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:40:11 INFO - 'MOZ_NO_REMOTE': '1', 22:40:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:40:11 INFO - 'NO_EM_RESTART': '1', 22:40:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:40:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:40:11 INFO - 'PWD': '/builds/slave/test', 22:40:11 INFO - 'SHELL': '/bin/bash', 22:40:11 INFO - 'SHLVL': '1', 22:40:11 INFO - 'TERM': 'linux', 22:40:11 INFO - 'TMOUT': '86400', 22:40:11 INFO - 'USER': 'cltbld', 22:40:11 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1449899851.818762-2064488871', 22:40:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:40:11 INFO - '_': '/tools/buildbot/bin/python'} 22:40:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:40:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:40:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:40:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:40:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:40:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:40:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:40:13 INFO - Installing collected packages: mozsystemmonitor 22:40:13 INFO - Running setup.py install for mozsystemmonitor 22:40:13 INFO - Successfully installed mozsystemmonitor 22:40:13 INFO - Cleaning up... 22:40:13 INFO - Return code: 0 22:40:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:40:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:40:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:40:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:40:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7fd813527f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c60240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cef0b0>, '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 0x2ceffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf0440>, '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': '7d909545e45784438f4e8e36000001b3-1449899851.818762-2064488871', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:40:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:40:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:40:13 INFO - Using env: {'DISPLAY': ':0', 22:40:13 INFO - 'HOME': '/home/cltbld', 22:40:13 INFO - 'LANG': 'en_US.UTF-8', 22:40:13 INFO - 'LANGUAGE': 'en_US:en', 22:40:13 INFO - 'LOGNAME': 'cltbld', 22:40:13 INFO - 'MAIL': '/var/mail/cltbld', 22:40:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:40:13 INFO - 'MOZ_NO_REMOTE': '1', 22:40:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:40:13 INFO - 'NO_EM_RESTART': '1', 22:40:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:40:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:40:13 INFO - 'PWD': '/builds/slave/test', 22:40:13 INFO - 'SHELL': '/bin/bash', 22:40:13 INFO - 'SHLVL': '1', 22:40:13 INFO - 'TERM': 'linux', 22:40:13 INFO - 'TMOUT': '86400', 22:40:13 INFO - 'USER': 'cltbld', 22:40:13 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1449899851.818762-2064488871', 22:40:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:40:13 INFO - '_': '/tools/buildbot/bin/python'} 22:40:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:40:14 INFO - Downloading/unpacking blobuploader==1.2.4 22:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:40:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:40:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:40:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:40:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:40:15 INFO - Downloading blobuploader-1.2.4.tar.gz 22:40:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:40:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:40:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:40:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:40:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:40:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:40:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:40:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:40:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:40:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:40:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:40:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:40:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:40:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:40:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:40:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:40:16 INFO - Downloading docopt-0.6.1.tar.gz 22:40:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:40:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:40:16 INFO - Installing collected packages: blobuploader, requests, docopt 22:40:16 INFO - Running setup.py install for blobuploader 22:40:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:40:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:40:16 INFO - Running setup.py install for requests 22:40:16 INFO - Running setup.py install for docopt 22:40:17 INFO - Successfully installed blobuploader requests docopt 22:40:17 INFO - Cleaning up... 22:40:17 INFO - Return code: 0 22:40:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:40:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:40:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:40:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:40:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd813527f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c60240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cef0b0>, '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 0x2ceffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf0440>, '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': '7d909545e45784438f4e8e36000001b3-1449899851.818762-2064488871', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:40:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:40:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:40:17 INFO - Using env: {'DISPLAY': ':0', 22:40:17 INFO - 'HOME': '/home/cltbld', 22:40:17 INFO - 'LANG': 'en_US.UTF-8', 22:40:17 INFO - 'LANGUAGE': 'en_US:en', 22:40:17 INFO - 'LOGNAME': 'cltbld', 22:40:17 INFO - 'MAIL': '/var/mail/cltbld', 22:40:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:40:17 INFO - 'MOZ_NO_REMOTE': '1', 22:40:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:40:17 INFO - 'NO_EM_RESTART': '1', 22:40:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:40:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:40:17 INFO - 'PWD': '/builds/slave/test', 22:40:17 INFO - 'SHELL': '/bin/bash', 22:40:17 INFO - 'SHLVL': '1', 22:40:17 INFO - 'TERM': 'linux', 22:40:17 INFO - 'TMOUT': '86400', 22:40:17 INFO - 'USER': 'cltbld', 22:40:17 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1449899851.818762-2064488871', 22:40:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:40:17 INFO - '_': '/tools/buildbot/bin/python'} 22:40:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:40:17 INFO - Running setup.py (path:/tmp/pip-DHD65Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:40:17 INFO - Running setup.py (path:/tmp/pip-gUiI9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:40:17 INFO - Running setup.py (path:/tmp/pip-e9miiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:40:17 INFO - Running setup.py (path:/tmp/pip-LBv2od-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:40:17 INFO - Running setup.py (path:/tmp/pip-yY_gAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:40:17 INFO - Running setup.py (path:/tmp/pip-Br3Po0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:40:17 INFO - Running setup.py (path:/tmp/pip-M7IvNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:40:17 INFO - Running setup.py (path:/tmp/pip-EFZrhp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:40:17 INFO - Running setup.py (path:/tmp/pip-1Nyc4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:40:17 INFO - Running setup.py (path:/tmp/pip-EuNbYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:40:17 INFO - Running setup.py (path:/tmp/pip-jczx1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:40:18 INFO - Running setup.py (path:/tmp/pip-HTYBqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:40:18 INFO - Running setup.py (path:/tmp/pip-Rebwfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:40:18 INFO - Running setup.py (path:/tmp/pip-LsHb4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:40:18 INFO - Running setup.py (path:/tmp/pip-xvY7V6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:40:18 INFO - Running setup.py (path:/tmp/pip-E9n7L2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:40:18 INFO - Running setup.py (path:/tmp/pip-gYHBwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:40:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:40:18 INFO - Running setup.py install for manifestparser 22:40:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:40:18 INFO - Running setup.py install for mozcrash 22:40:18 INFO - Running setup.py install for mozdebug 22:40:18 INFO - Running setup.py install for mozdevice 22:40:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:40:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:40:18 INFO - Running setup.py install for mozfile 22:40:18 INFO - Running setup.py install for mozhttpd 22:40:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:40:19 INFO - Running setup.py install for mozinfo 22:40:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:40:19 INFO - Running setup.py install for mozInstall 22:40:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:40:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:40:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:40:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:40:19 INFO - Running setup.py install for mozleak 22:40:19 INFO - Running setup.py install for mozlog 22:40:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:40:19 INFO - Running setup.py install for moznetwork 22:40:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:40:19 INFO - Running setup.py install for mozprocess 22:40:19 INFO - Running setup.py install for mozprofile 22:40:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:40:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:40:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:40:19 INFO - Running setup.py install for mozrunner 22:40:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:40:19 INFO - Running setup.py install for mozscreenshot 22:40:20 INFO - Running setup.py install for moztest 22:40:20 INFO - Running setup.py install for mozversion 22:40:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:40:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:40:20 INFO - Cleaning up... 22:40:20 INFO - Return code: 0 22:40:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:40:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:40:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:40:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:40:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:40:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd813527f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c60240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cef0b0>, '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 0x2ceffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf0440>, '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': '7d909545e45784438f4e8e36000001b3-1449899851.818762-2064488871', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:40:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:40:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:40:20 INFO - Using env: {'DISPLAY': ':0', 22:40:20 INFO - 'HOME': '/home/cltbld', 22:40:20 INFO - 'LANG': 'en_US.UTF-8', 22:40:20 INFO - 'LANGUAGE': 'en_US:en', 22:40:20 INFO - 'LOGNAME': 'cltbld', 22:40:20 INFO - 'MAIL': '/var/mail/cltbld', 22:40:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:40:20 INFO - 'MOZ_NO_REMOTE': '1', 22:40:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:40:20 INFO - 'NO_EM_RESTART': '1', 22:40:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:40:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:40:20 INFO - 'PWD': '/builds/slave/test', 22:40:20 INFO - 'SHELL': '/bin/bash', 22:40:20 INFO - 'SHLVL': '1', 22:40:20 INFO - 'TERM': 'linux', 22:40:20 INFO - 'TMOUT': '86400', 22:40:20 INFO - 'USER': 'cltbld', 22:40:20 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1449899851.818762-2064488871', 22:40:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:40:20 INFO - '_': '/tools/buildbot/bin/python'} 22:40:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:40:20 INFO - Running setup.py (path:/tmp/pip-eQq0cu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:40:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 22:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:40:20 INFO - Running setup.py (path:/tmp/pip-LLuXJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:40:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:40:20 INFO - Running setup.py (path:/tmp/pip-96bohv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:40:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:40:20 INFO - Running setup.py (path:/tmp/pip-W0kwjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:40:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:40:20 INFO - Running setup.py (path:/tmp/pip-iaRcWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:40:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 22:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:40:20 INFO - Running setup.py (path:/tmp/pip-B9pxjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:40:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 22:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:40:20 INFO - Running setup.py (path:/tmp/pip-5s89rI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:40:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 22:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:40:20 INFO - Running setup.py (path:/tmp/pip-EsudQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 22:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:40:21 INFO - Running setup.py (path:/tmp/pip-buFYOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 22:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:40:21 INFO - Running setup.py (path:/tmp/pip-_fOyqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:40:21 INFO - Running setup.py (path:/tmp/pip-vMt3YA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 22:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:40:21 INFO - Running setup.py (path:/tmp/pip-ccCl2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 22:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:40:21 INFO - Running setup.py (path:/tmp/pip-XgSF17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 22:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:40:21 INFO - Running setup.py (path:/tmp/pip-nduET3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:40:21 INFO - Running setup.py (path:/tmp/pip-MajYGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 22:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:40:21 INFO - Running setup.py (path:/tmp/pip-CjNOFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 22:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:40:21 INFO - Running setup.py (path:/tmp/pip-tK84dD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 22:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:40:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:40:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:40:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:40:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:40:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:40:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:40:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:40:23 INFO - Downloading blessings-1.5.1.tar.gz 22:40:23 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 22:40:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:40:23 INFO - Installing collected packages: blessings 22:40:23 INFO - Running setup.py install for blessings 22:40:23 INFO - Successfully installed blessings 22:40:23 INFO - Cleaning up... 22:40:23 INFO - Return code: 0 22:40:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:40:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:40:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:40:23 INFO - Reading from file tmpfile_stdout 22:40:23 INFO - Current package versions: 22:40:23 INFO - argparse == 1.2.1 22:40:23 INFO - blessings == 1.5.1 22:40:23 INFO - blobuploader == 1.2.4 22:40:23 INFO - docopt == 0.6.1 22:40:23 INFO - manifestparser == 1.1 22:40:23 INFO - mozInstall == 1.12 22:40:23 INFO - mozcrash == 0.16 22:40:23 INFO - mozdebug == 0.1 22:40:23 INFO - mozdevice == 0.47 22:40:23 INFO - mozfile == 1.2 22:40:23 INFO - mozhttpd == 0.7 22:40:23 INFO - mozinfo == 0.9 22:40:23 INFO - mozleak == 0.1 22:40:23 INFO - mozlog == 3.1 22:40:23 INFO - moznetwork == 0.27 22:40:23 INFO - mozprocess == 0.22 22:40:23 INFO - mozprofile == 0.27 22:40:23 INFO - mozrunner == 6.11 22:40:23 INFO - mozscreenshot == 0.1 22:40:23 INFO - mozsystemmonitor == 0.0 22:40:23 INFO - moztest == 0.7 22:40:23 INFO - mozversion == 1.4 22:40:23 INFO - psutil == 3.1.1 22:40:23 INFO - requests == 1.2.3 22:40:23 INFO - wsgiref == 0.1.2 22:40:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:40:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:40:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:40:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:40:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:40:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:23 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 0x7fd813527f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c60240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cef0b0>, '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 0x2ceffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf0440>, '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': '7d909545e45784438f4e8e36000001b3-1449899851.818762-2064488871', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:40:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 22:40:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:40:23 INFO - Using env: {'DISPLAY': ':0', 22:40:23 INFO - 'HOME': '/home/cltbld', 22:40:23 INFO - 'LANG': 'en_US.UTF-8', 22:40:23 INFO - 'LANGUAGE': 'en_US:en', 22:40:23 INFO - 'LOGNAME': 'cltbld', 22:40:23 INFO - 'MAIL': '/var/mail/cltbld', 22:40:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:40:23 INFO - 'MOZ_NO_REMOTE': '1', 22:40:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:40:23 INFO - 'NO_EM_RESTART': '1', 22:40:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:40:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:40:23 INFO - 'PWD': '/builds/slave/test', 22:40:23 INFO - 'SHELL': '/bin/bash', 22:40:23 INFO - 'SHLVL': '1', 22:40:23 INFO - 'TERM': 'linux', 22:40:23 INFO - 'TMOUT': '86400', 22:40:23 INFO - 'USER': 'cltbld', 22:40:23 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1449899851.818762-2064488871', 22:40:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:40:23 INFO - '_': '/tools/buildbot/bin/python'} 22:40:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:40:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:40:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 22:40:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 22:40:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:40:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 22:40:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 22:40:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 22:40:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 22:40:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:40:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 22:40:24 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:40:24 INFO - Cleaning up... 22:40:24 INFO - Return code: 0 22:40:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:40:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:40:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:40:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:40:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:40:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd813527f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c60240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cef0b0>, '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 0x2ceffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf0440>, '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': '7d909545e45784438f4e8e36000001b3-1449899851.818762-2064488871', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:40:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:40:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:40:24 INFO - Using env: {'DISPLAY': ':0', 22:40:24 INFO - 'HOME': '/home/cltbld', 22:40:24 INFO - 'LANG': 'en_US.UTF-8', 22:40:24 INFO - 'LANGUAGE': 'en_US:en', 22:40:24 INFO - 'LOGNAME': 'cltbld', 22:40:24 INFO - 'MAIL': '/var/mail/cltbld', 22:40:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:40:24 INFO - 'MOZ_NO_REMOTE': '1', 22:40:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:40:24 INFO - 'NO_EM_RESTART': '1', 22:40:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:40:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:40:24 INFO - 'PWD': '/builds/slave/test', 22:40:24 INFO - 'SHELL': '/bin/bash', 22:40:24 INFO - 'SHLVL': '1', 22:40:24 INFO - 'TERM': 'linux', 22:40:24 INFO - 'TMOUT': '86400', 22:40:24 INFO - 'USER': 'cltbld', 22:40:24 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1449899851.818762-2064488871', 22:40:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:40:24 INFO - '_': '/tools/buildbot/bin/python'} 22:40:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:40:24 INFO - Downloading/unpacking jsonschema 22:40:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:40:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:40:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:40:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:40:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:40:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:40:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:40:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 22:40:25 INFO - Downloading/unpacking functools32 (from jsonschema) 22:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:40:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:40:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:40:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:40:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:40:26 INFO - Downloading functools32-3.2.3-2.tar.gz 22:40:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 22:40:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:40:26 INFO - warning: no files found matching '*.txt' 22:40:26 INFO - no previously-included directories found matching 'build' 22:40:26 INFO - no previously-included directories found matching 'dist' 22:40:26 INFO - no previously-included directories found matching '.git*' 22:40:26 INFO - Installing collected packages: jsonschema, functools32 22:40:26 INFO - Running setup.py install for functools32 22:40:26 INFO - warning: no files found matching '*.txt' 22:40:26 INFO - no previously-included directories found matching 'build' 22:40:26 INFO - no previously-included directories found matching 'dist' 22:40:26 INFO - no previously-included directories found matching '.git*' 22:40:26 INFO - Successfully installed jsonschema functools32 22:40:26 INFO - Cleaning up... 22:40:26 INFO - Return code: 0 22:40:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:40:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:40:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:40:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:40:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:40:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd813527f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c60240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cef0b0>, '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 0x2ceffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf0440>, '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': '7d909545e45784438f4e8e36000001b3-1449899851.818762-2064488871', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:40:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 22:40:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:40:26 INFO - Using env: {'DISPLAY': ':0', 22:40:26 INFO - 'HOME': '/home/cltbld', 22:40:26 INFO - 'LANG': 'en_US.UTF-8', 22:40:26 INFO - 'LANGUAGE': 'en_US:en', 22:40:26 INFO - 'LOGNAME': 'cltbld', 22:40:26 INFO - 'MAIL': '/var/mail/cltbld', 22:40:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:40:26 INFO - 'MOZ_NO_REMOTE': '1', 22:40:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:40:26 INFO - 'NO_EM_RESTART': '1', 22:40:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:40:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:40:26 INFO - 'PWD': '/builds/slave/test', 22:40:26 INFO - 'SHELL': '/bin/bash', 22:40:26 INFO - 'SHLVL': '1', 22:40:26 INFO - 'TERM': 'linux', 22:40:26 INFO - 'TMOUT': '86400', 22:40:26 INFO - 'USER': 'cltbld', 22:40:26 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1449899851.818762-2064488871', 22:40:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:40:26 INFO - '_': '/tools/buildbot/bin/python'} 22:40:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:40:26 INFO - Downloading/unpacking flake8 22:40:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:40:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:40:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:40:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:40:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:40:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:40:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:40:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 22:40:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:40:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:40:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:40:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:40:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:40:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:40:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:40:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:40:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 22:40:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:40:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:40:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:40:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:40:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:40:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:40:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:40:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 22:40:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:40:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:40:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:40:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:40:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:40:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:40:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:40:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 22:40:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:40:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:40:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:40:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:40:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:40:28 INFO - no previously-included directories found matching 'docs/_build' 22:40:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:40:29 INFO - Running setup.py install for pep8 22:40:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:40:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:40:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:40:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:40:29 INFO - no previously-included directories found matching 'docs/_build' 22:40:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:40:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:40:29 INFO - Cleaning up... 22:40:29 INFO - Return code: 0 22:40:29 INFO - Running post-action listener: _resource_record_post_action 22:40:29 INFO - Running post-action listener: _start_resource_monitoring 22:40:29 INFO - Starting resource monitoring. 22:40:29 INFO - ##### 22:40:29 INFO - ##### Running install step. 22:40:29 INFO - ##### 22:40:29 INFO - Running pre-action listener: _resource_record_pre_action 22:40:29 INFO - Running main action method: install 22:40:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:40:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:40:29 INFO - Reading from file tmpfile_stdout 22:40:29 INFO - Detecting whether we're running mozinstall >=1.0... 22:40:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:40:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:40:29 INFO - Reading from file tmpfile_stdout 22:40:29 INFO - Output received: 22:40:29 INFO - Usage: mozinstall [options] installer 22:40:29 INFO - Options: 22:40:29 INFO - -h, --help show this help message and exit 22:40:29 INFO - -d DEST, --destination=DEST 22:40:29 INFO - Directory to install application into. [default: 22:40:29 INFO - "/builds/slave/test"] 22:40:29 INFO - --app=APP Application being installed. [default: firefox] 22:40:29 INFO - mkdir: /builds/slave/test/build/application 22:40:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:40:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:40:44 INFO - Reading from file tmpfile_stdout 22:40:44 INFO - Output received: 22:40:44 INFO - /builds/slave/test/build/application/firefox/firefox 22:40:44 INFO - Running post-action listener: _resource_record_post_action 22:40:44 INFO - ##### 22:40:44 INFO - ##### Running run-tests step. 22:40:44 INFO - ##### 22:40:44 INFO - Running pre-action listener: _resource_record_pre_action 22:40:44 INFO - Running main action method: run_tests 22:40:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:40:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:40:44 INFO - Python 2.7.3 22:40:44 INFO - Return code: 0 22:40:44 INFO - grabbing minidump binary from tooltool 22:40:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:40:44 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cef0b0>, '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 0x2ceffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf0440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:40:44 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 22:40:44 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:40:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:40:44 INFO - Return code: 0 22:40:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:40:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:40:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:40:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:40:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:40:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:40:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:40:45 INFO - Return code: 0 22:40:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OaIiKuxuQG-t9e8TfQKtfw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost'] in /builds/slave/test/build 22:40:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OaIiKuxuQG-t9e8TfQKtfw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost 22:40:45 INFO - Using env: {'DISPLAY': ':0', 22:40:45 INFO - 'HOME': '/home/cltbld', 22:40:45 INFO - 'LANG': 'en_US.UTF-8', 22:40:45 INFO - 'LANGUAGE': 'en_US:en', 22:40:45 INFO - 'LOGNAME': 'cltbld', 22:40:45 INFO - 'MAIL': '/var/mail/cltbld', 22:40:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:40:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:40:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:40:45 INFO - 'MOZ_NO_REMOTE': '1', 22:40:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:40:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:40:45 INFO - 'NO_EM_RESTART': '1', 22:40:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:40:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:40:45 INFO - 'PWD': '/builds/slave/test', 22:40:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:40:45 INFO - 'SHELL': '/bin/bash', 22:40:45 INFO - 'SHLVL': '1', 22:40:45 INFO - 'TERM': 'linux', 22:40:45 INFO - 'TMOUT': '86400', 22:40:45 INFO - 'USER': 'cltbld', 22:40:45 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1449899851.818762-2064488871', 22:40:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:40:45 INFO - '_': '/tools/buildbot/bin/python'} 22:40:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OaIiKuxuQG-t9e8TfQKtfw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost'] with output_timeout 3600 22:40:45 INFO - mozversion INFO | application_buildid: 20151211211932 22:40:45 INFO - mozversion INFO | application_changeset: d8ce27c85590380ef025bb4ed66e564a4dff9bff 22:40:45 INFO - mozversion INFO | application_display_name: Nightly 22:40:45 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:40:45 INFO - mozversion INFO | application_name: Firefox 22:40:45 INFO - mozversion INFO | application_remotingname: firefox 22:40:45 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 22:40:45 INFO - mozversion INFO | application_vendor: Mozilla 22:40:45 INFO - mozversion INFO | application_version: 45.0a1 22:40:45 INFO - mozversion INFO | platform_buildid: 20151211211932 22:40:45 INFO - mozversion INFO | platform_changeset: d8ce27c85590380ef025bb4ed66e564a4dff9bff 22:40:45 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 22:40:45 INFO - mozversion INFO | platform_version: 45.0a1 22:40:45 INFO - 2015-12-11 22:40:45,655 DEBUG : using testdate: 1449902445 22:40:45 INFO - 2015-12-11 22:40:45,655 DEBUG : actual date: 1449902445 22:40:45 INFO - 2015-12-11 22:40:45,663 INFO : starting webserver on 'localhost:42763' 22:40:45 INFO - 2015-12-11 22:40:45,664 INFO : Starting test suite talos-linux64-ix-008.e 22:40:45 INFO - 2015-12-11 22:40:45,664 INFO : Starting test dromaeo_css 22:40:45 INFO - 2015-12-11 22:40:45,664 DEBUG : operating with platform_type : linux_ 22:40:45 INFO - 2015-12-11 22:40:45,664 INFO : Initialising browser for dromaeo_css test... 22:40:45 INFO - 2015-12-11 22:40:45,695 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkrLMVw/profile http://localhost:42763/getInfo.html 22:40:52 INFO - 2015-12-11 22:40:52,592 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:40:52 INFO - 2015-12-11 22:40:52,592 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:40:52 INFO - 2015-12-11 22:40:52,592 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:40:52 INFO - 2015-12-11 22:40:52,592 DEBUG : BROWSER_OUTPUT: __metrics 22:40:52 INFO - 2015-12-11 22:40:52,713 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:40:53 INFO - 2015-12-11 22:40:53,670 INFO : Browser initialized. 22:40:53 INFO - 2015-12-11 22:40:53,670 INFO : Running cycle 1/1 for dromaeo_css test... 22:40:53 INFO - 2015-12-11 22:40:53,671 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkrLMVw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:41:05 INFO - 2015-12-11 22:41:05,645 DEBUG : BROWSER_OUTPUT: RSS: Main: 143101952 22:41:05 INFO - 2015-12-11 22:41:05,645 DEBUG : BROWSER_OUTPUT: 22:41:55 INFO - 2015-12-11 22:41:55,277 DEBUG : BROWSER_OUTPUT: 1449902515276 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 22:44:07 INFO - 2015-12-11 22:44:07,252 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42763/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42763/tests/dromaeo/cssquery-ext.html) 22:44:08 INFO - 2015-12-11 22:44:08,317 DEBUG : BROWSER_OUTPUT: RSS: Main: 147599360 22:44:08 INFO - 2015-12-11 22:44:08,317 DEBUG : BROWSER_OUTPUT: 22:47:10 INFO - 2015-12-11 22:47:10,435 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42763/tests/dromaeo/cssquery-ext.html (next: http://localhost:42763/tests/dromaeo/cssquery-jquery.html) 22:47:11 INFO - 2015-12-11 22:47:11,025 DEBUG : BROWSER_OUTPUT: RSS: Main: 145293312 22:47:11 INFO - 2015-12-11 22:47:11,026 DEBUG : BROWSER_OUTPUT: 22:50:12 INFO - 2015-12-11 22:50:12,831 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42763/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42763/tests/dromaeo/cssquery-mootools.html) 22:50:13 INFO - 2015-12-11 22:50:13,431 DEBUG : BROWSER_OUTPUT: RSS: Main: 145977344 22:50:13 INFO - 2015-12-11 22:50:13,431 DEBUG : BROWSER_OUTPUT: 22:53:15 INFO - 2015-12-11 22:53:15,243 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42763/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42763/tests/dromaeo/cssquery-prototype.html) 22:53:15 INFO - 2015-12-11 22:53:15,845 DEBUG : BROWSER_OUTPUT: RSS: Main: 143536128 22:53:15 INFO - 2015-12-11 22:53:15,845 DEBUG : BROWSER_OUTPUT: 22:56:18 INFO - 2015-12-11 22:56:18,546 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42763/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42763/tests/dromaeo/cssquery-yui.html) 22:56:19 INFO - 2015-12-11 22:56:19,175 DEBUG : BROWSER_OUTPUT: RSS: Main: 143802368 22:56:19 INFO - 2015-12-11 22:56:19,176 DEBUG : BROWSER_OUTPUT: 22:59:21 INFO - 2015-12-11 22:59:21,606 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42763/tests/dromaeo/cssquery-yui.html (next: http://localhost:42763/tests/dromaeo/cssquery-dojo.html) 22:59:21 INFO - 2015-12-11 22:59:21,856 DEBUG : BROWSER_OUTPUT: RSS: Main: 146079744 22:59:21 INFO - 2015-12-11 22:59:21,856 DEBUG : BROWSER_OUTPUT: 22:59:21 INFO - 2015-12-11 22:59:21,858 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:59:21 INFO - 2015-12-11 22:59:21,858 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:59:21 INFO - 2015-12-11 22:59:21,858 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:59:21 INFO - 2015-12-11 22:59:21,858 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:59:21 INFO - 2015-12-11 22:59:21,859 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2687.2072738542133;2739.3425577861294;2769.1415661145047;2775.4449110177957;2783.178962206149;4608.354830323758;4807.271134472184;4812.398450193726;4824.831130910419;4878.707277563344;4758.833440829571;4767.237242041274;4784.90430191396;4899.828506002291;4916.434610019849;4382.38646589477;4466.12910482456;4519;4519.909601807962;4551.726896386211;4433.756143412111;4466.5980061794435;4478.193925093482;4520.073384956077;4598.0344127733215;4234.724742891703;4334.523202447728;4491.887702807423;4503.301988191803;4571.4514258289055;4299.828006879721;4390.297552391602;4401.845935392278;4402.7358358498595;4436.423264975532;4370.672199585044;4421.38100665907;4454.37638730578;4458.464984201884;4493.775311234425;4427.667924905645;4582.1981153298375;4645.581897629196;4685;4686.554777296152;4999.700017998895;5041.067402530507;5098.949010509921;5101.15830887903;5109.233614957749;5156.819511317123;5216.9739151304;5240.135377662681;5247.606429517763;5269.525742683139;4570.10882877839;4735.384400028043;4751.52484751529;4811.735354555498;4908.656394052454;5277.340332458442;5297.947020529822;5310.60170487215;5324.148136298174;5332.173513105475;5083.2375143727995;5104.183330667075;5107;5112.590992720573;5155.664881782672;4834.854954351375;5007.69953802773;5013.799448022111;5018.347614810052;5020.49795020495;4998.050370429607;5019.67372120811;5042.319286896295;5044.722540260321;5046.243063540498;5104.285400043997;5125.051865404912;5140.537351638371;5154.278401023859;5156.097682905476;4314.352847072964;4341.914521369657;4365.257906155961;4372.453443319585;4391.824327026883;3643.5263415756312;3658.835352409095;3704.7777133372083;3718.2935242303874;3809.580946095927;4446.444194475691;4456.3538286948215;4503.549645035536;4505.662075344297;4556.977215113903;5257.684538927677;5270.49930256625;5275.709835959059;5283.418823929364;5331.1470164773455;4264.893377665521;4353.542877997828;4367.06108186735;4476.462824461086;4485.394471746273;4606.95393046072;4633.4208223972;4639.188142075123;4646.070785842845;4654.86035418938;4897.902041959141;4916.0905232532095;4917.926231106608;4924.7537623119415;4956.207006878882;4961.801527938842;5080.1363768160245;5087.618428617794;5157.484251574812;5211.218317252443;4906.803727850846;4920.5571498565305;4937.23472861707;4938.827141050046;4981.103401387785;4754.096721622881;5171.63798534099;5179.326687530597;5186.948130518797;5187.533122019036;5029.145045342374;5074.492550744896;5099.77051032697;5120.155174396183;5158.716270605153;4992.450830408725;5005.924911126263;5011.473795251446;5033;5040.722760248075;4748.192807222849;4817.27740838877;5036.143855544639;5042.520960508746;5045.344105266292;4776.402949631296;4814.6870453420415;4850.684705494132;4904.019196160711;4923.433805112315;5059.114654935298;5122.795088196431;5124.461931497139;5128.589712822891;5132.8460146195675;4758.500357462555;4765.76171191446;4913;4991.401031876198;5019.247112933089 22:59:21 INFO - 2015-12-11 22:59:21,861 DEBUG : BROWSER_OUTPUT: |1;ext.html;550.08685581934;551.7743331497365;565.3018522125172;587.2043381218448;597.0119452306433;34852.65147348526;35619.64380356196;35645.465318020215;35926.281474370495;35934.46098308527;38322.23355532888;38716;38747.22505549887;38820;38851.02872428191;7713.614319284027;7887.171846956073;7910.683572657087;7974.800629984239;8058.597070146469;7716.305532502074;7829.9821023266895;7881.290683838453;7887.290143887049;7893.802654933644;7745;7790.571518566477;7799.5320280783335;7818.530888146701;7856.057273127232;7801.4929029612895;7886.014248219001;7900.525968441883;7916.247956444128;7947.205279472064;7805.9609701951695;7874.763757087297;7909.802254943615;7954.721584744506;7955.681772729084;36447.4532882007;36726.26547469063;36752.081197969994;36847;36885.81557092224;2800.4819108465;2852.5721141828685;2855.0461626949905;3181.3319202967173;3422.4866270059442;27227.727722722717;27682.723172768216;28152.155435336972;28168.718312816814;28338.29154271139;3376.0547046826928;3484.407650699387;3486.7059385448206;3530.505729197914;3540.451230059345;193114;194314;194539;195061;198048;48321.75839120782;49393.50606493961;50030.49969500331;51337;52886;46844.7657761709;47219.29171062437;47502.287465688045;47535.286970695466;47644;11615.245009074382;11930.582429614922;11933.28400295985;12085.697857553632;12121.757564848655;8791;8902.465852048897;8982;8987.46075235488;9027.548622568846;17200.31198752061;17438.215280312415;18570.071496425124;18627.90686046561;18640.254389824255;7316.707331706779;7460.813479663052;7512.586807725627;7523;7626.237376262329;807.7980504873782;809.9919000810035;810.4974915552395;943.8772959515219;971.7424882406168;25541.23376298714;25890.87054564715;26375.472490550466;27343.86328068347;28308.150755477367;891.3003292415423;901.6123067081218;921.7972046149837;935.1256575102301;1045.4406892312577;11319.151063670257;13852.515161969282;14640;14716.705665886837;14934.70130597382;247002;251314;254356;255683;256005;44825.10349793051;45303.093938121056;45669.314960275624;45828;45859.54140458619;1191.880811918801;1195.635331223985;1208.510553225945;1221.3465795799382;1222.5048855213652;26125.477490450463;26530.602040969014;26672;26685.86657066702;26775;39171.80414097911;39631.60368396394;39675.80162099171;39701.80894573052;39875.40186897141;242847;246211;246296;247653;250896;26903.596446053718;27300.044498442458;28117.156485305473;28139.296517587223;28424.431511369243;33202.16994575155;33208.1697957553;33394.66421343119;34026.489602655485;34154.14614634654;28689.85655071711;29318.387488688328;29403.852980735814;29522.409551809273;29984.700152999063;28355.716442836132;28709;29003.27491812637;29063.27341816387;31298.843505782326;29183.708162918098;29291.41417171687;29487.410251795274;29531.55702664505;29599.85200073986;27548.724512755416;28118.71881281161;29668.322003436377;32182.356352872343;32325.676743232267;22498.437539061655;22528.549429011655;22954.770452295263;23023.424414389774;23028.539429211658 22:59:21 INFO - 2015-12-11 22:59:21,862 DEBUG : BROWSER_OUTPUT: |2;jquery.html;330.1762103551639;336.4012058535806;336.8703049326009;338.2119661189429;344.13106905064706;14632.34154463049;14987.72604328632;15440.150791706452;15851.3659453622;16418.753718694228;15068.32192551335;15105.697886042273;15361;15407.38370465183;15422.228888555555;4597.88505287368;5021.1213037718435;5025.698458092508;5027.622928280375;5036.068327359432;5086.949130508685;5128.53843154116;5128.53843154116;5130.410002849682;5139.537441630253;4948.628852836052;5082.161443361841;5086.440491545927;5267.631265811395;5281.735913204344;5169.302144210558;5218.165093585008;5262.736863156846;5274.103402421579;5288.788448462057;5005.299258103868;5090.9745451272875;5104.821331253388;5126.487351264881;5134.717590532557;11146.275492092987;11166.106711463064;11213.831792523119;11419.771604567863;11513.942430287794;1658.1046235033068;1744.3022790883622;1781.8218178182208;1850.722391641251;1901.4580844459263;8650.697225597074;8702.086280940473;8872.689455869078;8914.42056266347;9015.233705135071;1632.183908045977;1758.5339884930504;1773.3172728499492;1780.5815633326158;1790.7582476365653;54477;57106.71446642782;57118;57190.428095718926;57458.425415745725;9951.651692190739;10005.49972501372;10017.198624110053;10091.747706307255;10110.545025473872;12458.252504849737;12475.376231188404;12480.251184928933;12490.625281241577;12503.374831258401;6685.966570167216;6694.899576506356;6717.261101278856;6759.797206083826;6760.290169532227;6158.445739883342;6211.130441738161;6230.345813689588;6246.843828904313;6254.2807577129215;4100.138970816102;4192.45498085247;4252.553481884358;4258.701890867672;4272.807723652443;1718.561766749471;1769.389855231733;1779.350537053966;1788.7764029496313;1817.7000794868964;392.7074329624448;396.56774116212887;399.39890464850214;813.2436833744556;874.4054043250651;9560.521973901277;10127.82202856257;10201.591936322464;10245.334053286513;10352.948235258926;397.2095529895545;398.79262783352493;401.5302096547047;419.9538050814408;424.7960978730165;9036;9402.15380615748;9440.763980900396;9443.527823608792;9650.90349096514;480303.5908922738;484081;499543;501381;517000;73652.26347736454;74128.25871741322;74447.62776186084;74686.62656686791;75665.62167189129;1047.518141654832;1060.867391576053;1080.1466841195524;1087.0868470484672;1094.4473041114186;13821.308934553434;14271.857281427052;14288.214148221947;14418.351174197396;14476.131432114107;32669.34661306713;33891.4916276261;34134.829325853214;34283.828580856934;35648.287034258654;42141.57858421376;42623;42832.14335713206;43756.34365484457;44373;8374.832503349777;8775.692850750193;8829.16122968317;9025.05236950137;9032.187103160748;9744.75638109053;9764.316497845082;9765.804683906425;9907.108360247612;12008.939955300168;8593.226609605166;13347.265900375573;13382.464701412224;13696.65758356049;13732.794008089686;8667.869981950402;8765.123487651184;8900.643974240958;8978.41640293405;9014.819703606023;8811.118888111137;8921.776955576162;9158.771030724285;9212.078792120734;9214.677486287948;12829.61511154667;12966.286854223108;13687.11033782801;13728.313584320944;13919.373628186959;14289.857101429268;14482.565523034325;14550.272486375427;14596.12423254608;14643 22:59:21 INFO - 2015-12-11 22:59:21,863 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1347.885429738472;1377.2769296119536;1385.681293302541;1621.197507233919;1701.4980580728688;6901.585904845707;7060.505764596481;7071.6817743201555;7091.929080709191;7183;7189.352958233758;7275.672594733236;7317.56094634321;7332.486725929187;7345.66944487498;2081.5836832633495;2119.79861913118;2120.872747635139;2123.4691327168207;2124.713163722901;2115.375964090589;2124.1928067334393;2132.7014218009413;2164.0694501364405;2168.913243470259;1734.7831521059868;1766.5671910381975;2068.048697599106;2087.060822629815;2090.341542414135;2079.6048750737314;2087.4155236533793;2088;2088.8433367497346;2092.016752126498;2060.464279287381;2086.6557018092;2144.0566150893715;2156.1914282144194;2156.8921553922396;6964.059851919977;7067.4346052316205;7093.92906070943;7096.6451677416435;7146.857062858714;4231.682623803227;4320.071184695305;4320.978395108004;4331.9783401083105;4345.565443455661;2802.3134332088566;2826.434713057397;2855.300451389402;2867.211516832867;2868.6270784797844;875.0374587953264;884.8628462588244;886.3131073418089;912.2975309012023;920.2729843423688;9005.459672419676;9238.122378374044;9417.293702972305;9470.100340467714;9540.093691099335;3821.8280177392085;3864.1305706215876;3873.573906870242;3912.374020156761;3962.5244970603135;7720.845583088307;7721.227877212234;7727.806804829925;7747.38020958322;7845.803854903673;4103.179364127186;4159.625633692982;4161.0845613964875;4172.812223449952;4181.121964387513;3783.2622638585212;3785.716071294664;3800.1829606634706;3801.0877389426337;3802.524684414448;2907.069737683963;2979.1658335666048;2984.9552256715733;2998.385331007138;3016.457037733185;902.5081330674798;905.4386280505996;908.4912449028565;911.193593669594;915.4757329047195;734.7391675955066;766.7853001159684;802.9598520073973;814.226484839405;907.2832462354797;6496.220453545605;6866.279040700754;7002.054722612484;7004.684789184499;7031.789046328516;1048.7063622185647;1065.477915821242;1073.8603981482356;1079.0773888325525;1080.864891888514;5222.086134926372;5263.473652634706;5266.131088370376;5268.683878967274;5303.231031500411;8056.234657707509;8149.674013039531;8230.09468958414;8315.501069935823;8358.122397148212;8101.837963240702;8237.876431853527;8242.557552428301;8298.04572474161;8308.626111824982;6352.6823658816875;6411.326810684905;6475.546711730228;6499.317571655003;6519.413252807175;6128.908066378919;6137.048757442603;6166.660833654013;6178;6191.226096737908;7361.447891408273;7374.926250737424;7380.520266182681;7549.773506794805;7557.319841214317;7499.475036747375;7679.424043196895;7691.57696326685;7698.961505192438;7709.151993280847;5934.851628709144;5956.076808094752;5968.582199246185;5991.700414979146;6067.908981365372;6420.518461115342;6443.194600674916;6459.192600924885;6508.381703738138;6518.794023105741;5901.262342207224;6122.571420000735;6221.09794079865;6348.079528468254;6361.173047503795;5010.248462730474;5043.293938848491;6115.724792384264;6164.815055548341;6177.258728952374;6251.843703907439;6303.684815759286;6318.147050148355;6332.493400527855;6365.331640177715;5883.55873309512;5885.264341957255;5907.143464197753;5908.675022873783;5914.615549989237;5961.135635332939;6077.392260773887;6098.908516372169;6100.511959043355;6115.357887421935 22:59:21 INFO - 2015-12-11 22:59:21,864 DEBUG : BROWSER_OUTPUT: |4;prototype.html;305.30695321619925;312.10892900768306;312.6420248815108;316.114878340646;316.31991218879415;5438.8912221755545;5601.6358936669085;5623.80316688916;5634.0703783875615;5636.577256705753;5510.283663123799;5570.777168913239;5574.470425309589;5582.637128586649;5604.495595396414;4172.895677608069;4330.090680957002;4333.371661109138;4336.262835317995;4336.804843782022;4289.313709806432;4302.20409224293;4322.848700295474;4335.046289816235;4337.024169561839;4282.721623094489;4288;4290.4636920384955;4292.441982542281;4293.656507479394;4275.978620106911;4284.828606855722;4293.957060429387;4294.312909934395;4299.989502466933;3480.5301284326547;3662.176010397666;3680.1719613087107;3701.907452313687;3726.1988672435555;5228.660137091077;5369.597280203961;5372.7313634318125;5384.9230153969365;5393.78424863005;4893.73084480357;4918.581920536759;4933.260010998343;4948.134076536628;4951.900961980777;5884.352721200665;5884.7940322088525;5886.852828679274;5888.969430349672;5898.144769008512;3921.2549615573234;4042.312806822847;4044.5955404459614;4046.7369620974837;4057.3102572562734;6152.723127459275;6248.218972628421;6254.46837018854;6261.154744109578;6262.718177682015;4127.938080928729;4129;4137.1518838638;4143.08852052548;4188.643965262987;4190;4195.895102622398;4199.895002624898;4202.579742025834;4209.810558524874;4628.83799067031;4764.30917516965;4838.879028024257;4841.225403935424;4843.975780121077;5840.474357307863;5863.648181109062;5912.142739302777;5916.615419997686;5935.436133567304;1480.3560451203546;1501.2418728542016;1504.4132788212605;1504.9924750376397;1509.124707669549;992.161623428202;996.7358649957768;996.8654231678776;1005.5927349423495;1009.0615727373466;4997.575206107449;5042.899142017139;5044.066847633199;5073.061483625541;5109.9744501278;6140.508759299245;6140.723667434976;6143.600665956698;6152.600080994721;6164.075388691643;5019.071471777733;5072.6195535335;5081.364829396325;5086.16078347076;5092.26162206478;3215.5015972524297;3256.886008989721;3294.4893541501106;3314.0886256279714;3325.48454989477;5794.333651630032;5795.623284486495;5801.7099145042575;5808.912866307009;5812.94187058124;6375.362463753588;6411.583247089017;6414.166158399472;6436.066770318278;6455.903161452582;5617.354004289559;5759.65442073477;5799.362070172193;5803.158542011469;5812.244408226988;6103.694815259308;6116.541259405473;6139.631622102688;6200.286966998853;6203.906941395792;6033.939660603338;6039.63762174271;6041.909371359346;6041.939580604314;6042.667653279112;5679.801206957736;5704.486596206361;5724;5725.7137143141845;5782.5373970081455;3978.7214894957074;4099.1801639672785;4119.237940980928;4136.358864376027;4148.792560371909;5824.301083869963;5974.581779275409;6062;6073.848153796191;6075.058365953284;5687.20379146928;5871.588988770745;5936.961031819328;5939.821805345847;5941.821745347646;5906.173135761082;5921.526277897844;5922.555808314308;5922.7334769936315;5923.911141332797;5681.573881958952;5771.7114144293455;5780.8554786129;5789.8552536186935;5803.47768700819;5960.672163031075;5976.223090998143;5989.101634754822;5997.5501837363245;6014.909776353271;5725.51333136688;5755.913661295168;5759.280089988752;5760.423957604206;5842.707864606838 22:59:21 INFO - 2015-12-11 22:59:21,865 DEBUG : BROWSER_OUTPUT: |5;yui.html;762.1654288554033;774.8721460958942;783.7178615698348;785.1951749456806;797.5852556670535;10691.78616427672;10896.618618348359;10922;10927.945360273208;10969;13389.330533473336;13614.591562253123;13640.181589104635;13657.726845463085;13664.521741739041;808.6118663041743;810.4853418079532;810.8297257575916;812.354178428151;825.6779855856221;635.2853040329629;644.0243031806816;800.2677550041705;801.0787594266582;808.6886548678742;849.2950850793857;852;856.2379482260793;857.6140736668493;861.4400639584289;849;855.2003876375546;856.1609622569886;859.5959898847532;863.1756672377895;631.9684015799191;633.1041576169714;633.7845132654919;635.9523035772336;636.0681601453892;10892.782144357148;10998.450077496092;11037.392943388111;11050.668479945614;11054.778904421866;10588.523516441779;10988.560457581687;11156.888431115665;11313.321200727984;11808.586699465477;8787.0773568775;8840.8673869892;8979.865302020475;8995.100489951017;9279.350445468819;3208.9197770055935;3258.837058147083;3267;3268.8038717677014;3270.1824543864036;37813.62186378156;37901.43147852757;38156;38267;38494.230115397535;9209.539523023823;9340.532973351304;9372.734680818003;9486.905130948602;9728.367656102331;16531.91734041322;16563.42028029013;16571;16680.666386672197;16702.58243543897;6375.266844312963;6385.680715964276;6500.154979852589;6571.0471981562405;6582.473402127818;3370.679785420381;3429.091290807888;3463.341965026637;3524.1894364296354;3542.6103128655827;2580.148550978173;2613.2160351894354;2617.2148355493277;2617.4895895300233;2618.646482724808;477.8064883722098;482.2091769498026;483.8620993016973;483.9298301746227;488.8044782087122;439.2444994609267;485.6794515619674;518.1217835768336;559.0482253700468;568.4741614007027;7103.467239957024;7480.401567874557;8108.918910810817;8313.792155196168;8339.54132522705;450.2008934141924;455.0693831115377;475.6670330768476;550.9531689806412;600.9128676341905;3262.885798997024;3359.277755282626;3409.9659003409647;3415.9146021349666;3506.982465087658;46760.2985955211;47014;47325;47522.762386187846;47633.523664763605;42711.3935687589;42760.57239427628;43153.78423107927;43489.34765978449;43657.34513982293;40222;40644.39033414501;40699;40819.795901020305;41386.58613413887;6686.13080299558;6804.319568043156;6930.480213984072;7636.08366995964;7811.960940195263;30384.392312154076;30650;30726;30830.53754193644;30880;34399.14002149966;35251.64748352586;35918.640813591526;38691;38950.220995580494;9229.676961306322;9237.630494780133;9440.527973601429;9874.901250987397;9941.155001824925;11022.724431889266;11126.443677815914;11145.996860282614;11163.106951444028;11451.885481145415;10312.896871031193;10383.636572720221;10389.168866490512;10393.740156496147;10400.063994240554;10511.78976420452;10644.520996555018;10742.24804263694;10746.83879741789;10761.515731792244;10302.639407620996;10350.585976560853;10432.165426765992;10474.371537707762;10491.475426228506;9096.77258068527;9503;9599.520023998912;9672.177864881563;9846.015398460097;8799.736007919773;9138.862917056116;9220.124088211609;9224.446533208029;9226.123518265755 22:59:21 INFO - 2015-12-11 22:59:21,865 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:59:21 INFO - 2015-12-11 22:59:21,865 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:59:21 INFO - 2015-12-11 22:59:21,865 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,318 22:59:21 INFO - 2015-12-11 22:59:21,865 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:59:21 INFO - 2015-12-11 22:59:21,865 DEBUG : BROWSER_OUTPUT: __startTimestamp1449903561856__endTimestamp 22:59:21 INFO - 2015-12-11 22:59:21,865 DEBUG : BROWSER_OUTPUT: 22:59:21 INFO - 2015-12-11 22:59:21,866 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:59:21 INFO - 2015-12-11 22:59:21,866 DEBUG : BROWSER_OUTPUT: Number of tests: 6 22:59:21 INFO - 2015-12-11 22:59:21,866 DEBUG : BROWSER_OUTPUT: 22:59:21 INFO - 2015-12-11 22:59:21,866 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4747.17 Median:4899.83 stddev:497.85 (10.2%) stddev-sans-first:472.42 22:59:21 INFO - 2015-12-11 22:59:21,866 DEBUG : BROWSER_OUTPUT: Values: 2687.2 2739.3 2769.1 2775.4 2783.2 4608.4 4807.3 4812.4 4824.8 4878.7 4758.8 4767.2 4784.9 4899.8 4916.4 4382.4 4466.1 4519.0 4519.9 4551.7 4433.8 4466.6 4478.2 4520.1 4598.0 4234.7 4334.5 4491.9 4503.3 4571.5 4299.8 4390.3 4401.8 4402.7 4436.4 4370.7 4421.4 4454.4 4458.5 4493.8 4427.7 4582.2 4645.6 4685.0 4686.6 4999.7 5041.1 5098.9 5101.2 5109.2 5156.8 5217.0 5240.1 5247.6 5269.5 4570.1 4735.4 4751.5 4811.7 4908.7 5277.3 5297.9 5310.6 5324.1 5332.2 5083.2 5104.2 5107.0 5112.6 5155.7 4834.9 5007.7 5013.8 5018.3 5020.5 4998.1 5019.7 5042.3 5044.7 5046.2 5104.3 5125.1 5140.5 5154.3 5156.1 4314.4 4341.9 4365.3 4372.5 4391.8 3643.5 3658.8 3704.8 3718.3 3809.6 4446.4 4456.4 4503.5 4505.7 4557.0 5257.7 5270.5 5275.7 5283.4 5331.1 4264.9 4353.5 4367.1 4476.5 4485.4 4607.0 4633.4 4639.2 4646.1 4654.9 4897.9 4916.1 4917.9 4924.8 4956.2 4961.8 5080.1 5087.6 5157.5 5211.2 4906.8 4920.6 4937.2 4938.8 4981.1 4754.1 5171.6 5179.3 5186.9 5187.5 5029.1 5074.5 5099.8 5120.2 5158.7 4992.5 5005.9 5011.5 5033.0 5040.7 4748.2 4817.3 5036.1 5042.5 5045.3 4776.4 4814.7 4850.7 4904.0 4923.4 5059.1 5122.8 5124.5 5128.6 5132.8 4758.5 4765.8 4913.0 4991.4 5019.2 22:59:21 INFO - 2015-12-11 22:59:21,866 DEBUG : BROWSER_OUTPUT: 22:59:21 INFO - 2015-12-11 22:59:21,867 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38381.28 Median:18788.32 stddev:60640.37 (322.8%) stddev-sans-first:60743.95 22:59:21 INFO - 2015-12-11 22:59:21,867 DEBUG : BROWSER_OUTPUT: Values: 550.1 551.8 565.3 587.2 597.0 34852.7 35619.6 35645.5 35926.3 35934.5 38322.2 38716.0 38747.2 38820.0 38851.0 7713.6 7887.2 7910.7 7974.8 8058.6 7716.3 7830.0 7881.3 7887.3 7893.8 7745.0 7790.6 7799.5 7818.5 7856.1 7801.5 7886.0 7900.5 7916.2 7947.2 7806.0 7874.8 7909.8 7954.7 7955.7 36447.5 36726.3 36752.1 36847.0 36885.8 2800.5 2852.6 2855.0 3181.3 3422.5 27227.7 27682.7 28152.2 28168.7 28338.3 3376.1 3484.4 3486.7 3530.5 3540.5 193114.0 194314.0 194539.0 195061.0 198048.0 48321.8 49393.5 50030.5 51337.0 52886.0 46844.8 47219.3 47502.3 47535.3 47644.0 11615.2 11930.6 11933.3 12085.7 12121.8 8791.0 8902.5 8982.0 8987.5 9027.5 17200.3 17438.2 18570.1 18627.9 18640.3 7316.7 7460.8 7512.6 7523.0 7626.2 807.8 810.0 810.5 943.9 971.7 25541.2 25890.9 26375.5 27343.9 28308.2 891.3 901.6 921.8 935.1 1045.4 11319.2 13852.5 14640.0 14716.7 14934.7 247002.0 251314.0 254356.0 255683.0 256005.0 44825.1 45303.1 45669.3 45828.0 45859.5 1191.9 1195.6 1208.5 1221.3 1222.5 26125.5 26530.6 26672.0 26685.9 26775.0 39171.8 39631.6 39675.8 39701.8 39875.4 242847.0 246211.0 246296.0 247653.0 250896.0 26903.6 27300.0 28117.2 28139.3 28424.4 33202.2 33208.2 33394.7 34026.5 34154.1 28689.9 29318.4 29403.9 29522.4 29984.7 28355.7 28709.0 29003.3 29063.3 31298.8 29183.7 29291.4 29487.4 29531.6 29599.9 27548.7 28118.7 29668.3 32182.4 32325.7 22498.4 22528.5 22954.8 23023.4 23028.5 22:59:21 INFO - 2015-12-11 22:59:21,867 DEBUG : BROWSER_OUTPUT: 22:59:21 INFO - 2015-12-11 22:59:21,867 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26108.47 Median:23440.85 stddev:81255.96 (346.6%) stddev-sans-first:81460.85 22:59:21 INFO - 2015-12-11 22:59:21,867 DEBUG : BROWSER_OUTPUT: Values: 330.2 336.4 336.9 338.2 344.1 14632.3 14987.7 15440.2 15851.4 16418.8 15068.3 15105.7 15361.0 15407.4 15422.2 4597.9 5021.1 5025.7 5027.6 5036.1 5086.9 5128.5 5128.5 5130.4 5139.5 4948.6 5082.2 5086.4 5267.6 5281.7 5169.3 5218.2 5262.7 5274.1 5288.8 5005.3 5091.0 5104.8 5126.5 5134.7 11146.3 11166.1 11213.8 11419.8 11513.9 1658.1 1744.3 1781.8 1850.7 1901.5 8650.7 8702.1 8872.7 8914.4 9015.2 1632.2 1758.5 1773.3 1780.6 1790.8 54477.0 57106.7 57118.0 57190.4 57458.4 9951.7 10005.5 10017.2 10091.7 10110.5 12458.3 12475.4 12480.3 12490.6 12503.4 6686.0 6694.9 6717.3 6759.8 6760.3 6158.4 6211.1 6230.3 6246.8 6254.3 4100.1 4192.5 4252.6 4258.7 4272.8 1718.6 1769.4 1779.4 1788.8 1817.7 392.7 396.6 399.4 813.2 874.4 9560.5 10127.8 10201.6 10245.3 10352.9 397.2 398.8 401.5 420.0 424.8 9036.0 9402.2 9440.8 9443.5 9650.9 480303.6 484081.0 499543.0 501381.0 517000.0 73652.3 74128.3 74447.6 74686.6 75665.6 1047.5 1060.9 1080.1 1087.1 1094.4 13821.3 14271.9 14288.2 14418.4 14476.1 32669.3 33891.5 34134.8 34283.8 35648.3 42141.6 42623.0 42832.1 43756.3 44373.0 8374.8 8775.7 8829.2 9025.1 9032.2 9744.8 9764.3 9765.8 9907.1 12008.9 8593.2 13347.3 13382.5 13696.7 13732.8 8667.9 8765.1 8900.6 8978.4 9014.8 8811.1 8921.8 9158.8 9212.1 9214.7 12829.6 12966.3 13687.1 13728.3 13919.4 14289.9 14482.6 14550.3 14596.1 14643.0 22:59:21 INFO - 2015-12-11 22:59:21,867 DEBUG : BROWSER_OUTPUT: 22:59:21 INFO - 2015-12-11 22:59:21,867 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4861.39 Median:6132.98 stddev:2500.62 (40.8%) stddev-sans-first:2493.69 22:59:21 INFO - 2015-12-11 22:59:21,868 DEBUG : BROWSER_OUTPUT: Values: 1347.9 1377.3 1385.7 1621.2 1701.5 6901.6 7060.5 7071.7 7091.9 7183.0 7189.4 7275.7 7317.6 7332.5 7345.7 2081.6 2119.8 2120.9 2123.5 2124.7 2115.4 2124.2 2132.7 2164.1 2168.9 1734.8 1766.6 2068.0 2087.1 2090.3 2079.6 2087.4 2088.0 2088.8 2092.0 2060.5 2086.7 2144.1 2156.2 2156.9 6964.1 7067.4 7093.9 7096.6 7146.9 4231.7 4320.1 4321.0 4332.0 4345.6 2802.3 2826.4 2855.3 2867.2 2868.6 875.0 884.9 886.3 912.3 920.3 9005.5 9238.1 9417.3 9470.1 9540.1 3821.8 3864.1 3873.6 3912.4 3962.5 7720.8 7721.2 7727.8 7747.4 7845.8 4103.2 4159.6 4161.1 4172.8 4181.1 3783.3 3785.7 3800.2 3801.1 3802.5 2907.1 2979.2 2985.0 2998.4 3016.5 902.5 905.4 908.5 911.2 915.5 734.7 766.8 803.0 814.2 907.3 6496.2 6866.3 7002.1 7004.7 7031.8 1048.7 1065.5 1073.9 1079.1 1080.9 5222.1 5263.5 5266.1 5268.7 5303.2 8056.2 8149.7 8230.1 8315.5 8358.1 8101.8 8237.9 8242.6 8298.0 8308.6 6352.7 6411.3 6475.5 6499.3 6519.4 6128.9 6137.0 6166.7 6178.0 6191.2 7361.4 7374.9 7380.5 7549.8 7557.3 7499.5 7679.4 7691.6 7699.0 7709.2 5934.9 5956.1 5968.6 5991.7 6067.9 6420.5 6443.2 6459.2 6508.4 6518.8 5901.3 6122.6 6221.1 6348.1 6361.2 5010.2 5043.3 6115.7 6164.8 6177.3 6251.8 6303.7 6318.1 6332.5 6365.3 5883.6 5885.3 5907.1 5908.7 5914.6 5961.1 6077.4 6098.9 6100.5 6115.4 22:59:21 INFO - 2015-12-11 22:59:21,868 DEBUG : BROWSER_OUTPUT: 22:59:21 INFO - 2015-12-11 22:59:21,868 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4864.70 Median:5578.55 stddev:1454.51 (26.1%) stddev-sans-first:1417.76 22:59:21 INFO - 2015-12-11 22:59:21,868 DEBUG : BROWSER_OUTPUT: Values: 305.3 312.1 312.6 316.1 316.3 5438.9 5601.6 5623.8 5634.1 5636.6 5510.3 5570.8 5574.5 5582.6 5604.5 4172.9 4330.1 4333.4 4336.3 4336.8 4289.3 4302.2 4322.8 4335.0 4337.0 4282.7 4288.0 4290.5 4292.4 4293.7 4276.0 4284.8 4294.0 4294.3 4300.0 3480.5 3662.2 3680.2 3701.9 3726.2 5228.7 5369.6 5372.7 5384.9 5393.8 4893.7 4918.6 4933.3 4948.1 4951.9 5884.4 5884.8 5886.9 5889.0 5898.1 3921.3 4042.3 4044.6 4046.7 4057.3 6152.7 6248.2 6254.5 6261.2 6262.7 4127.9 4129.0 4137.2 4143.1 4188.6 4190.0 4195.9 4199.9 4202.6 4209.8 4628.8 4764.3 4838.9 4841.2 4844.0 5840.5 5863.6 5912.1 5916.6 5935.4 1480.4 1501.2 1504.4 1505.0 1509.1 992.2 996.7 996.9 1005.6 1009.1 4997.6 5042.9 5044.1 5073.1 5110.0 6140.5 6140.7 6143.6 6152.6 6164.1 5019.1 5072.6 5081.4 5086.2 5092.3 3215.5 3256.9 3294.5 3314.1 3325.5 5794.3 5795.6 5801.7 5808.9 5812.9 6375.4 6411.6 6414.2 6436.1 6455.9 5617.4 5759.7 5799.4 5803.2 5812.2 6103.7 6116.5 6139.6 6200.3 6203.9 6033.9 6039.6 6041.9 6041.9 6042.7 5679.8 5704.5 5724.0 5725.7 5782.5 3978.7 4099.2 4119.2 4136.4 4148.8 5824.3 5974.6 6062.0 6073.8 6075.1 5687.2 5871.6 5937.0 5939.8 5941.8 5906.2 5921.5 5922.6 5922.7 5923.9 5681.6 5771.7 5780.9 5789.9 5803.5 5960.7 5976.2 5989.1 5997.6 6014.9 5725.5 5755.9 5759.3 5760.4 5842.7 22:59:21 INFO - 2015-12-11 22:59:21,868 DEBUG : BROWSER_OUTPUT: 22:59:21 INFO - 2015-12-11 22:59:21,869 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11932.73 Median:444.72 stddev:13253.95 (2980.3%) stddev-sans-first:13264.58 22:59:21 INFO - 2015-12-11 22:59:21,869 DEBUG : BROWSER_OUTPUT: Values: 762.2 774.9 783.7 785.2 797.6 10691.8 10896.6 10922.0 10927.9 10969.0 13389.3 13614.6 13640.2 13657.7 13664.5 808.6 810.5 810.8 812.4 825.7 635.3 644.0 800.3 801.1 808.7 849.3 852.0 856.2 857.6 861.4 849.0 855.2 856.2 859.6 863.2 632.0 633.1 633.8 636.0 636.1 10892.8 10998.5 11037.4 11050.7 11054.8 10588.5 10988.6 11156.9 11313.3 11808.6 8787.1 8840.9 8979.9 8995.1 9279.4 3208.9 3258.8 3267.0 3268.8 3270.2 37813.6 37901.4 38156.0 38267.0 38494.2 9209.5 9340.5 9372.7 9486.9 9728.4 16531.9 16563.4 16571.0 16680.7 16702.6 6375.3 6385.7 6500.2 6571.0 6582.5 3370.7 3429.1 3463.3 3524.2 3542.6 2580.1 2613.2 2617.2 2617.5 2618.6 477.8 482.2 483.9 483.9 488.8 439.2 485.7 518.1 559.0 568.5 7103.5 7480.4 8108.9 8313.8 8339.5 450.2 455.1 475.7 551.0 600.9 3262.9 3359.3 3410.0 3415.9 3507.0 46760.3 47014.0 47325.0 47522.8 47633.5 42711.4 42760.6 43153.8 43489.3 43657.3 40222.0 40644.4 40699.0 40819.8 41386.6 6686.1 6804.3 6930.5 7636.1 7812.0 30384.4 30650.0 30726.0 30830.5 30880.0 34399.1 35251.6 35918.6 38691.0 38950.2 9229.7 9237.6 9440.5 9874.9 9941.2 11022.7 11126.4 11146.0 11163.1 11451.9 10312.9 10383.6 10389.2 10393.7 10400.1 10511.8 10644.5 10742.2 10746.8 10761.5 10302.6 10350.6 10432.2 10474.4 10491.5 9096.8 9503.0 9599.5 9672.2 9846.0 8799.7 9138.9 9220.1 9224.4 9226.1 22:59:21 INFO - 2015-12-11 22:59:21,869 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:59:21 INFO - 2015-12-11 22:59:21,869 DEBUG : BROWSER_OUTPUT: 22:59:22 INFO - 2015-12-11 22:59:22,616 INFO : Browser exited with error code: 0 22:59:22 INFO - 2015-12-11 22:59:22,636 INFO : Completed test dromaeo_css (00:18:36) 22:59:22 INFO - 2015-12-11 22:59:22,636 INFO : Starting test kraken 22:59:22 INFO - 2015-12-11 22:59:22,636 DEBUG : operating with platform_type : linux_ 22:59:22 INFO - 2015-12-11 22:59:22,636 INFO : Initialising browser for kraken test... 22:59:22 INFO - 2015-12-11 22:59:22,642 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpouKIaW/profile http://localhost:42763/getInfo.html 22:59:27 INFO - 2015-12-11 22:59:27,138 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:59:27 INFO - 2015-12-11 22:59:27,138 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:59:27 INFO - 2015-12-11 22:59:27,138 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:59:27 INFO - 2015-12-11 22:59:27,138 DEBUG : BROWSER_OUTPUT: __metrics 22:59:27 INFO - 2015-12-11 22:59:27,275 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:59:28 INFO - 2015-12-11 22:59:28,202 INFO : Browser initialized. 22:59:28 INFO - 2015-12-11 22:59:28,202 INFO : Running cycle 1/1 for kraken test... 22:59:28 INFO - 2015-12-11 22:59:28,203 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpouKIaW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:59:40 INFO - 2015-12-11 22:59:40,297 DEBUG : BROWSER_OUTPUT: RSS: Main: 142950400 22:59:40 INFO - 2015-12-11 22:59:40,297 DEBUG : BROWSER_OUTPUT: 22:59:42 INFO - 2015-12-11 22:59:42,873 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42763/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42763/tests/kraken/driver.html?testName=audio-beat-detection) 22:59:43 INFO - 2015-12-11 22:59:43,483 DEBUG : BROWSER_OUTPUT: RSS: Main: 141783040 22:59:43 INFO - 2015-12-11 22:59:43,483 DEBUG : BROWSER_OUTPUT: 22:59:46 INFO - 2015-12-11 22:59:46,242 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42763/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42763/tests/kraken/driver.html?testName=audio-dft) 22:59:46 INFO - 2015-12-11 22:59:46,844 DEBUG : BROWSER_OUTPUT: RSS: Main: 142606336 22:59:46 INFO - 2015-12-11 22:59:46,845 DEBUG : BROWSER_OUTPUT: 22:59:49 INFO - 2015-12-11 22:59:49,728 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42763/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42763/tests/kraken/driver.html?testName=audio-fft) 22:59:50 INFO - 2015-12-11 22:59:50,315 DEBUG : BROWSER_OUTPUT: RSS: Main: 137281536 22:59:50 INFO - 2015-12-11 22:59:50,315 DEBUG : BROWSER_OUTPUT: 22:59:52 INFO - 2015-12-11 22:59:52,400 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42763/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42763/tests/kraken/driver.html?testName=audio-oscillator) 22:59:52 INFO - 2015-12-11 22:59:52,993 DEBUG : BROWSER_OUTPUT: RSS: Main: 138420224 22:59:52 INFO - 2015-12-11 22:59:52,993 DEBUG : BROWSER_OUTPUT: 22:59:55 INFO - 2015-12-11 22:59:55,247 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42763/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42763/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:59:55 INFO - 2015-12-11 22:59:55,833 DEBUG : BROWSER_OUTPUT: RSS: Main: 139628544 22:59:55 INFO - 2015-12-11 22:59:55,833 DEBUG : BROWSER_OUTPUT: 22:59:58 INFO - 2015-12-11 22:59:58,912 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42763/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42763/tests/kraken/driver.html?testName=imaging-darkroom) 22:59:59 INFO - 2015-12-11 22:59:59,513 DEBUG : BROWSER_OUTPUT: RSS: Main: 140599296 22:59:59 INFO - 2015-12-11 22:59:59,514 DEBUG : BROWSER_OUTPUT: 23:00:02 INFO - 2015-12-11 23:00:02,997 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42763/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42763/tests/kraken/driver.html?testName=imaging-desaturate) 23:00:03 INFO - 2015-12-11 23:00:03,598 DEBUG : BROWSER_OUTPUT: RSS: Main: 138395648 23:00:03 INFO - 2015-12-11 23:00:03,598 DEBUG : BROWSER_OUTPUT: 23:00:06 INFO - 2015-12-11 23:00:06,577 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42763/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42763/tests/kraken/driver.html?testName=json-parse-financial) 23:00:07 INFO - 2015-12-11 23:00:07,164 DEBUG : BROWSER_OUTPUT: RSS: Main: 139640832 23:00:07 INFO - 2015-12-11 23:00:07,164 DEBUG : BROWSER_OUTPUT: 23:00:08 INFO - 2015-12-11 23:00:08,933 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42763/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42763/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:00:09 INFO - 2015-12-11 23:00:09,514 DEBUG : BROWSER_OUTPUT: RSS: Main: 139292672 23:00:09 INFO - 2015-12-11 23:00:09,514 DEBUG : BROWSER_OUTPUT: 23:00:11 INFO - 2015-12-11 23:00:11,412 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42763/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42763/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:00:12 INFO - 2015-12-11 23:00:12,034 DEBUG : BROWSER_OUTPUT: RSS: Main: 139968512 23:00:12 INFO - 2015-12-11 23:00:12,034 DEBUG : BROWSER_OUTPUT: 23:00:14 INFO - 2015-12-11 23:00:14,198 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42763/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42763/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:00:14 INFO - 2015-12-11 23:00:14,792 DEBUG : BROWSER_OUTPUT: RSS: Main: 139743232 23:00:14 INFO - 2015-12-11 23:00:14,792 DEBUG : BROWSER_OUTPUT: 23:00:17 INFO - 2015-12-11 23:00:17,391 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42763/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42763/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:00:17 INFO - 2015-12-11 23:00:17,997 DEBUG : BROWSER_OUTPUT: RSS: Main: 140296192 23:00:17 INFO - 2015-12-11 23:00:17,998 DEBUG : BROWSER_OUTPUT: 23:00:20 INFO - 2015-12-11 23:00:20,612 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42763/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42763/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:00:21 INFO - 2015-12-11 23:00:21,214 DEBUG : BROWSER_OUTPUT: RSS: Main: 141058048 23:00:21 INFO - 2015-12-11 23:00:21,214 DEBUG : BROWSER_OUTPUT: 23:00:22 INFO - 2015-12-11 23:00:22,984 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42763/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42763/tests/kraken/driver.html?testName=ai-astar) 23:00:23 INFO - 2015-12-11 23:00:23,233 DEBUG : BROWSER_OUTPUT: RSS: Main: 140607488 23:00:23 INFO - 2015-12-11 23:00:23,234 DEBUG : BROWSER_OUTPUT: 23:00:23 INFO - 2015-12-11 23:00:23,234 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:00:23 INFO - 2015-12-11 23:00:23,235 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:00:23 INFO - 2015-12-11 23:00:23,236 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:00:23 INFO - 2015-12-11 23:00:23,236 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:00:23 INFO - 2015-12-11 23:00:23,236 DEBUG : BROWSER_OUTPUT: |0;ai-astar;117;109;114;114;113;125;114;115;114;113 23:00:23 INFO - 2015-12-11 23:00:23,236 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;168;130;160;162;129;151;158;138;172;132 23:00:23 INFO - 2015-12-11 23:00:23,236 DEBUG : BROWSER_OUTPUT: |2;audio-dft;173;161;162;161;162;166;164;162;162;163 23:00:23 INFO - 2015-12-11 23:00:23,237 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;73;72;147;71;77;73;74;152 23:00:23 INFO - 2015-12-11 23:00:23,237 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;137;95;95;94;131;94;94;129 23:00:23 INFO - 2015-12-11 23:00:23,237 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;110;110;110;109;110;110;112 23:00:23 INFO - 2015-12-11 23:00:23,237 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;148;147;147;148;148;147;148;148;148 23:00:23 INFO - 2015-12-11 23:00:23,237 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;98;97;96;96;96;96;96;96;96;96 23:00:23 INFO - 2015-12-11 23:00:23,237 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;72;72;72;73;73;72;83;72;71 23:00:23 INFO - 2015-12-11 23:00:23,237 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;68;68;68;68;68;69;69;68 23:00:23 INFO - 2015-12-11 23:00:23,238 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;86;84;85;85;85;86;86;93;84 23:00:23 INFO - 2015-12-11 23:00:23,238 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;130;121;124;131;130;125;127;120;127 23:00:23 INFO - 2015-12-11 23:00:23,238 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;160;154;150;149;138;153;149;148;138 23:00:23 INFO - 2015-12-11 23:00:23,238 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;69;72;74;72;69;71;70;69;72 23:00:23 INFO - 2015-12-11 23:00:23,238 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:00:23 INFO - 2015-12-11 23:00:23,238 DEBUG : BROWSER_OUTPUT: __start_cc_report 23:00:23 INFO - 2015-12-11 23:00:23,238 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,808 23:00:23 INFO - 2015-12-11 23:00:23,239 DEBUG : BROWSER_OUTPUT: __end_cc_report 23:00:23 INFO - 2015-12-11 23:00:23,239 DEBUG : BROWSER_OUTPUT: __startTimestamp1449903623233__endTimestamp 23:00:23 INFO - 2015-12-11 23:00:23,239 DEBUG : BROWSER_OUTPUT: 23:00:23 INFO - 2015-12-11 23:00:23,242 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:00:23 INFO - 2015-12-11 23:00:23,242 DEBUG : BROWSER_OUTPUT: Number of tests: 14 23:00:23 INFO - 2015-12-11 23:00:23,242 DEBUG : BROWSER_OUTPUT: 23:00:23 INFO - 2015-12-11 23:00:23,243 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.80 Median:114.00 stddev:4.10 (3.6%) stddev-sans-first:4.28 23:00:23 INFO - 2015-12-11 23:00:23,243 DEBUG : BROWSER_OUTPUT: Values: 117.0 109.0 114.0 114.0 113.0 125.0 114.0 115.0 114.0 113.0 23:00:23 INFO - 2015-12-11 23:00:23,243 DEBUG : BROWSER_OUTPUT: 23:00:23 INFO - 2015-12-11 23:00:23,243 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.00 Median:159.00 stddev:16.42 (10.3%) stddev-sans-first:16.07 23:00:23 INFO - 2015-12-11 23:00:23,243 DEBUG : BROWSER_OUTPUT: Values: 168.0 130.0 160.0 162.0 129.0 151.0 158.0 138.0 172.0 132.0 23:00:23 INFO - 2015-12-11 23:00:23,243 DEBUG : BROWSER_OUTPUT: 23:00:23 INFO - 2015-12-11 23:00:23,243 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.60 Median:162.50 stddev:3.63 (2.2%) stddev-sans-first:1.59 23:00:23 INFO - 2015-12-11 23:00:23,245 DEBUG : BROWSER_OUTPUT: Values: 173.0 161.0 162.0 161.0 162.0 166.0 164.0 162.0 162.0 163.0 23:00:23 INFO - 2015-12-11 23:00:23,245 DEBUG : BROWSER_OUTPUT: 23:00:23 INFO - 2015-12-11 23:00:23,245 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.40 Median:73.00 stddev:32.26 (44.2%) stddev-sans-first:33.74 23:00:23 INFO - 2015-12-11 23:00:23,245 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 73.0 72.0 147.0 71.0 77.0 73.0 74.0 152.0 23:00:23 INFO - 2015-12-11 23:00:23,245 DEBUG : BROWSER_OUTPUT: 23:00:23 INFO - 2015-12-11 23:00:23,245 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.80 Median:94.00 stddev:18.42 (19.6%) stddev-sans-first:19.12 23:00:23 INFO - 2015-12-11 23:00:23,245 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 137.0 95.0 95.0 94.0 131.0 94.0 94.0 129.0 23:00:23 INFO - 2015-12-11 23:00:23,245 DEBUG : BROWSER_OUTPUT: 23:00:23 INFO - 2015-12-11 23:00:23,245 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 23:00:23 INFO - 2015-12-11 23:00:23,246 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 110.0 110.0 110.0 109.0 110.0 110.0 112.0 23:00:23 INFO - 2015-12-11 23:00:23,246 DEBUG : BROWSER_OUTPUT: 23:00:23 INFO - 2015-12-11 23:00:23,246 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 23:00:23 INFO - 2015-12-11 23:00:23,246 DEBUG : BROWSER_OUTPUT: Values: 148.0 148.0 147.0 147.0 148.0 148.0 147.0 148.0 148.0 148.0 23:00:23 INFO - 2015-12-11 23:00:23,246 DEBUG : BROWSER_OUTPUT: 23:00:23 INFO - 2015-12-11 23:00:23,246 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.33 23:00:23 INFO - 2015-12-11 23:00:23,246 DEBUG : BROWSER_OUTPUT: Values: 98.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 23:00:23 INFO - 2015-12-11 23:00:23,246 DEBUG : BROWSER_OUTPUT: 23:00:23 INFO - 2015-12-11 23:00:23,246 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.20 Median:72.00 stddev:3.49 (4.8%) stddev-sans-first:3.67 23:00:23 INFO - 2015-12-11 23:00:23,247 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 72.0 72.0 73.0 73.0 72.0 83.0 72.0 71.0 23:00:23 INFO - 2015-12-11 23:00:23,247 DEBUG : BROWSER_OUTPUT: 23:00:23 INFO - 2015-12-11 23:00:23,247 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.44 23:00:23 INFO - 2015-12-11 23:00:23,247 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 68.0 68.0 68.0 68.0 68.0 69.0 69.0 68.0 23:00:23 INFO - 2015-12-11 23:00:23,247 DEBUG : BROWSER_OUTPUT: 23:00:23 INFO - 2015-12-11 23:00:23,247 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:85.50 stddev:2.66 (3.1%) stddev-sans-first:2.74 23:00:23 INFO - 2015-12-11 23:00:23,247 DEBUG : BROWSER_OUTPUT: Values: 84.0 86.0 84.0 85.0 85.0 85.0 86.0 86.0 93.0 84.0 23:00:23 INFO - 2015-12-11 23:00:23,247 DEBUG : BROWSER_OUTPUT: 23:00:23 INFO - 2015-12-11 23:00:23,247 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:127.00 stddev:3.74 (2.9%) stddev-sans-first:3.95 23:00:23 INFO - 2015-12-11 23:00:23,248 DEBUG : BROWSER_OUTPUT: Values: 127.0 130.0 121.0 124.0 131.0 130.0 125.0 127.0 120.0 127.0 23:00:23 INFO - 2015-12-11 23:00:23,248 DEBUG : BROWSER_OUTPUT: 23:00:23 INFO - 2015-12-11 23:00:23,248 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.00 Median:149.50 stddev:7.15 (4.8%) stddev-sans-first:7.12 23:00:23 INFO - 2015-12-11 23:00:23,248 DEBUG : BROWSER_OUTPUT: Values: 141.0 160.0 154.0 150.0 149.0 138.0 153.0 149.0 148.0 138.0 23:00:23 INFO - 2015-12-11 23:00:23,248 DEBUG : BROWSER_OUTPUT: 23:00:23 INFO - 2015-12-11 23:00:23,248 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:71.50 stddev:1.66 (2.3%) stddev-sans-first:1.76 23:00:23 INFO - 2015-12-11 23:00:23,248 DEBUG : BROWSER_OUTPUT: Values: 71.0 69.0 72.0 74.0 72.0 69.0 71.0 70.0 69.0 72.0 23:00:23 INFO - 2015-12-11 23:00:23,248 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:00:23 INFO - 2015-12-11 23:00:23,248 DEBUG : BROWSER_OUTPUT: 23:00:24 INFO - 2015-12-11 23:00:24,190 INFO : Browser exited with error code: 0 23:00:24 INFO - 2015-12-11 23:00:24,238 INFO : Completed test kraken (00:01:01) 23:00:24 INFO - 2015-12-11 23:00:24,239 INFO : Starting test v8_7 23:00:24 INFO - 2015-12-11 23:00:24,239 DEBUG : operating with platform_type : linux_ 23:00:24 INFO - 2015-12-11 23:00:24,239 INFO : Initialising browser for v8_7 test... 23:00:24 INFO - 2015-12-11 23:00:24,245 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA0OXwj/profile http://localhost:42763/getInfo.html 23:00:28 INFO - 2015-12-11 23:00:28,775 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:00:28 INFO - 2015-12-11 23:00:28,775 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:00:28 INFO - 2015-12-11 23:00:28,775 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 23:00:28 INFO - 2015-12-11 23:00:28,775 DEBUG : BROWSER_OUTPUT: __metrics 23:00:28 INFO - 2015-12-11 23:00:28,883 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:00:29 INFO - 2015-12-11 23:00:29,774 INFO : Browser initialized. 23:00:29 INFO - 2015-12-11 23:00:29,774 INFO : Running cycle 1/1 for v8_7 test... 23:00:29 INFO - 2015-12-11 23:00:29,775 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA0OXwj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:00:41 INFO - 2015-12-11 23:00:41,764 DEBUG : BROWSER_OUTPUT: RSS: Main: 142704640 23:00:41 INFO - 2015-12-11 23:00:41,764 DEBUG : BROWSER_OUTPUT: 23:01:03 INFO - 2015-12-11 23:01:03,281 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42763/tests/v8_7/run.html (next: http://localhost:42763/tests/v8_7/run.html) 23:01:03 INFO - 2015-12-11 23:01:03,531 DEBUG : BROWSER_OUTPUT: RSS: Main: 137998336 23:01:03 INFO - 2015-12-11 23:01:03,532 DEBUG : BROWSER_OUTPUT: 23:01:03 INFO - 2015-12-11 23:01:03,532 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:01:03 INFO - 2015-12-11 23:01:03,532 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:01:03 INFO - 2015-12-11 23:01:03,532 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:01:03 INFO - 2015-12-11 23:01:03,532 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:01:03 INFO - 2015-12-11 23:01:03,532 DEBUG : BROWSER_OUTPUT: |0;Richards;167.44809109176154 23:01:03 INFO - 2015-12-11 23:01:03,532 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;183.5199119104423 23:01:03 INFO - 2015-12-11 23:01:03,532 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.6291446085261 23:01:03 INFO - 2015-12-11 23:01:03,533 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5154.639175257732 23:01:03 INFO - 2015-12-11 23:01:03,533 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1101.3215859030836 23:01:03 INFO - 2015-12-11 23:01:03,533 DEBUG : BROWSER_OUTPUT: |5;Earley;706.9209039548023 23:01:03 INFO - 2015-12-11 23:01:03,533 DEBUG : BROWSER_OUTPUT: |6;Boyer;12120.481927710844 23:01:03 INFO - 2015-12-11 23:01:03,533 DEBUG : BROWSER_OUTPUT: |7;RegExp;26128.20512820513 23:01:03 INFO - 2015-12-11 23:01:03,533 DEBUG : BROWSER_OUTPUT: |8;Splay;591.7159763313609 23:01:03 INFO - 2015-12-11 23:01:03,533 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4859.223300970873 23:01:03 INFO - 2015-12-11 23:01:03,534 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:01:03 INFO - 2015-12-11 23:01:03,534 DEBUG : BROWSER_OUTPUT: __startTimestamp1449903663531__endTimestamp 23:01:03 INFO - 2015-12-11 23:01:03,534 DEBUG : BROWSER_OUTPUT: 23:01:03 INFO - 2015-12-11 23:01:03,534 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:01:03 INFO - 2015-12-11 23:01:03,534 DEBUG : BROWSER_OUTPUT: Number of tests: 10 23:01:03 INFO - 2015-12-11 23:01:03,535 DEBUG : BROWSER_OUTPUT: 23:01:03 INFO - 2015-12-11 23:01:03,535 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.45 Median:167.45 stddev:0.00 (0.0%) 23:01:03 INFO - 2015-12-11 23:01:03,536 DEBUG : BROWSER_OUTPUT: Values: 167.4 23:01:03 INFO - 2015-12-11 23:01:03,536 DEBUG : BROWSER_OUTPUT: 23:01:03 INFO - 2015-12-11 23:01:03,536 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:183.52 Median:183.52 stddev:0.00 (0.0%) 23:01:03 INFO - 2015-12-11 23:01:03,536 DEBUG : BROWSER_OUTPUT: Values: 183.5 23:01:03 INFO - 2015-12-11 23:01:03,537 DEBUG : BROWSER_OUTPUT: 23:01:03 INFO - 2015-12-11 23:01:03,537 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.63 Median:278.63 stddev:0.00 (0.0%) 23:01:03 INFO - 2015-12-11 23:01:03,537 DEBUG : BROWSER_OUTPUT: Values: 278.6 23:01:03 INFO - 2015-12-11 23:01:03,537 DEBUG : BROWSER_OUTPUT: 23:01:03 INFO - 2015-12-11 23:01:03,537 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5154.64 Median:5154.64 stddev:0.00 (0.0%) 23:01:03 INFO - 2015-12-11 23:01:03,537 DEBUG : BROWSER_OUTPUT: Values: 5154.6 23:01:03 INFO - 2015-12-11 23:01:03,537 DEBUG : BROWSER_OUTPUT: 23:01:03 INFO - 2015-12-11 23:01:03,538 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1101.32 Median:1101.32 stddev:0.00 (0.0%) 23:01:03 INFO - 2015-12-11 23:01:03,538 DEBUG : BROWSER_OUTPUT: Values: 1101.3 23:01:03 INFO - 2015-12-11 23:01:03,538 DEBUG : BROWSER_OUTPUT: 23:01:03 INFO - 2015-12-11 23:01:03,538 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:706.92 Median:706.92 stddev:0.00 (0.0%) 23:01:03 INFO - 2015-12-11 23:01:03,538 DEBUG : BROWSER_OUTPUT: Values: 706.9 23:01:03 INFO - 2015-12-11 23:01:03,538 DEBUG : BROWSER_OUTPUT: 23:01:03 INFO - 2015-12-11 23:01:03,538 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12120.48 Median:12120.48 stddev:0.00 (0.0%) 23:01:03 INFO - 2015-12-11 23:01:03,538 DEBUG : BROWSER_OUTPUT: Values: 12120.5 23:01:03 INFO - 2015-12-11 23:01:03,538 DEBUG : BROWSER_OUTPUT: 23:01:03 INFO - 2015-12-11 23:01:03,538 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26128.21 Median:26128.21 stddev:0.00 (0.0%) 23:01:03 INFO - 2015-12-11 23:01:03,538 DEBUG : BROWSER_OUTPUT: Values: 26128.2 23:01:03 INFO - 2015-12-11 23:01:03,538 DEBUG : BROWSER_OUTPUT: 23:01:03 INFO - 2015-12-11 23:01:03,538 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:591.72 Median:591.72 stddev:0.00 (0.0%) 23:01:03 INFO - 2015-12-11 23:01:03,538 DEBUG : BROWSER_OUTPUT: Values: 591.7 23:01:03 INFO - 2015-12-11 23:01:03,538 DEBUG : BROWSER_OUTPUT: 23:01:03 INFO - 2015-12-11 23:01:03,539 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4859.22 Median:4859.22 stddev:0.00 (0.0%) 23:01:03 INFO - 2015-12-11 23:01:03,539 DEBUG : BROWSER_OUTPUT: Values: 4859.2 23:01:03 INFO - 2015-12-11 23:01:03,539 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:01:03 INFO - 2015-12-11 23:01:03,539 DEBUG : BROWSER_OUTPUT: 23:01:04 INFO - 2015-12-11 23:01:04,446 INFO : Browser exited with error code: 0 23:01:04 INFO - 2015-12-11 23:01:04,464 INFO : Completed test v8_7 (00:00:40) 23:01:04 INFO - 2015-12-11 23:01:04,501 INFO : Completed test suite (00:20:18) 23:01:04 INFO - 2015-12-11 23:01:04,501 DEBUG : Working with test: dromaeo_css 23:01:04 INFO - 2015-12-11 23:01:04,502 DEBUG : Generating results file: dromaeo_css 23:01:04 INFO - 2015-12-11 23:01:04,503 DEBUG : Working with test: kraken 23:01:04 INFO - 2015-12-11 23:01:04,503 DEBUG : Generating results file: kraken 23:01:04 INFO - 2015-12-11 23:01:04,503 INFO : javascript benchmark 23:01:04 INFO - 2015-12-11 23:01:04,503 DEBUG : Working with test: v8_7 23:01:04 INFO - 2015-12-11 23:01:04,503 DEBUG : Generating results file: v8_7 23:01:04 INFO - 2015-12-11 23:01:04,504 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:01:04 INFO - 2015-12-11 23:01:04,648 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 23:01:04 INFO - 2015-12-11 23:01:04,648 DEBUG : process_Request line: dromaeo_css 6209.14 graph.html#tests=[[72,94,43]] 23:01:04 INFO - 2015-12-11 23:01:04,649 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:01:04 INFO - 2015-12-11 23:01:04,749 DEBUG : process_Request line: kraken 1548.80 graph.html#tests=[[232,94,43]] 23:01:04 INFO - 2015-12-11 23:01:04,749 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:01:04 INFO - 2015-12-11 23:01:04,864 DEBUG : process_Request line: v8_7 21377.03 graph.html#tests=[[230,94,43]] 23:01:04 INFO - 2015-12-11 23:01:04,865 INFO : javascript benchmark 23:01:04 INFO - 2015-12-11 23:01:04,869 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2687.2072738542133, 2739.3425577861294, 2769.1415661145047, 2775.4449110177957, 2783.178962206149, 4608.354830323758, 4807.271134472184, 4812.398450193726, 4824.831130910419, 4878.707277563344, 4758.833440829571, 4767.237242041274, 4784.90430191396, 4899.828506002291, 4916.434610019849, 4382.38646589477, 4466.12910482456, 4519.0, 4519.909601807962, 4551.726896386211, 4433.756143412111, 4466.5980061794435, 4478.193925093482, 4520.073384956077, 4598.0344127733215, 4234.724742891703, 4334.523202447728, 4491.887702807423, 4503.301988191803, 4571.4514258289055, 4299.828006879721, 4390.297552391602, 4401.845935392278, 4402.7358358498595, 4436.423264975532, 4370.672199585044, 4421.38100665907, 4454.37638730578, 4458.464984201884, 4493.775311234425, 4427.667924905645, 4582.1981153298375, 4645.581897629196, 4685.0, 4686.554777296152, 4999.700017998895, 5041.067402530507, 5098.949010509921, 5101.15830887903, 5109.233614957749, 5156.819511317123, 5216.9739151304, 5240.135377662681, 5247.606429517763, 5269.525742683139, 4570.10882877839, 4735.384400028043, 4751.52484751529, 4811.735354555498, 4908.656394052454, 5277.340332458442, 5297.947020529822, 5310.60170487215, 5324.148136298174, 5332.173513105475, 5083.2375143727995, 5104.183330667075, 5107.0, 5112.590992720573, 5155.664881782672, 4834.854954351375, 5007.69953802773, 5013.799448022111, 5018.347614810052, 5020.49795020495, 4998.050370429607, 5019.67372120811, 5042.319286896295, 5044.722540260321, 5046.243063540498, 5104.285400043997, 5125.051865404912, 5140.537351638371, 5154.278401023859, 5156.097682905476, 4314.352847072964, 4341.914521369657, 4365.257906155961, 4372.453443319585, 4391.824327026883, 3643.5263415756312, 3658.835352409095, 3704.7777133372083, 3718.2935242303874, 3809.580946095927, 4446.444194475691, 4456.3538286948215, 4503.549645035536, 4505.662075344297, 4556.977215113903, 5257.684538927677, 5270.49930256625, 5275.709835959059, 5283.418823929364, 5331.1470164773455, 4264.893377665521, 4353.542877997828, 4367.06108186735, 4476.462824461086, 4485.394471746273, 4606.95393046072, 4633.4208223972, 4639.188142075123, 4646.070785842845, 4654.86035418938, 4897.902041959141, 4916.0905232532095, 4917.926231106608, 4924.7537623119415, 4956.207006878882, 4961.801527938842, 5080.1363768160245, 5087.618428617794, 5157.484251574812, 5211.218317252443, 4906.803727850846, 4920.5571498565305, 4937.23472861707, 4938.827141050046, 4981.103401387785, 4754.096721622881, 5171.63798534099, 5179.326687530597, 5186.948130518797, 5187.533122019036, 5029.145045342374, 5074.492550744896, 5099.77051032697, 5120.155174396183, 5158.716270605153, 4992.450830408725, 5005.924911126263, 5011.473795251446, 5033.0, 5040.722760248075, 4748.192807222849, 4817.27740838877, 5036.143855544639, 5042.520960508746, 5045.344105266292, 4776.402949631296, 4814.6870453420415, 4850.684705494132, 4904.019196160711, 4923.433805112315, 5059.114654935298, 5122.795088196431, 5124.461931497139, 5128.589712822891, 5132.8460146195675, 4758.500357462555, 4765.76171191446, 4913.0, 4991.401031876198, 5019.247112933089], "unit": "ms", "name": "dojo.html", "value": 4716.178241325625}, {"lowerIsBetter": false, "replicates": [550.08685581934, 551.7743331497365, 565.3018522125172, 587.2043381218448, 597.0119452306433, 34852.65147348526, 35619.64380356196, 35645.465318020215, 35926.281474370495, 35934.46098308527, 38322.23355532888, 38716.0, 38747.22505549887, 38820.0, 38851.02872428191, 7713.614319284027, 7887.171846956073, 7910.683572657087, 7974.800629984239, 8058.597070146469, 7716.305532502074, 7829.9821023266895, 7881.290683838453, 7887.290143887049, 7893.802654933644, 7745.0, 7790.571518566477, 7799.5320280783335, 7818.530888146701, 7856.057273127232, 7801.4929029612895, 7886.014248219001, 7900.525968441883, 7916.247956444128, 7947.205279472064, 7805.9609701951695, 7874.763757087297, 7909.802254943615, 7954.721584744506, 7955.681772729084, 36447.4532882007, 36726.26547469063, 36752.081197969994, 36847.0, 36885.81557092224, 2800.4819108465, 2852.5721141828685, 2855.0461626949905, 3181.3319202967173, 3422.4866270059442, 27227.727722722717, 27682.723172768216, 28152.155435336972, 28168.718312816814, 28338.29154271139, 3376.0547046826928, 3484.407650699387, 3486.7059385448206, 3530.505729197914, 3540.451230059345, 193114.0, 194314.0, 194539.0, 195061.0, 198048.0, 48321.75839120782, 49393.50606493961, 50030.49969500331, 51337.0, 52886.0, 46844.7657761709, 47219.29171062437, 47502.287465688045, 47535.286970695466, 47644.0, 11615.245009074382, 11930.582429614922, 11933.28400295985, 12085.697857553632, 12121.757564848655, 8791.0, 8902.465852048897, 8982.0, 8987.46075235488, 9027.548622568846, 17200.31198752061, 17438.215280312415, 18570.071496425124, 18627.90686046561, 18640.254389824255, 7316.707331706779, 7460.813479663052, 7512.586807725627, 7523.0, 7626.237376262329, 807.7980504873782, 809.9919000810035, 810.4974915552395, 943.8772959515219, 971.7424882406168, 25541.23376298714, 25890.87054564715, 26375.472490550466, 27343.86328068347, 28308.150755477367, 891.3003292415423, 901.6123067081218, 921.7972046149837, 935.1256575102301, 1045.4406892312577, 11319.151063670257, 13852.515161969282, 14640.0, 14716.705665886837, 14934.70130597382, 247002.0, 251314.0, 254356.0, 255683.0, 256005.0, 44825.10349793051, 45303.093938121056, 45669.314960275624, 45828.0, 45859.54140458619, 1191.880811918801, 1195.635331223985, 1208.510553225945, 1221.3465795799382, 1222.5048855213652, 26125.477490450463, 26530.602040969014, 26672.0, 26685.86657066702, 26775.0, 39171.80414097911, 39631.60368396394, 39675.80162099171, 39701.80894573052, 39875.40186897141, 242847.0, 246211.0, 246296.0, 247653.0, 250896.0, 26903.596446053718, 27300.044498442458, 28117.156485305473, 28139.296517587223, 28424.431511369243, 33202.16994575155, 33208.1697957553, 33394.66421343119, 34026.489602655485, 34154.14614634654, 28689.85655071711, 29318.387488688328, 29403.852980735814, 29522.409551809273, 29984.700152999063, 28355.716442836132, 28709.0, 29003.27491812637, 29063.27341816387, 31298.843505782326, 29183.708162918098, 29291.41417171687, 29487.410251795274, 29531.55702664505, 29599.85200073986, 27548.724512755416, 28118.71881281161, 29668.322003436377, 32182.356352872343, 32325.676743232267, 22498.437539061655, 22528.549429011655, 22954.770452295263, 23023.424414389774, 23028.539429211658], "unit": "ms", "name": "ext.html", "value": 16139.320762155514}, {"lowerIsBetter": false, "replicates": [330.1762103551639, 336.4012058535806, 336.8703049326009, 338.2119661189429, 344.13106905064706, 14632.34154463049, 14987.72604328632, 15440.150791706452, 15851.3659453622, 16418.753718694228, 15068.32192551335, 15105.697886042273, 15361.0, 15407.38370465183, 15422.228888555555, 4597.88505287368, 5021.1213037718435, 5025.698458092508, 5027.622928280375, 5036.068327359432, 5086.949130508685, 5128.53843154116, 5128.53843154116, 5130.410002849682, 5139.537441630253, 4948.628852836052, 5082.161443361841, 5086.440491545927, 5267.631265811395, 5281.735913204344, 5169.302144210558, 5218.165093585008, 5262.736863156846, 5274.103402421579, 5288.788448462057, 5005.299258103868, 5090.9745451272875, 5104.821331253388, 5126.487351264881, 5134.717590532557, 11146.275492092987, 11166.106711463064, 11213.831792523119, 11419.771604567863, 11513.942430287794, 1658.1046235033068, 1744.3022790883622, 1781.8218178182208, 1850.722391641251, 1901.4580844459263, 8650.697225597074, 8702.086280940473, 8872.689455869078, 8914.42056266347, 9015.233705135071, 1632.183908045977, 1758.5339884930504, 1773.3172728499492, 1780.5815633326158, 1790.7582476365653, 54477.0, 57106.71446642782, 57118.0, 57190.428095718926, 57458.425415745725, 9951.651692190739, 10005.49972501372, 10017.198624110053, 10091.747706307255, 10110.545025473872, 12458.252504849737, 12475.376231188404, 12480.251184928933, 12490.625281241577, 12503.374831258401, 6685.966570167216, 6694.899576506356, 6717.261101278856, 6759.797206083826, 6760.290169532227, 6158.445739883342, 6211.130441738161, 6230.345813689588, 6246.843828904313, 6254.2807577129215, 4100.138970816102, 4192.45498085247, 4252.553481884358, 4258.701890867672, 4272.807723652443, 1718.561766749471, 1769.389855231733, 1779.350537053966, 1788.7764029496313, 1817.7000794868964, 392.7074329624448, 396.56774116212887, 399.39890464850214, 813.2436833744556, 874.4054043250651, 9560.521973901277, 10127.82202856257, 10201.591936322464, 10245.334053286513, 10352.948235258926, 397.2095529895545, 398.79262783352493, 401.5302096547047, 419.9538050814408, 424.7960978730165, 9036.0, 9402.15380615748, 9440.763980900396, 9443.527823608792, 9650.90349096514, 480303.5908922738, 484081.0, 499543.0, 501381.0, 517000.0, 73652.26347736454, 74128.25871741322, 74447.62776186084, 74686.62656686791, 75665.62167189129, 1047.518141654832, 1060.867391576053, 1080.1466841195524, 1087.0868470484672, 1094.4473041114186, 13821.308934553434, 14271.857281427052, 14288.214148221947, 14418.351174197396, 14476.131432114107, 32669.34661306713, 33891.4916276261, 34134.829325853214, 34283.828580856934, 35648.287034258654, 42141.57858421376, 42623.0, 42832.14335713206, 43756.34365484457, 44373.0, 8374.832503349777, 8775.692850750193, 8829.16122968317, 9025.05236950137, 9032.187103160748, 9744.75638109053, 9764.316497845082, 9765.804683906425, 9907.108360247612, 12008.939955300168, 8593.226609605166, 13347.265900375573, 13382.464701412224, 13696.65758356049, 13732.794008089686, 8667.869981950402, 8765.123487651184, 8900.643974240958, 8978.41640293405, 9014.819703606023, 8811.118888111137, 8921.776955576162, 9158.771030724285, 9212.078792120734, 9214.677486287948, 12829.61511154667, 12966.286854223108, 13687.11033782801, 13728.313584320944, 13919.373628186959, 14289.857101429268, 14482.565523034325, 14550.272486375427, 14596.12423254608, 14643.0], "unit": "ms", "name": "jquery.html", "value": 7645.398563627449}, {"lowerIsBetter": false, "replicates": [1347.885429738472, 1377.2769296119536, 1385.681293302541, 1621.197507233919, 1701.4980580728688, 6901.585904845707, 7060.505764596481, 7071.6817743201555, 7091.929080709191, 7183.0, 7189.352958233758, 7275.672594733236, 7317.56094634321, 7332.486725929187, 7345.66944487498, 2081.5836832633495, 2119.79861913118, 2120.872747635139, 2123.4691327168207, 2124.713163722901, 2115.375964090589, 2124.1928067334393, 2132.7014218009413, 2164.0694501364405, 2168.913243470259, 1734.7831521059868, 1766.5671910381975, 2068.048697599106, 2087.060822629815, 2090.341542414135, 2079.6048750737314, 2087.4155236533793, 2088.0, 2088.8433367497346, 2092.016752126498, 2060.464279287381, 2086.6557018092, 2144.0566150893715, 2156.1914282144194, 2156.8921553922396, 6964.059851919977, 7067.4346052316205, 7093.92906070943, 7096.6451677416435, 7146.857062858714, 4231.682623803227, 4320.071184695305, 4320.978395108004, 4331.9783401083105, 4345.565443455661, 2802.3134332088566, 2826.434713057397, 2855.300451389402, 2867.211516832867, 2868.6270784797844, 875.0374587953264, 884.8628462588244, 886.3131073418089, 912.2975309012023, 920.2729843423688, 9005.459672419676, 9238.122378374044, 9417.293702972305, 9470.100340467714, 9540.093691099335, 3821.8280177392085, 3864.1305706215876, 3873.573906870242, 3912.374020156761, 3962.5244970603135, 7720.845583088307, 7721.227877212234, 7727.806804829925, 7747.38020958322, 7845.803854903673, 4103.179364127186, 4159.625633692982, 4161.0845613964875, 4172.812223449952, 4181.121964387513, 3783.2622638585212, 3785.716071294664, 3800.1829606634706, 3801.0877389426337, 3802.524684414448, 2907.069737683963, 2979.1658335666048, 2984.9552256715733, 2998.385331007138, 3016.457037733185, 902.5081330674798, 905.4386280505996, 908.4912449028565, 911.193593669594, 915.4757329047195, 734.7391675955066, 766.7853001159684, 802.9598520073973, 814.226484839405, 907.2832462354797, 6496.220453545605, 6866.279040700754, 7002.054722612484, 7004.684789184499, 7031.789046328516, 1048.7063622185647, 1065.477915821242, 1073.8603981482356, 1079.0773888325525, 1080.864891888514, 5222.086134926372, 5263.473652634706, 5266.131088370376, 5268.683878967274, 5303.231031500411, 8056.234657707509, 8149.674013039531, 8230.09468958414, 8315.501069935823, 8358.122397148212, 8101.837963240702, 8237.876431853527, 8242.557552428301, 8298.04572474161, 8308.626111824982, 6352.6823658816875, 6411.326810684905, 6475.546711730228, 6499.317571655003, 6519.413252807175, 6128.908066378919, 6137.048757442603, 6166.660833654013, 6178.0, 6191.226096737908, 7361.447891408273, 7374.926250737424, 7380.520266182681, 7549.773506794805, 7557.319841214317, 7499.475036747375, 7679.424043196895, 7691.57696326685, 7698.961505192438, 7709.151993280847, 5934.851628709144, 5956.076808094752, 5968.582199246185, 5991.700414979146, 6067.908981365372, 6420.518461115342, 6443.194600674916, 6459.192600924885, 6508.381703738138, 6518.794023105741, 5901.262342207224, 6122.571420000735, 6221.09794079865, 6348.079528468254, 6361.173047503795, 5010.248462730474, 5043.293938848491, 6115.724792384264, 6164.815055548341, 6177.258728952374, 6251.843703907439, 6303.684815759286, 6318.147050148355, 6332.493400527855, 6365.331640177715, 5883.55873309512, 5885.264341957255, 5907.143464197753, 5908.675022873783, 5914.615549989237, 5961.135635332939, 6077.392260773887, 6098.908516372169, 6100.511959043355, 6115.357887421935], "unit": "ms", "name": "mootools.html", "value": 3985.272697705405}, {"lowerIsBetter": false, "replicates": [305.30695321619925, 312.10892900768306, 312.6420248815108, 316.114878340646, 316.31991218879415, 5438.8912221755545, 5601.6358936669085, 5623.80316688916, 5634.0703783875615, 5636.577256705753, 5510.283663123799, 5570.777168913239, 5574.470425309589, 5582.637128586649, 5604.495595396414, 4172.895677608069, 4330.090680957002, 4333.371661109138, 4336.262835317995, 4336.804843782022, 4289.313709806432, 4302.20409224293, 4322.848700295474, 4335.046289816235, 4337.024169561839, 4282.721623094489, 4288.0, 4290.4636920384955, 4292.441982542281, 4293.656507479394, 4275.978620106911, 4284.828606855722, 4293.957060429387, 4294.312909934395, 4299.989502466933, 3480.5301284326547, 3662.176010397666, 3680.1719613087107, 3701.907452313687, 3726.1988672435555, 5228.660137091077, 5369.597280203961, 5372.7313634318125, 5384.9230153969365, 5393.78424863005, 4893.73084480357, 4918.581920536759, 4933.260010998343, 4948.134076536628, 4951.900961980777, 5884.352721200665, 5884.7940322088525, 5886.852828679274, 5888.969430349672, 5898.144769008512, 3921.2549615573234, 4042.312806822847, 4044.5955404459614, 4046.7369620974837, 4057.3102572562734, 6152.723127459275, 6248.218972628421, 6254.46837018854, 6261.154744109578, 6262.718177682015, 4127.938080928729, 4129.0, 4137.1518838638, 4143.08852052548, 4188.643965262987, 4190.0, 4195.895102622398, 4199.895002624898, 4202.579742025834, 4209.810558524874, 4628.83799067031, 4764.30917516965, 4838.879028024257, 4841.225403935424, 4843.975780121077, 5840.474357307863, 5863.648181109062, 5912.142739302777, 5916.615419997686, 5935.436133567304, 1480.3560451203546, 1501.2418728542016, 1504.4132788212605, 1504.9924750376397, 1509.124707669549, 992.161623428202, 996.7358649957768, 996.8654231678776, 1005.5927349423495, 1009.0615727373466, 4997.575206107449, 5042.899142017139, 5044.066847633199, 5073.061483625541, 5109.9744501278, 6140.508759299245, 6140.723667434976, 6143.600665956698, 6152.600080994721, 6164.075388691643, 5019.071471777733, 5072.6195535335, 5081.364829396325, 5086.16078347076, 5092.26162206478, 3215.5015972524297, 3256.886008989721, 3294.4893541501106, 3314.0886256279714, 3325.48454989477, 5794.333651630032, 5795.623284486495, 5801.7099145042575, 5808.912866307009, 5812.94187058124, 6375.362463753588, 6411.583247089017, 6414.166158399472, 6436.066770318278, 6455.903161452582, 5617.354004289559, 5759.65442073477, 5799.362070172193, 5803.158542011469, 5812.244408226988, 6103.694815259308, 6116.541259405473, 6139.631622102688, 6200.286966998853, 6203.906941395792, 6033.939660603338, 6039.63762174271, 6041.909371359346, 6041.939580604314, 6042.667653279112, 5679.801206957736, 5704.486596206361, 5724.0, 5725.7137143141845, 5782.5373970081455, 3978.7214894957074, 4099.1801639672785, 4119.237940980928, 4136.358864376027, 4148.792560371909, 5824.301083869963, 5974.581779275409, 6062.0, 6073.848153796191, 6075.058365953284, 5687.20379146928, 5871.588988770745, 5936.961031819328, 5939.821805345847, 5941.821745347646, 5906.173135761082, 5921.526277897844, 5922.555808314308, 5922.7334769936315, 5923.911141332797, 5681.573881958952, 5771.7114144293455, 5780.8554786129, 5789.8552536186935, 5803.47768700819, 5960.672163031075, 5976.223090998143, 5989.101634754822, 5997.5501837363245, 6014.909776353271, 5725.51333136688, 5755.913661295168, 5759.280089988752, 5760.423957604206, 5842.707864606838], "unit": "ms", "name": "prototype.html", "value": 4394.985455863447}, {"lowerIsBetter": false, "replicates": [762.1654288554033, 774.8721460958942, 783.7178615698348, 785.1951749456806, 797.5852556670535, 10691.78616427672, 10896.618618348359, 10922.0, 10927.945360273208, 10969.0, 13389.330533473336, 13614.591562253123, 13640.181589104635, 13657.726845463085, 13664.521741739041, 808.6118663041743, 810.4853418079532, 810.8297257575916, 812.354178428151, 825.6779855856221, 635.2853040329629, 644.0243031806816, 800.2677550041705, 801.0787594266582, 808.6886548678742, 849.2950850793857, 852.0, 856.2379482260793, 857.6140736668493, 861.4400639584289, 849.0, 855.2003876375546, 856.1609622569886, 859.5959898847532, 863.1756672377895, 631.9684015799191, 633.1041576169714, 633.7845132654919, 635.9523035772336, 636.0681601453892, 10892.782144357148, 10998.450077496092, 11037.392943388111, 11050.668479945614, 11054.778904421866, 10588.523516441779, 10988.560457581687, 11156.888431115665, 11313.321200727984, 11808.586699465477, 8787.0773568775, 8840.8673869892, 8979.865302020475, 8995.100489951017, 9279.350445468819, 3208.9197770055935, 3258.837058147083, 3267.0, 3268.8038717677014, 3270.1824543864036, 37813.62186378156, 37901.43147852757, 38156.0, 38267.0, 38494.230115397535, 9209.539523023823, 9340.532973351304, 9372.734680818003, 9486.905130948602, 9728.367656102331, 16531.91734041322, 16563.42028029013, 16571.0, 16680.666386672197, 16702.58243543897, 6375.266844312963, 6385.680715964276, 6500.154979852589, 6571.0471981562405, 6582.473402127818, 3370.679785420381, 3429.091290807888, 3463.341965026637, 3524.1894364296354, 3542.6103128655827, 2580.148550978173, 2613.2160351894354, 2617.2148355493277, 2617.4895895300233, 2618.646482724808, 477.8064883722098, 482.2091769498026, 483.8620993016973, 483.9298301746227, 488.8044782087122, 439.2444994609267, 485.6794515619674, 518.1217835768336, 559.0482253700468, 568.4741614007027, 7103.467239957024, 7480.401567874557, 8108.918910810817, 8313.792155196168, 8339.54132522705, 450.2008934141924, 455.0693831115377, 475.6670330768476, 550.9531689806412, 600.9128676341905, 3262.885798997024, 3359.277755282626, 3409.9659003409647, 3415.9146021349666, 3506.982465087658, 46760.2985955211, 47014.0, 47325.0, 47522.762386187846, 47633.523664763605, 42711.3935687589, 42760.57239427628, 43153.78423107927, 43489.34765978449, 43657.34513982293, 40222.0, 40644.39033414501, 40699.0, 40819.795901020305, 41386.58613413887, 6686.13080299558, 6804.319568043156, 6930.480213984072, 7636.08366995964, 7811.960940195263, 30384.392312154076, 30650.0, 30726.0, 30830.53754193644, 30880.0, 34399.14002149966, 35251.64748352586, 35918.640813591526, 38691.0, 38950.220995580494, 9229.676961306322, 9237.630494780133, 9440.527973601429, 9874.901250987397, 9941.155001824925, 11022.724431889266, 11126.443677815914, 11145.996860282614, 11163.106951444028, 11451.885481145415, 10312.896871031193, 10383.636572720221, 10389.168866490512, 10393.740156496147, 10400.063994240554, 10511.78976420452, 10644.520996555018, 10742.24804263694, 10746.83879741789, 10761.515731792244, 10302.639407620996, 10350.585976560853, 10432.165426765992, 10474.371537707762, 10491.475426228506, 9096.77258068527, 9503.0, 9599.520023998912, 9672.177864881563, 9846.015398460097, 8799.736007919773, 9138.862917056116, 9220.124088211609, 9224.446533208029, 9226.123518265755], "unit": "ms", "name": "yui.html", "value": 5621.567411567082}], "name": "dromaeo_css", "value": 6209.142281068482}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 109.0, 114.0, 114.0, 113.0, 125.0, 114.0, 115.0, 114.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 114.8}, {"lowerIsBetter": true, "replicates": [168.0, 130.0, 160.0, 162.0, 129.0, 151.0, 158.0, 138.0, 172.0, 132.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.0}, {"lowerIsBetter": true, "replicates": [173.0, 161.0, 162.0, 161.0, 162.0, 166.0, 164.0, 162.0, 162.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 163.6}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 73.0, 72.0, 147.0, 71.0, 77.0, 73.0, 74.0, 152.0], "unit": "ms", "name": "audio-fft", "value": 88.4}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 137.0, 95.0, 95.0, 94.0, 131.0, 94.0, 94.0, 129.0], "unit": "ms", "name": "audio-oscillator", "value": 105.8}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 112.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 147.0, 147.0, 148.0, 148.0, 147.0, 148.0, 148.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.7}, {"lowerIsBetter": true, "replicates": [98.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 72.0, 72.0, 73.0, 73.0, 72.0, 83.0, 72.0, 71.0], "unit": "ms", "name": "json-parse-financial", "value": 73.2}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 84.0, 85.0, 85.0, 85.0, 86.0, 86.0, 93.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.8}, {"lowerIsBetter": true, "replicates": [127.0, 130.0, 121.0, 124.0, 131.0, 130.0, 125.0, 127.0, 120.0, 127.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.2}, {"lowerIsBetter": true, "replicates": [141.0, 160.0, 154.0, 150.0, 149.0, 138.0, 153.0, 149.0, 148.0, 138.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 148.0}, {"lowerIsBetter": true, "replicates": [71.0, 69.0, 72.0, 74.0, 72.0, 69.0, 71.0, 70.0, 69.0, 72.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.9}], "name": "kraken", "value": 1548.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.44809109176154], "unit": "score", "name": "Richards", "value": 210.82354399999997}, {"lowerIsBetter": false, "replicates": [183.5199119104423], "unit": "score", "name": "DeltaBlue", "value": 360.27698199999986}, {"lowerIsBetter": false, "replicates": [278.6291446085261], "unit": "score", "name": "Encrypt", "value": 955.3236090000001}, {"lowerIsBetter": false, "replicates": [5154.639175257732], "unit": "score", "name": "Decrypt", "value": 51.63911399999997}, {"lowerIsBetter": false, "replicates": [1101.3215859030836], "unit": "score", "name": "RayTrace", "value": 671.910012}, {"lowerIsBetter": false, "replicates": [706.9209039548023], "unit": "score", "name": "Earley", "value": 942.7688391608393}, {"lowerIsBetter": false, "replicates": [12120.481927710844], "unit": "score", "name": "Boyer", "value": 54.9865099403579}, {"lowerIsBetter": false, "replicates": [26128.20512820513], "unit": "score", "name": "RegExp", "value": 34.86596172718352}, {"lowerIsBetter": false, "replicates": [591.7159763313609], "unit": "score", "name": "Splay", "value": 137.71979000000002}, {"lowerIsBetter": false, "replicates": [4859.223300970873], "unit": "score", "name": "NavierStokes", "value": 305.39860139860156}], "name": "v8_7", "value": 21377.027201630346}]} 23:01:04 INFO - RETURN: dromaeo_css: 6209.14 23:01:04 INFO - RETURN: kraken: 1548.80 23:01:04 INFO - RETURN: v8_7: 21377.03 23:01:04 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "21377.03"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1548.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6209.14"}}} 23:01:04 INFO - Return code: 0 23:01:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:01:04 INFO - # TBPL SUCCESS # 23:01:04 INFO - Running post-action listener: _resource_record_post_action 23:01:04 INFO - Running post-run listener: _resource_record_post_run 23:01:06 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 10698752; Write bytes: 481558528; Read time: 4120; Write time: 546856 23:01:06 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 4096; Write bytes: 81526784; Read time: 276; Write time: 110792 23:01:06 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 8957952; Write bytes: 399671296; Read time: 3796; Write time: 436036 23:01:06 INFO - Running post-run listener: _upload_blobber_files 23:01:06 INFO - Blob upload gear active. 23:01:06 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 23:01:06 INFO - Copying logs to upload dir... 23:01:06 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1287.285916 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2015-12-11 23:01:06.067655) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-11 23:01:06.071388) ========= 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=7d909545e45784438f4e8e36000001b3-1449899851.818762-2064488871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/OaIiKuxuQG-t9e8TfQKtfw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009922 build_url: 'https://queue.taskcluster.net/v1/task/OaIiKuxuQG-t9e8TfQKtfw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-11 23:01:06.122155) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 23:01:06.122471) ========= 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=7d909545e45784438f4e8e36000001b3-1449899851.818762-2064488871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 23:01:06.172298) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-11 23:01:06.172887) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-11 23:01:06.173328) ========= ========= Total master_lag: 0.21 =========