builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-022 starttime: 1450276833.26 results: success (0) buildid: 20151216054508 builduid: f1d77a968d4b45a884af46baeb892745 revision: a42ef45dc7217345fbc67d43d74399c8c679e9b2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 06:40:33.259537) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 06:40:33.259971) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 06:40:33.260254) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1450276363.192137-1622430701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006317 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 06:40:33.289719) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 06:40:33.290013) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 06:40:33.310197) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 06:40:33.310480) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1450276363.192137-1622430701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004545 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 06:40:33.359790) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 06:40:33.360203) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 06:40:33.361066) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 06:40:33.361700) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1450276363.192137-1622430701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-16 06:40:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2015-12-16 06:40:33 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.187386 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 06:40:33.574405) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 06:40:33.574720) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1450276363.192137-1622430701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015537 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 06:40:33.636318) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-12-16 06:40:33.636623) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a42ef45dc7217345fbc67d43d74399c8c679e9b2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev a42ef45dc7217345fbc67d43d74399c8c679e9b2 --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=b47e8c1238be48f5acbf8f2f000001bb-1450276363.192137-1622430701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-16 06:40:33,694 truncating revision to first 12 chars 2015-12-16 06:40:33,694 Setting DEBUG logging. 2015-12-16 06:40:33,694 attempt 1/10 2015-12-16 06:40:33,694 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a42ef45dc721?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-16 06:40:36,212 unpacking tar archive at: fx-team-a42ef45dc721/testing/mozharness/ program finished with exit code 0 elapsedTime=2.795792 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-12-16 06:40:36.450415) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 06:40:36.450729) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 06:40:36.459196) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 06:40:36.459573) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 06:40:36.460022) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-16 06:40:36.460316) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b47e8c1238be48f5acbf8f2f000001bb-1450276363.192137-1622430701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:40:36 INFO - MultiFileLogger online at 20151216 06:40:36 in /builds/slave/test 06:40:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 06:40:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:40:36 INFO - {'append_to_log': False, 06:40:36 INFO - 'base_work_dir': '/builds/slave/test', 06:40:36 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:40:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:40:36 INFO - 'branch': 'Fx-Team-Non-PGO', 06:40:36 INFO - 'buildbot_json_path': 'buildprops.json', 06:40:36 INFO - 'config_files': ('talos/linux_config.py',), 06:40:36 INFO - 'default_actions': ('clobber', 06:40:36 INFO - 'read-buildbot-config', 06:40:36 INFO - 'download-and-extract', 06:40:36 INFO - 'populate-webroot', 06:40:36 INFO - 'create-virtualenv', 06:40:36 INFO - 'install', 06:40:36 INFO - 'run-tests'), 06:40:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:40:36 INFO - 'download_minidump_stackwalk': True, 06:40:36 INFO - 'download_symbols': 'ondemand', 06:40:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:40:36 INFO - 'tooltool.py': '/tools/tooltool.py', 06:40:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:40:36 INFO - '/tools/misc-python/virtualenv.py')}, 06:40:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:40:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:40:36 INFO - 'installer_path': 'installer.exe', 06:40:36 INFO - 'log_level': 'info', 06:40:36 INFO - 'log_name': 'talos', 06:40:36 INFO - 'log_to_console': True, 06:40:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:40:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:40:36 INFO - 'opt_config_files': (), 06:40:36 INFO - 'pip_index': False, 06:40:36 INFO - 'sps_profile': False, 06:40:36 INFO - 'sps_profile_interval': 0, 06:40:36 INFO - 'suite': 'dromaeojs-e10s', 06:40:36 INFO - 'system_bits': '64', 06:40:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:40:36 INFO - 'title': 'talos-linux64-ix-022', 06:40:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:40:36 INFO - 'use_talos_json': True, 06:40:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:40:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:40:36 INFO - 'work_dir': 'build'} 06:40:36 INFO - ##### 06:40:36 INFO - ##### Running clobber step. 06:40:36 INFO - ##### 06:40:36 INFO - Running pre-action listener: _resource_record_pre_action 06:40:36 INFO - Running main action method: clobber 06:40:36 INFO - rmtree: /builds/slave/test/build 06:40:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:40:37 INFO - Running post-action listener: _resource_record_post_action 06:40:37 INFO - ##### 06:40:37 INFO - ##### Running read-buildbot-config step. 06:40:37 INFO - ##### 06:40:37 INFO - Running pre-action listener: _resource_record_pre_action 06:40:37 INFO - Running main action method: read_buildbot_config 06:40:37 INFO - Using buildbot properties: 06:40:37 INFO - { 06:40:37 INFO - "properties": { 06:40:37 INFO - "buildnumber": 587, 06:40:37 INFO - "product": "firefox", 06:40:37 INFO - "script_repo_revision": "production", 06:40:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 06:40:37 INFO - "repository": "", 06:40:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 06:40:37 INFO - "buildid": "20151216054508", 06:40:37 INFO - "slavename": "talos-linux64-ix-022", 06:40:37 INFO - "pgo_build": "False", 06:40:37 INFO - "basedir": "/builds/slave/test", 06:40:37 INFO - "project": "", 06:40:37 INFO - "platform": "ubuntu64_hw", 06:40:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:40:37 INFO - "slavebuilddir": "test", 06:40:37 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:40:37 INFO - "branch": "fx-team", 06:40:37 INFO - "repo_path": "integration/fx-team", 06:40:37 INFO - "stage_platform": "linux64", 06:40:37 INFO - "builduid": "f1d77a968d4b45a884af46baeb892745", 06:40:37 INFO - "revision": "a42ef45dc7217345fbc67d43d74399c8c679e9b2" 06:40:37 INFO - }, 06:40:37 INFO - "sourcestamp": { 06:40:37 INFO - "repository": "", 06:40:37 INFO - "hasPatch": false, 06:40:37 INFO - "project": "", 06:40:37 INFO - "branch": "fx-team-linux64-talos", 06:40:37 INFO - "changes": [ 06:40:37 INFO - { 06:40:37 INFO - "category": null, 06:40:37 INFO - "files": [ 06:40:37 INFO - { 06:40:37 INFO - "url": null, 06:40:37 INFO - "name": "https://queue.taskcluster.net/v1/task/14DTxexDSSmMU-eFukCKuA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 06:40:37 INFO - } 06:40:37 INFO - ], 06:40:37 INFO - "repository": "", 06:40:37 INFO - "rev": "a42ef45dc7217345fbc67d43d74399c8c679e9b2", 06:40:37 INFO - "who": "cbook@mozilla.com", 06:40:37 INFO - "when": 1450276798, 06:40:37 INFO - "number": 7366346, 06:40:37 INFO - "comments": "Backed out changeset 7a5367ac58a4 (bug 1209344) for various test failures\n\n\nG: changed toolkit/mozapps/extensions/test/xpcshell/xpcshell-shared.ini", 06:40:37 INFO - "project": "", 06:40:37 INFO - "at": "Wed 16 Dec 2015 06:39:58", 06:40:37 INFO - "branch": "fx-team-linux64-talos", 06:40:37 INFO - "revlink": "", 06:40:37 INFO - "properties": [ 06:40:37 INFO - [ 06:40:37 INFO - "buildid", 06:40:37 INFO - "20151216054508", 06:40:37 INFO - "Change" 06:40:37 INFO - ], 06:40:37 INFO - [ 06:40:37 INFO - "builduid", 06:40:37 INFO - "f1d77a968d4b45a884af46baeb892745", 06:40:37 INFO - "Change" 06:40:37 INFO - ], 06:40:37 INFO - [ 06:40:37 INFO - "pgo_build", 06:40:37 INFO - "False", 06:40:37 INFO - "Change" 06:40:37 INFO - ] 06:40:37 INFO - ], 06:40:37 INFO - "revision": "a42ef45dc7217345fbc67d43d74399c8c679e9b2" 06:40:37 INFO - } 06:40:37 INFO - ], 06:40:37 INFO - "revision": "a42ef45dc7217345fbc67d43d74399c8c679e9b2" 06:40:37 INFO - } 06:40:37 INFO - } 06:40:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/14DTxexDSSmMU-eFukCKuA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 06:40:37 INFO - Running post-action listener: _resource_record_post_action 06:40:37 INFO - ##### 06:40:37 INFO - ##### Running download-and-extract step. 06:40:37 INFO - ##### 06:40:37 INFO - Running pre-action listener: _resource_record_pre_action 06:40:37 INFO - Running main action method: download_and_extract 06:40:37 INFO - mkdir: /builds/slave/test/build/tests 06:40:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:37 INFO - https://queue.taskcluster.net/v1/task/14DTxexDSSmMU-eFukCKuA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:40:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/14DTxexDSSmMU-eFukCKuA/artifacts/public/build/test_packages.json 06:40:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/14DTxexDSSmMU-eFukCKuA/artifacts/public/build/test_packages.json 06:40:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/14DTxexDSSmMU-eFukCKuA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 06:40:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/14DTxexDSSmMU-eFukCKuA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 06:40:39 INFO - Downloaded 1302 bytes. 06:40:39 INFO - Reading from file /builds/slave/test/build/test_packages.json 06:40:39 INFO - Using the following test package requirements: 06:40:39 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:40:39 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:40:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:40:39 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:40:39 INFO - u'jsshell-linux-x86_64.zip'], 06:40:39 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:40:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:40:39 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:40:39 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:40:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:40:39 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:40:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:40:39 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:40:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:40:39 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:40:39 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:40:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:40:39 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:40:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:39 INFO - https://queue.taskcluster.net/v1/task/14DTxexDSSmMU-eFukCKuA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:40:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/14DTxexDSSmMU-eFukCKuA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:40:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/14DTxexDSSmMU-eFukCKuA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:40:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/14DTxexDSSmMU-eFukCKuA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:40:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/14DTxexDSSmMU-eFukCKuA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:40:40 INFO - Downloaded 21869080 bytes. 06:40:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 06:40:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:40:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 06:40:41 INFO - Return code: 0 06:40:41 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:40:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:41 INFO - https://queue.taskcluster.net/v1/task/14DTxexDSSmMU-eFukCKuA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:40:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/14DTxexDSSmMU-eFukCKuA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:40:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/14DTxexDSSmMU-eFukCKuA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:40:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/14DTxexDSSmMU-eFukCKuA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:40:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/14DTxexDSSmMU-eFukCKuA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:40:43 INFO - Downloaded 21869080 bytes. 06:40:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 06:40:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:40:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 06:40:44 INFO - Return code: 0 06: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')]} 06:40:44 INFO - https://queue.taskcluster.net/v1/task/14DTxexDSSmMU-eFukCKuA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:40:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/14DTxexDSSmMU-eFukCKuA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:40:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/14DTxexDSSmMU-eFukCKuA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:40:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/14DTxexDSSmMU-eFukCKuA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:40:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/14DTxexDSSmMU-eFukCKuA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:40:45 INFO - Downloaded 11132052 bytes. 06:40:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 06:40:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:40:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 06:40:45 INFO - Return code: 0 06:40:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:45 INFO - https://queue.taskcluster.net/v1/task/14DTxexDSSmMU-eFukCKuA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:40:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/14DTxexDSSmMU-eFukCKuA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:40:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/14DTxexDSSmMU-eFukCKuA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:40:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/14DTxexDSSmMU-eFukCKuA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:40:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/14DTxexDSSmMU-eFukCKuA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:40:48 INFO - Downloaded 57748425 bytes. 06:40:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/14DTxexDSSmMU-eFukCKuA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:40:48 INFO - mkdir: /builds/slave/test/properties 06:40:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:40:48 INFO - Writing to file /builds/slave/test/properties/build_url 06:40:48 INFO - Contents: 06:40:48 INFO - build_url:https://queue.taskcluster.net/v1/task/14DTxexDSSmMU-eFukCKuA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:40:48 INFO - Running post-action listener: _resource_record_post_action 06:40:48 INFO - Running post-action listener: set_extra_try_arguments 06:40:48 INFO - ##### 06:40:48 INFO - ##### Running populate-webroot step. 06:40:48 INFO - ##### 06:40:48 INFO - Running pre-action listener: _resource_record_pre_action 06:40:48 INFO - Running main action method: populate_webroot 06:40:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:40:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:40:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:40:48 INFO - '--tppagecycles', 06:40:48 INFO - '7'], 06:40:48 INFO - 'tests': ['tsvgm']}}, 06:40:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:40:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:40:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:40:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:40:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:40:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:40:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:40:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:40:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:40:48 INFO - 'talos_options': ['--e10s'], 06:40:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:40:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:40:48 INFO - 'tests': ['damp', 'tps']}, 06:40:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:40:48 INFO - 'talos_options': ['--e10s'], 06:40:48 INFO - 'tests': ['damp', 'tps']}, 06:40:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:40:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:40:48 INFO - 'other': {'tests': ['a11yr', 06:40:48 INFO - 'ts_paint', 06:40:48 INFO - 'tpaint', 06:40:48 INFO - 'sessionrestore', 06:40:48 INFO - 'sessionrestore_no_auto_restore']}, 06:40:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:40:48 INFO - 'tests': ['a11yr', 06:40:48 INFO - 'ts_paint', 06:40:48 INFO - 'tpaint', 06:40:48 INFO - 'sessionrestore', 06:40:48 INFO - 'sessionrestore_no_auto_restore']}, 06:40:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:40:48 INFO - 'tests': ['a11yr', 06:40:48 INFO - 'ts_paint', 06:40:48 INFO - 'tpaint', 06:40:48 INFO - 'sessionrestore', 06:40:48 INFO - 'sessionrestore_no_auto_restore']}, 06:40:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:40:48 INFO - 'tests': ['a11yr', 06:40:48 INFO - 'ts_paint', 06:40:48 INFO - 'tpaint', 06:40:48 INFO - 'sessionrestore', 06:40:48 INFO - 'sessionrestore_no_auto_restore']}, 06:40:48 INFO - 'other_l64': {'tests': ['a11yr', 06:40:48 INFO - 'ts_paint', 06:40:48 INFO - 'tpaint', 06:40:48 INFO - 'sessionrestore', 06:40:48 INFO - 'sessionrestore_no_auto_restore']}, 06:40:48 INFO - 'other_nol64': {'tests': ['a11yr', 06:40:48 INFO - 'ts_paint', 06:40:48 INFO - 'tpaint', 06:40:48 INFO - 'sessionrestore', 06:40:48 INFO - 'sessionrestore_no_auto_restore']}, 06:40:48 INFO - 'svgr': {'tests': ['tsvgx', 06:40:48 INFO - 'tsvgr_opacity', 06:40:48 INFO - 'tart', 06:40:48 INFO - 'tscrollx', 06:40:48 INFO - 'cart']}, 06:40:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:40:48 INFO - 'tests': ['tsvgx', 06:40:48 INFO - 'tsvgr_opacity', 06:40:48 INFO - 'tart', 06:40:48 INFO - 'tscrollx', 06:40:48 INFO - 'cart']}, 06:40:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:40:48 INFO - 'tests': ['tp5o']}, 06:40:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:40:48 INFO - 'talos_options': ['--e10s'], 06:40:48 INFO - 'tests': ['tp5o']}, 06:40:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:40:48 INFO - 'talos_options': ['--xperf_path', 06:40:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:40:48 INFO - 'tests': ['tp5n']}, 06:40:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:40:48 INFO - 'talos_options': ['--e10s', 06:40:48 INFO - '--xperf_path', 06:40:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:40:48 INFO - 'tests': ['tp5n']}}, 06:40:48 INFO - 'talos.zip': {'path': '', 06:40:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:40:48 INFO - Running post-action listener: _resource_record_post_action 06:40:48 INFO - ##### 06:40:48 INFO - ##### Running create-virtualenv step. 06:40:48 INFO - ##### 06:40:48 INFO - Running pre-action listener: _resource_record_pre_action 06:40:48 INFO - Running main action method: create_virtualenv 06:40:48 INFO - Creating virtualenv /builds/slave/test/build/venv 06:40:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:40:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:40:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:40:48 INFO - Using real prefix '/usr' 06:40:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:40:49 INFO - Installing distribute.............................................................................................................................................................................................done. 06:40:51 INFO - Installing pip.................done. 06:40:51 INFO - Return code: 0 06:40:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:40:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f939fd27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180b0b0>, '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 0x180bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180c440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450276363.192137-1622430701', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:40:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:40:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:40:51 INFO - Using env: {'DISPLAY': ':0', 06:40:51 INFO - 'HOME': '/home/cltbld', 06:40:51 INFO - 'LANG': 'en_US.UTF-8', 06:40:51 INFO - 'LANGUAGE': 'en_US:en', 06:40:51 INFO - 'LOGNAME': 'cltbld', 06:40:51 INFO - 'MAIL': '/var/mail/cltbld', 06:40:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:51 INFO - 'MOZ_NO_REMOTE': '1', 06:40:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:51 INFO - 'NO_EM_RESTART': '1', 06:40:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:51 INFO - 'PWD': '/builds/slave/test', 06:40:51 INFO - 'SHELL': '/bin/bash', 06:40:51 INFO - 'SHLVL': '1', 06:40:51 INFO - 'TERM': 'linux', 06:40:51 INFO - 'TMOUT': '86400', 06:40:51 INFO - 'USER': 'cltbld', 06:40:51 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450276363.192137-1622430701', 06:40:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:51 INFO - '_': '/tools/buildbot/bin/python'} 06:40:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:40:51 INFO - Cleaning up... 06:40:51 INFO - Return code: 0 06:40:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:40:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f939fd27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180b0b0>, '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 0x180bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180c440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450276363.192137-1622430701', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:40:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 06:40:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:40:51 INFO - Using env: {'DISPLAY': ':0', 06:40:51 INFO - 'HOME': '/home/cltbld', 06:40:51 INFO - 'LANG': 'en_US.UTF-8', 06:40:51 INFO - 'LANGUAGE': 'en_US:en', 06:40:51 INFO - 'LOGNAME': 'cltbld', 06:40:51 INFO - 'MAIL': '/var/mail/cltbld', 06:40:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:51 INFO - 'MOZ_NO_REMOTE': '1', 06:40:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:51 INFO - 'NO_EM_RESTART': '1', 06:40:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:51 INFO - 'PWD': '/builds/slave/test', 06:40:51 INFO - 'SHELL': '/bin/bash', 06:40:51 INFO - 'SHLVL': '1', 06:40:51 INFO - 'TERM': 'linux', 06:40:51 INFO - 'TMOUT': '86400', 06:40:51 INFO - 'USER': 'cltbld', 06:40:51 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450276363.192137-1622430701', 06:40:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:51 INFO - '_': '/tools/buildbot/bin/python'} 06:40:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:51 INFO - Downloading/unpacking psutil>=0.7.1 06:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:40:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:40:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:40:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:40:53 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 06:40:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:40:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:40:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:40:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:40:53 INFO - Installing collected packages: psutil 06:40:53 INFO - Running setup.py install for psutil 06:40:53 INFO - building 'psutil._psutil_linux' extension 06:40:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:40:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:40:53 INFO - building 'psutil._psutil_posix' extension 06:40:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:40:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:40:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:40:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:40:53 INFO - Successfully installed psutil 06:40:53 INFO - Cleaning up... 06:40:54 INFO - Return code: 0 06:40:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:40:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:54 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 0x7f939fd27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180b0b0>, '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 0x180bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180c440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450276363.192137-1622430701', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:40:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:40:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:40:54 INFO - Using env: {'DISPLAY': ':0', 06:40:54 INFO - 'HOME': '/home/cltbld', 06:40:54 INFO - 'LANG': 'en_US.UTF-8', 06:40:54 INFO - 'LANGUAGE': 'en_US:en', 06:40:54 INFO - 'LOGNAME': 'cltbld', 06:40:54 INFO - 'MAIL': '/var/mail/cltbld', 06:40:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:54 INFO - 'MOZ_NO_REMOTE': '1', 06:40:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:54 INFO - 'NO_EM_RESTART': '1', 06:40:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:54 INFO - 'PWD': '/builds/slave/test', 06:40:54 INFO - 'SHELL': '/bin/bash', 06:40:54 INFO - 'SHLVL': '1', 06:40:54 INFO - 'TERM': 'linux', 06:40:54 INFO - 'TMOUT': '86400', 06:40:54 INFO - 'USER': 'cltbld', 06:40:54 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450276363.192137-1622430701', 06:40:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:54 INFO - '_': '/tools/buildbot/bin/python'} 06:40:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:40:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:40:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:40:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:40:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:40:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:40:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:40:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:40:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:40:55 INFO - Installing collected packages: mozsystemmonitor 06:40:55 INFO - Running setup.py install for mozsystemmonitor 06:40:56 INFO - Successfully installed mozsystemmonitor 06:40:56 INFO - Cleaning up... 06:40:56 INFO - Return code: 0 06:40:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:40:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:56 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 0x7f939fd27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180b0b0>, '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 0x180bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180c440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450276363.192137-1622430701', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:40:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:40:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:40:56 INFO - Using env: {'DISPLAY': ':0', 06:40:56 INFO - 'HOME': '/home/cltbld', 06:40:56 INFO - 'LANG': 'en_US.UTF-8', 06:40:56 INFO - 'LANGUAGE': 'en_US:en', 06:40:56 INFO - 'LOGNAME': 'cltbld', 06:40:56 INFO - 'MAIL': '/var/mail/cltbld', 06:40:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:56 INFO - 'MOZ_NO_REMOTE': '1', 06:40:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:56 INFO - 'NO_EM_RESTART': '1', 06:40:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:56 INFO - 'PWD': '/builds/slave/test', 06:40:56 INFO - 'SHELL': '/bin/bash', 06:40:56 INFO - 'SHLVL': '1', 06:40:56 INFO - 'TERM': 'linux', 06:40:56 INFO - 'TMOUT': '86400', 06:40:56 INFO - 'USER': 'cltbld', 06:40:56 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450276363.192137-1622430701', 06:40:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:56 INFO - '_': '/tools/buildbot/bin/python'} 06:40:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:56 INFO - Downloading/unpacking blobuploader==1.2.4 06:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:40:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:40:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:40:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:40:57 INFO - Downloading blobuploader-1.2.4.tar.gz 06:40:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:40:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:40:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:40:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:40:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:40:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:40:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:40:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:40:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:40:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:40:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:40:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:40:58 INFO - Downloading docopt-0.6.1.tar.gz 06:40:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:40:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:40:58 INFO - Installing collected packages: blobuploader, requests, docopt 06:40:58 INFO - Running setup.py install for blobuploader 06:40:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:40:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:40:58 INFO - Running setup.py install for requests 06:40:59 INFO - Running setup.py install for docopt 06:40:59 INFO - Successfully installed blobuploader requests docopt 06:40:59 INFO - Cleaning up... 06:40:59 INFO - Return code: 0 06:40:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:40:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:59 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 0x7f939fd27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180b0b0>, '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 0x180bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180c440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450276363.192137-1622430701', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:40:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:40:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:40:59 INFO - Using env: {'DISPLAY': ':0', 06:40:59 INFO - 'HOME': '/home/cltbld', 06:40:59 INFO - 'LANG': 'en_US.UTF-8', 06:40:59 INFO - 'LANGUAGE': 'en_US:en', 06:40:59 INFO - 'LOGNAME': 'cltbld', 06:40:59 INFO - 'MAIL': '/var/mail/cltbld', 06:40:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:59 INFO - 'MOZ_NO_REMOTE': '1', 06:40:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:59 INFO - 'NO_EM_RESTART': '1', 06:40:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:59 INFO - 'PWD': '/builds/slave/test', 06:40:59 INFO - 'SHELL': '/bin/bash', 06:40:59 INFO - 'SHLVL': '1', 06:40:59 INFO - 'TERM': 'linux', 06:40:59 INFO - 'TMOUT': '86400', 06:40:59 INFO - 'USER': 'cltbld', 06:40:59 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450276363.192137-1622430701', 06:40:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:59 INFO - '_': '/tools/buildbot/bin/python'} 06:40:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:40:59 INFO - Running setup.py (path:/tmp/pip-1fUvwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:40:59 INFO - Running setup.py (path:/tmp/pip-sli0cu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:40:59 INFO - Running setup.py (path:/tmp/pip-VeRWPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:40:59 INFO - Running setup.py (path:/tmp/pip-No1myY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:40:59 INFO - Running setup.py (path:/tmp/pip-u2J7DK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:40:59 INFO - Running setup.py (path:/tmp/pip-DxC1z7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:40:59 INFO - Running setup.py (path:/tmp/pip-G3MK6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:41:00 INFO - Running setup.py (path:/tmp/pip-PYGZg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:41:00 INFO - Running setup.py (path:/tmp/pip-N2kOJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:41:00 INFO - Running setup.py (path:/tmp/pip-AYnPmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:41:00 INFO - Running setup.py (path:/tmp/pip-sshst5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:41:00 INFO - Running setup.py (path:/tmp/pip-8JSrSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:41:00 INFO - Running setup.py (path:/tmp/pip-vOTZdk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:41:00 INFO - Running setup.py (path:/tmp/pip-MOW6WQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:41:00 INFO - Running setup.py (path:/tmp/pip-gKQ9IQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:41:00 INFO - Running setup.py (path:/tmp/pip-nsaIG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:41:00 INFO - Running setup.py (path:/tmp/pip-QBmvmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:41:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:41:00 INFO - Running setup.py install for manifestparser 06:41:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:41:00 INFO - Running setup.py install for mozcrash 06:41:00 INFO - Running setup.py install for mozdebug 06:41:01 INFO - Running setup.py install for mozdevice 06:41:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:41:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:41:01 INFO - Running setup.py install for mozfile 06:41:01 INFO - Running setup.py install for mozhttpd 06:41:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:41:01 INFO - Running setup.py install for mozinfo 06:41:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:41:01 INFO - Running setup.py install for mozInstall 06:41:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:41:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:41:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:41:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:41:01 INFO - Running setup.py install for mozleak 06:41:01 INFO - Running setup.py install for mozlog 06:41:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:41:01 INFO - Running setup.py install for moznetwork 06:41:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:41:01 INFO - Running setup.py install for mozprocess 06:41:01 INFO - Running setup.py install for mozprofile 06:41:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:41:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:41:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:41:02 INFO - Running setup.py install for mozrunner 06:41:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:41:02 INFO - Running setup.py install for mozscreenshot 06:41:02 INFO - Running setup.py install for moztest 06:41:02 INFO - Running setup.py install for mozversion 06:41:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:41:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:41:02 INFO - Cleaning up... 06:41:02 INFO - Return code: 0 06:41:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f939fd27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180b0b0>, '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 0x180bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180c440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450276363.192137-1622430701', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:41:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:41:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:41:02 INFO - Using env: {'DISPLAY': ':0', 06:41:02 INFO - 'HOME': '/home/cltbld', 06:41:02 INFO - 'LANG': 'en_US.UTF-8', 06:41:02 INFO - 'LANGUAGE': 'en_US:en', 06:41:02 INFO - 'LOGNAME': 'cltbld', 06:41:02 INFO - 'MAIL': '/var/mail/cltbld', 06:41:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:02 INFO - 'MOZ_NO_REMOTE': '1', 06:41:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:02 INFO - 'NO_EM_RESTART': '1', 06:41:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:02 INFO - 'PWD': '/builds/slave/test', 06:41:02 INFO - 'SHELL': '/bin/bash', 06:41:02 INFO - 'SHLVL': '1', 06:41:02 INFO - 'TERM': 'linux', 06:41:02 INFO - 'TMOUT': '86400', 06:41:02 INFO - 'USER': 'cltbld', 06:41:02 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450276363.192137-1622430701', 06:41:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:02 INFO - '_': '/tools/buildbot/bin/python'} 06:41:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:41:02 INFO - Running setup.py (path:/tmp/pip-IP3fAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:41:02 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:41:02 INFO - Running setup.py (path:/tmp/pip-3U4UFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:41:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:41:02 INFO - Running setup.py (path:/tmp/pip-lbkyeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:41:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:41:02 INFO - Running setup.py (path:/tmp/pip-cyHgTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:41:03 INFO - Running setup.py (path:/tmp/pip-LngoPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:41:03 INFO - Running setup.py (path:/tmp/pip-2DbLF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:41:03 INFO - Running setup.py (path:/tmp/pip-JBrIpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:41:03 INFO - Running setup.py (path:/tmp/pip-nQsvwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:41:03 INFO - Running setup.py (path:/tmp/pip-suHsSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:41:03 INFO - Running setup.py (path:/tmp/pip-YMpW22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:41:03 INFO - Running setup.py (path:/tmp/pip-MleS0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:41:03 INFO - Running setup.py (path:/tmp/pip-IlXPYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:41:03 INFO - Running setup.py (path:/tmp/pip-TTUggv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:41:03 INFO - Running setup.py (path:/tmp/pip-Ysqbmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:41:03 INFO - Running setup.py (path:/tmp/pip-IzzpWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:41:03 INFO - Running setup.py (path:/tmp/pip-VWYb0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:41:03 INFO - Running setup.py (path:/tmp/pip-5CKhHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:41:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:06 INFO - Downloading blessings-1.5.1.tar.gz 06:41:06 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 06:41:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:41:06 INFO - Installing collected packages: blessings 06:41:06 INFO - Running setup.py install for blessings 06:41:06 INFO - Successfully installed blessings 06:41:06 INFO - Cleaning up... 06:41:06 INFO - Return code: 0 06:41:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:41:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:41:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:41:07 INFO - Reading from file tmpfile_stdout 06:41:07 INFO - Current package versions: 06:41:07 INFO - argparse == 1.2.1 06:41:07 INFO - blessings == 1.5.1 06:41:07 INFO - blobuploader == 1.2.4 06:41:07 INFO - docopt == 0.6.1 06:41:07 INFO - manifestparser == 1.1 06:41:07 INFO - mozInstall == 1.12 06:41:07 INFO - mozcrash == 0.16 06:41:07 INFO - mozdebug == 0.1 06:41:07 INFO - mozdevice == 0.47 06:41:07 INFO - mozfile == 1.2 06:41:07 INFO - mozhttpd == 0.7 06:41:07 INFO - mozinfo == 0.9 06:41:07 INFO - mozleak == 0.1 06:41:07 INFO - mozlog == 3.1 06:41:07 INFO - moznetwork == 0.27 06:41:07 INFO - mozprocess == 0.22 06:41:07 INFO - mozprofile == 0.27 06:41:07 INFO - mozrunner == 6.11 06:41:07 INFO - mozscreenshot == 0.1 06:41:07 INFO - mozsystemmonitor == 0.0 06:41:07 INFO - moztest == 0.7 06:41:07 INFO - mozversion == 1.4 06:41:07 INFO - psutil == 3.1.1 06:41:07 INFO - requests == 1.2.3 06:41:07 INFO - wsgiref == 0.1.2 06:41:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41: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', '-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 0x7f939fd27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180b0b0>, '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 0x180bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180c440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450276363.192137-1622430701', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:41:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:41:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:41:07 INFO - Using env: {'DISPLAY': ':0', 06:41:07 INFO - 'HOME': '/home/cltbld', 06:41:07 INFO - 'LANG': 'en_US.UTF-8', 06:41:07 INFO - 'LANGUAGE': 'en_US:en', 06:41:07 INFO - 'LOGNAME': 'cltbld', 06:41:07 INFO - 'MAIL': '/var/mail/cltbld', 06:41:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:07 INFO - 'MOZ_NO_REMOTE': '1', 06:41:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:07 INFO - 'NO_EM_RESTART': '1', 06:41:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:07 INFO - 'PWD': '/builds/slave/test', 06:41:07 INFO - 'SHELL': '/bin/bash', 06:41:07 INFO - 'SHLVL': '1', 06:41:07 INFO - 'TERM': 'linux', 06:41:07 INFO - 'TMOUT': '86400', 06:41:07 INFO - 'USER': 'cltbld', 06:41:07 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450276363.192137-1622430701', 06:41:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:07 INFO - '_': '/tools/buildbot/bin/python'} 06:41:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:41:07 INFO - Cleaning up... 06:41:07 INFO - Return code: 0 06:41:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f939fd27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180b0b0>, '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 0x180bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180c440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450276363.192137-1622430701', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:41: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', 'jsonschema'] in /builds/slave/test/build 06:41: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 jsonschema 06:41:07 INFO - Using env: {'DISPLAY': ':0', 06:41:07 INFO - 'HOME': '/home/cltbld', 06:41:07 INFO - 'LANG': 'en_US.UTF-8', 06:41:07 INFO - 'LANGUAGE': 'en_US:en', 06:41:07 INFO - 'LOGNAME': 'cltbld', 06:41:07 INFO - 'MAIL': '/var/mail/cltbld', 06:41:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:07 INFO - 'MOZ_NO_REMOTE': '1', 06:41:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:07 INFO - 'NO_EM_RESTART': '1', 06:41:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:07 INFO - 'PWD': '/builds/slave/test', 06:41:07 INFO - 'SHELL': '/bin/bash', 06:41:07 INFO - 'SHLVL': '1', 06:41:07 INFO - 'TERM': 'linux', 06:41:07 INFO - 'TMOUT': '86400', 06:41:07 INFO - 'USER': 'cltbld', 06:41:07 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450276363.192137-1622430701', 06:41:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:07 INFO - '_': '/tools/buildbot/bin/python'} 06:41:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:07 INFO - Downloading/unpacking jsonschema 06:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:41:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 06:41:09 INFO - Downloading/unpacking functools32 (from jsonschema) 06:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:09 INFO - Downloading functools32-3.2.3-2.tar.gz 06:41:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 06:41:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:41:09 INFO - warning: no files found matching '*.txt' 06:41:09 INFO - no previously-included directories found matching 'build' 06:41:09 INFO - no previously-included directories found matching 'dist' 06:41:09 INFO - no previously-included directories found matching '.git*' 06:41:09 INFO - Installing collected packages: jsonschema, functools32 06:41:09 INFO - Running setup.py install for functools32 06:41:09 INFO - warning: no files found matching '*.txt' 06:41:09 INFO - no previously-included directories found matching 'build' 06:41:09 INFO - no previously-included directories found matching 'dist' 06:41:09 INFO - no previously-included directories found matching '.git*' 06:41:09 INFO - Successfully installed jsonschema functools32 06:41:09 INFO - Cleaning up... 06:41:09 INFO - Return code: 0 06:41:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:41:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f939fd27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180b0b0>, '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 0x180bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180c440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450276363.192137-1622430701', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:41:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:41:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:41:09 INFO - Using env: {'DISPLAY': ':0', 06:41:09 INFO - 'HOME': '/home/cltbld', 06:41:09 INFO - 'LANG': 'en_US.UTF-8', 06:41:09 INFO - 'LANGUAGE': 'en_US:en', 06:41:09 INFO - 'LOGNAME': 'cltbld', 06:41:09 INFO - 'MAIL': '/var/mail/cltbld', 06:41:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:09 INFO - 'MOZ_NO_REMOTE': '1', 06:41:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:09 INFO - 'NO_EM_RESTART': '1', 06:41:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:09 INFO - 'PWD': '/builds/slave/test', 06:41:09 INFO - 'SHELL': '/bin/bash', 06:41:09 INFO - 'SHLVL': '1', 06:41:09 INFO - 'TERM': 'linux', 06:41:09 INFO - 'TMOUT': '86400', 06:41:09 INFO - 'USER': 'cltbld', 06:41:09 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450276363.192137-1622430701', 06:41:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:09 INFO - '_': '/tools/buildbot/bin/python'} 06:41:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:09 INFO - Downloading/unpacking flake8 06:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:41:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 06:41:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:41: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 06:41: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 06:41: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 06:41: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 06:41: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 06:41: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 06:41:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:41:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 06:41:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:41: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 06:41: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 06:41: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 06:41: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 06:41: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 06:41: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 06:41:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 06:41:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:41: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 06:41: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 06:41: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 06:41: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 06:41: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 06:41: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 06:41:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 06:41:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:41:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:41:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:41:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:41:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:41:12 INFO - no previously-included directories found matching 'docs/_build' 06:41:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:41:12 INFO - Running setup.py install for pep8 06:41:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:41:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:41:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:41:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:41:12 INFO - no previously-included directories found matching 'docs/_build' 06:41:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:41:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:41:12 INFO - Cleaning up... 06:41:12 INFO - Return code: 0 06:41:12 INFO - Running post-action listener: _resource_record_post_action 06:41:12 INFO - Running post-action listener: _start_resource_monitoring 06:41:12 INFO - Starting resource monitoring. 06:41:12 INFO - ##### 06:41:12 INFO - ##### Running install step. 06:41:12 INFO - ##### 06:41:12 INFO - Running pre-action listener: _resource_record_pre_action 06:41:12 INFO - Running main action method: install 06:41:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:41:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:41:12 INFO - Reading from file tmpfile_stdout 06:41:12 INFO - Detecting whether we're running mozinstall >=1.0... 06:41:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:41:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:41:12 INFO - Reading from file tmpfile_stdout 06:41:12 INFO - Output received: 06:41:12 INFO - Usage: mozinstall [options] installer 06:41:12 INFO - Options: 06:41:12 INFO - -h, --help show this help message and exit 06:41:12 INFO - -d DEST, --destination=DEST 06:41:12 INFO - Directory to install application into. [default: 06:41:12 INFO - "/builds/slave/test"] 06:41:12 INFO - --app=APP Application being installed. [default: firefox] 06:41:12 INFO - mkdir: /builds/slave/test/build/application 06:41:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:41:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:41:27 INFO - Reading from file tmpfile_stdout 06:41:27 INFO - Output received: 06:41:27 INFO - /builds/slave/test/build/application/firefox/firefox 06:41:27 INFO - Running post-action listener: _resource_record_post_action 06:41:27 INFO - ##### 06:41:27 INFO - ##### Running run-tests step. 06:41:27 INFO - ##### 06:41:27 INFO - Running pre-action listener: _resource_record_pre_action 06:41:27 INFO - Running main action method: run_tests 06:41:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:41:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:41:27 INFO - Python 2.7.3 06:41:27 INFO - Return code: 0 06:41:27 INFO - grabbing minidump binary from tooltool 06:41:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:27 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 0x180b0b0>, '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 0x180bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180c440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:41:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:41:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:41:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:41:27 INFO - Return code: 0 06:41:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:41:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:41:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:41:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:41:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:41:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:41:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:41:28 INFO - Return code: 0 06:41:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/14DTxexDSSmMU-eFukCKuA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost'] in /builds/slave/test/build 06:41:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/14DTxexDSSmMU-eFukCKuA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost 06:41:28 INFO - Using env: {'DISPLAY': ':0', 06:41:28 INFO - 'HOME': '/home/cltbld', 06:41:28 INFO - 'LANG': 'en_US.UTF-8', 06:41:28 INFO - 'LANGUAGE': 'en_US:en', 06:41:28 INFO - 'LOGNAME': 'cltbld', 06:41:28 INFO - 'MAIL': '/var/mail/cltbld', 06:41:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:41:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:41:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:28 INFO - 'MOZ_NO_REMOTE': '1', 06:41:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:41:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:28 INFO - 'NO_EM_RESTART': '1', 06:41:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:28 INFO - 'PWD': '/builds/slave/test', 06:41:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:41:28 INFO - 'SHELL': '/bin/bash', 06:41:28 INFO - 'SHLVL': '1', 06:41:28 INFO - 'TERM': 'linux', 06:41:28 INFO - 'TMOUT': '86400', 06:41:28 INFO - 'USER': 'cltbld', 06:41:28 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450276363.192137-1622430701', 06:41:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:28 INFO - '_': '/tools/buildbot/bin/python'} 06:41:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/14DTxexDSSmMU-eFukCKuA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost'] with output_timeout 3600 06:41:28 INFO - mozversion INFO | application_buildid: 20151216054508 06:41:28 INFO - mozversion INFO | application_changeset: a42ef45dc7217345fbc67d43d74399c8c679e9b2 06:41:28 INFO - mozversion INFO | application_display_name: Nightly 06:41:28 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:41:28 INFO - mozversion INFO | application_name: Firefox 06:41:28 INFO - mozversion INFO | application_remotingname: firefox 06:41:28 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 06:41:28 INFO - mozversion INFO | application_vendor: Mozilla 06:41:28 INFO - mozversion INFO | application_version: 46.0a1 06:41:28 INFO - mozversion INFO | platform_buildid: 20151216054508 06:41:28 INFO - mozversion INFO | platform_changeset: a42ef45dc7217345fbc67d43d74399c8c679e9b2 06:41:28 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 06:41:28 INFO - mozversion INFO | platform_version: 46.0a1 06:41:28 INFO - 2015-12-16 06:41:28,541 DEBUG : using testdate: 1450276888 06:41:28 INFO - 2015-12-16 06:41:28,541 DEBUG : actual date: 1450276888 06:41:28 INFO - 2015-12-16 06:41:28,549 INFO : starting webserver on 'localhost:35418' 06:41:28 INFO - 2015-12-16 06:41:28,550 INFO : Starting test suite talos-linux64-ix-022.e 06:41:28 INFO - 2015-12-16 06:41:28,550 INFO : Starting test dromaeo_css 06:41:28 INFO - 2015-12-16 06:41:28,551 DEBUG : operating with platform_type : linux_ 06:41:28 INFO - 2015-12-16 06:41:28,551 INFO : Initialising browser for dromaeo_css test... 06:41:28 INFO - 2015-12-16 06:41:28,568 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxaS1GI/profile http://localhost:35418/getInfo.html 06:41:34 INFO - 2015-12-16 06:41:34,078 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:41:34 INFO - 2015-12-16 06:41:34,078 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:41:34 INFO - 2015-12-16 06:41:34,079 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:41:34 INFO - 2015-12-16 06:41:34,079 DEBUG : BROWSER_OUTPUT: __metrics 06:41:34 INFO - 2015-12-16 06:41:34,207 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:41:35 INFO - 2015-12-16 06:41:35,177 INFO : Browser initialized. 06:41:35 INFO - 2015-12-16 06:41:35,177 INFO : Running cycle 1/1 for dromaeo_css test... 06:41:35 INFO - 2015-12-16 06:41:35,178 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxaS1GI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:41:47 INFO - 2015-12-16 06:41:47,138 DEBUG : BROWSER_OUTPUT: RSS: Main: 143384576 06:41:47 INFO - 2015-12-16 06:41:47,138 DEBUG : BROWSER_OUTPUT: 06:42:36 INFO - 2015-12-16 06:42:36,764 DEBUG : BROWSER_OUTPUT: 1450276956757 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:44:48 INFO - 2015-12-16 06:44:48,559 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35418/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35418/tests/dromaeo/cssquery-ext.html) 06:44:49 INFO - 2015-12-16 06:44:49,534 DEBUG : BROWSER_OUTPUT: RSS: Main: 146014208 06:44:49 INFO - 2015-12-16 06:44:49,535 DEBUG : BROWSER_OUTPUT: 06:47:51 INFO - 2015-12-16 06:47:51,472 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35418/tests/dromaeo/cssquery-ext.html (next: http://localhost:35418/tests/dromaeo/cssquery-jquery.html) 06:47:52 INFO - 2015-12-16 06:47:52,066 DEBUG : BROWSER_OUTPUT: RSS: Main: 145174528 06:47:52 INFO - 2015-12-16 06:47:52,066 DEBUG : BROWSER_OUTPUT: 06:50:53 INFO - 2015-12-16 06:50:53,903 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35418/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35418/tests/dromaeo/cssquery-mootools.html) 06:50:54 INFO - 2015-12-16 06:50:54,496 DEBUG : BROWSER_OUTPUT: RSS: Main: 145068032 06:50:54 INFO - 2015-12-16 06:50:54,496 DEBUG : BROWSER_OUTPUT: 06:53:56 INFO - 2015-12-16 06:53:56,294 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35418/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35418/tests/dromaeo/cssquery-prototype.html) 06:53:56 INFO - 2015-12-16 06:53:56,895 DEBUG : BROWSER_OUTPUT: RSS: Main: 144482304 06:53:56 INFO - 2015-12-16 06:53:56,895 DEBUG : BROWSER_OUTPUT: 06:56:59 INFO - 2015-12-16 06:56:59,532 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35418/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35418/tests/dromaeo/cssquery-yui.html) 06:57:00 INFO - 2015-12-16 06:57:00,154 DEBUG : BROWSER_OUTPUT: RSS: Main: 145084416 06:57:00 INFO - 2015-12-16 06:57:00,154 DEBUG : BROWSER_OUTPUT: 07:00:02 INFO - 2015-12-16 07:00:02,689 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35418/tests/dromaeo/cssquery-yui.html (next: http://localhost:35418/tests/dromaeo/cssquery-dojo.html) 07:00:02 INFO - 2015-12-16 07:00:02,939 DEBUG : BROWSER_OUTPUT: RSS: Main: 147607552 07:00:02 INFO - 2015-12-16 07:00:02,940 DEBUG : BROWSER_OUTPUT: 07:00:02 INFO - 2015-12-16 07:00:02,940 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:00:02 INFO - 2015-12-16 07:00:02,940 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:00:02 INFO - 2015-12-16 07:00:02,941 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:00:02 INFO - 2015-12-16 07:00:02,941 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:00:02 INFO - 2015-12-16 07:00:02,941 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2688.233853351795;2730.440259746752;2762.751352378287;2766.944661106779;2778.485980093683;4586.701864378813;4831.734254615994;4841.491643377448;4851.539103785143;4875.414950205975;4730.077634861195;4748.121597504464;4750.738709370983;4808.51914808519;4820.156472617286;4295.076558539913;4337.414449049385;4424.336349547578;4441.489228738688;4474.507804141542;4212.431321771553;4399.362092496586;4438.822447102112;4470.396496472967;4500.752458614775;4320.265554855682;4356.411884395598;4369.2353838078525;4404.075144219718;4436.068425630621;4382.715123516961;4404.977975110136;4405.0969551241915;4448.021435284232;4464.196444639963;4210.242156411845;4322.416473776031;4376.846810361622;4388.29787234041;4429.069895321986;4617.12274667812;4716.316134160562;4725.314829349725;4739.241721324572;4742.264948932921;5127.743612819344;5184.870378240536;5191.532762051395;5197.324347834795;5235.057689615867;4898.975505122487;5050.116229659795;5053.065182941167;5219.321488206547;5226.895462090737;4723.244280915072;4759.571638552477;4771.093492236464;4828;4854.17479028566;5296.894062118813;5331.920021199685;5339.973300133474;5340.599455040888;5345.679259244458;4869.391326084239;5082.644214904995;5086.18621020635;5107.897842043139;5113.335266415343;5054.772535235923;5122.564582010571;5179.922301165486;5208.505192006829;5249.47505249472;5133.101707201225;5139;5146.382434107931;5163.535281824654;5167.0957582422925;4854.805807767721;4925.285833554115;5110.770015349244;5114.41184263807;5116.923246151311;4162.958370416318;4210.6841986851105;4220.662347012293;4255.6169944705125;4270.636995855387;3758.398656215047;3761.6990640748672;3765.171662234304;3793.3172029034486;3797.4493698413576;4263.914721705549;4345.196138714348;4369.104333611602;4415.712978656377;4489.2592722201125;5132.640715149903;5171.741412929338;5200.765965531485;5220.373555173328;5221.634485586049;4456.264716321835;4463.843765468193;4477.552244775561;4489.753063581535;4501.48232953208;4308.375285583573;4399.84600538986;4415.889602759957;4519.683622146484;4569.657275704269;4894.583960363409;4925.827596034193;4940.505949405103;4944.035912997075;5000.899982000413;5196.945558424393;5210.088234559013;5214.7914083436235;5216.634835561475;5224.817131400383;4699.835505757282;4780.11567859947;4843.515648435128;4869.902601947871;4883.218685010382;5101.846944591668;5131.204663277198;5146.459621739813;5148.9742551287;5203.453637368022;4962.503749625009;5236.659617124875;5238.292830467991;5240.633155679066;5242.68543887368;4886.53577910098;4906.754662266943;4941.975290123526;4981.2030075187795;5010.624203184703;5008.974955125347;5072;5077.441481437113;5079.517445842786;5123.5644970177955;4675.742834144155;4836.322914791862;4900.387451568554;5001.674891132065;5017.2724954880605;4918;4935.62982776286;4974.452810190948;4975.850724478271;5032.773525191302;4922.7538623067985;4956.653034287565;4978.7510624467905;4983.501649835132;5019.67372120811 07:00:02 INFO - 2015-12-16 07:00:02,942 DEBUG : BROWSER_OUTPUT: |1;ext.html;557.1753804369536;557.2811073714907;571.1974675580809;572.6506830833192;573.3607028163599;26335.341616459573;34558.82720586397;34852.30295394097;34857.47713784295;34885;39558.81323560291;39976.400353994715;40116.799416002876;40150.7992460038;40248.19503609926;7895.526268423884;8065.2741253287195;8066.112727599989;8075.3539716822515;8080.474769140016;7801.648925798324;7934.3255823255095;7939.603019849013;7946.880796788053;7972.3622110231045;7811.140774514799;7840;7849.372050235996;7884.132745398002;7924.603769811515;7885;7888;7951.960240198791;7974.720884769005;7975.96012019942;7731.110922243902;7902.091259505173;7903.486273392211;7913.881291780628;7945.682172713085;36300;36894;36903.708370206914;36918.44622330667;36941.26117477662;2931.7508011819023;3285.78642388244;3447.2933048725204;3665;3699.1491956850077;27477;28006.019789307276;28100.859495702596;28216.85891570529;28470.145895623165;3421.606515250753;3471.6181220065773;3517.56030496188;3547.255076433952;3555.1823080691584;204801.97599012058;205030;205468;206803;207159;46914;48127.278090828666;52484.47515524796;52672.473275267526;53838.46161538413;54124;54188.45811541834;54247.45752542424;54382.456175437736;54419.18371224435;14585;14775.335109920079;14809;14822.851771482363;14840.332185051699;11051.17116216287;11116.388598627153;11131.443427828575;11144.665660030212;11222.270552414231;18656.906715466335;18900.71648925267;18910.243590256512;19051;19143.80856191448;7486.363659088929;7674.462787604814;7706.229377062249;7746.109197442253;7750.3024727773645;899.7660608241773;908.4685459006555;927.1655510040882;947.7298969793576;989.7575094101991;25108.372290692878;26084.73915260861;26947.461050778875;27000;27004.459910801674;943.5753910740194;957.7940742740344;971.1793534463367;972.4262685015875;999.5152351109706;12351.25892446456;13962.720745585235;14060.43758249679;14421.278936053155;14430.494932677306;260112;260832;262425;262586;263216;46537.30194047092;46690.5330946693;46776.5322346779;46938.82652933636;47038;1225.154643296123;1226.564569577787;1233.272369302116;1237.5730373021293;1239.5847391123893;25512.872435637702;26712.332191695365;26725.331866703487;27028;27254.182374528795;36765.81617092004;36838.8158059208;37102.814485927396;37246.6275337254;37273.440898386005;198295;199280;199957;200798;201109;27991.160265192077;29122.27194320159;29536.704632954254;29656.851715741283;29683;33725;33818.66181338155;34019.14952126118;34348;34450.65549344474;30302.696973029986;32401.35197296088;33021.66978330186;33228.33543329168;33354;31276.530852036783;31917.521237180998;31924.201894952814;32110;32214.67785322117;31064.22339441532;31072.378552428374;31330.843345783127;31758;31787.68212317847;26989.46021079528;28206.717932820407;29428.411431770815;29771.85114074416;29777.854825528808;23232.883835580713;23240.18659346915;23406.149148935005;23548;23599.29202123939 07:00:02 INFO - 2015-12-16 07:00:02,946 DEBUG : BROWSER_OUTPUT: |2;jquery.html;340.03599794582374;340.3890017418733;340.82447539517153;342.7052734648202;343.4453357827109;15158.317875695593;15209.239538023096;16283.267252973616;16291.266892989828;16691.165441727924;9768.560414781334;10112.595496180162;13742.312884355768;15339.616509587266;15427.228638568055;4432.867013989578;4558.566936141078;4559.247724125516;5154.484551544834;5164.354455693038;5074.416442109149;5079.390473143209;5085.262636917663;5087.389513258414;5105.872353191163;3498.860045598173;4373.278409062516;5049.520295571915;5061.772220250079;5320.441353657869;5267.341582302212;5274.736263186864;5292.947070529303;5310.097283461801;5314.468553144713;4696.929546056812;4822.879428014293;4829.444613869415;4833.226683730586;5081.771320290596;16779;17588;17719.291228350852;17722.46832595024;18028.36900708482;1754.7017007108823;1754.9034803085826;1784.4735802938164;1804.5218017225445;1882.2282864025822;8812.647494100293;8895.73312800617;9088.818223635557;9379;11952.223105498202;1695.8049824270242;1739.147817569382;1744.72956691713;1774.4499205246416;1808.3851490493296;55552.16671749927;58269;58601.41398586045;58790.706046469924;58822.41177588212;9807.166390856715;9994;10032.297739158188;10035.197184225244;10096.69709908704;12648.747025059447;12663.113582049167;12670.619881403572;12706.809397859039;12733.426995785212;7222.855542889113;7273.3453989141235;7287.380572651384;7287.562746235243;7303.087114110736;6875.5530890491955;6899.241083480813;6960.477964152708;6967.163940327092;7063.117110361205;4213.873583792491;4232.978835105805;4298.247806633826;4300.741955482618;4341.522432532419;1676.7736355592083;1702.8807983441288;1722.586579221003;1756.6574517968872;1761.6652835961127;381.6336317135525;819.5328662662345;846.7883029242689;930.4510338900081;1010.8736407949007;9300.8604870927;9433.433993960247;9784.608615655294;9970.501474926225;10098.091171794575;400.5333786139115;402.5833262573281;417.2447869356414;421.1198594936597;439.3080897586314;5404.675719456845;5457.399686034533;5497.697626630574;5575.804846830422;5585.497305242548;474297;475174;475274;485815;488564;69145.65427172832;72103.27896720966;72638.63680681668;72866.27133728594;72958.27041729621;443.79585390719984;447.1057884231537;448.177594114803;451.1540860885839;454.0397060217616;9136.355456017714;9212.263018958602;9223.30825188127;9257.722268331961;9412.529373531434;29805.10584682463;30355.392892142474;31264.843675781474;31308.217294566908;31670.524942125427;43814.34278485889;44722.3291650619;46591.30113048375;46829;47245;8648.697295594624;8677.088905664814;8711.085336039625;8747.518886461306;9005.414648047856;10503.684889453329;10545.525451354553;10653.360798352123;11123.888761112285;16247.431339903047;13311.201327920357;13710;13994.370253338828;14122.223277719824;14328.641783955485;13525.256110913993;13855.792163117763;13917.721645567235;14152.646183845487;14766.114033158045;14242.28788560547;14289.571312860215;14386.352614132598;14412.279386030867;14466.27668616586;8713.869291960753;8752.99340575842;8936.776580585538;8938.50838203879;8945.59744811472;11595.362255076052;13928.72142557123;14029.228392438514;14350.856491434952;14503.202323871867 07:00:02 INFO - 2015-12-16 07:00:02,947 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1397.4619771388013;1400.5098215624532;1520.7718842173679;1715.1938588863234;1800.3788692900948;6136.9079463808075;6234.501239900808;7162.713491460342;7381.114266288053;7411.3700335471485;6816.863662726755;6889.862202755942;6946.47901407394;6980.092587963571;7017.929820701792;2077.356019633911;2112.7464704235513;2113.2075471698113;2113.50332671822;2115.058798834519;2084.343431818972;2093.5603523260133;2104.5370018595886;2107.6417009108486;2108.9982258427203;2099.7585277693033;2099.937001889946;2107.041296210228;2124.341454149219;2125.3836387447623;2042.28520017994;2063.494443861256;2070.1512379924234;2075.1595603780493;2080.4590806390297;2037.4295197344768;2059.814616684491;2063.7833027532192;2066.4523901166203;2067.266120527206;6987.475939304572;7062.081929349203;7067.964660176717;7068.505204635678;7079.433645308363;4101.815418306183;4159.667226621893;4160.729552579072;4166.354215096665;4167.166566686645;2590.365360486674;2640.9471810563873;2660.4812061647986;2678.1831541380066;2696.689880663729;853.5049671190694;866.8873046503977;883.4787475389551;892.9642814287421;903.8418276801533;9209.539523023823;9278.443293402417;9279.489628070454;9280.860787088199;9285.907140928639;3851.441540976543;3880.4761357216416;3884.1843212925037;3918.1771827916455;3931.724779265481;8021.398395120389;8029.156938521488;8117.133059396372;8127.349812015024;8142.022957245168;4125.401816736617;4158.147579746144;4184.267753143188;4190.161967606491;4204.957950420457;3285.474324108179;3356.311956049053;3845.8846234613006;3851.287511810324;3858.5562660294427;3411.488276758506;3438.0889064397957;3447.517347571342;3448.517207590939;3450.8447119879665;1101.6144349477618;1112.4437781109445;1114.3982249585133;1116.4027245423658;1117.3686866920164;1192.0999645267768;1196.8324434579165;1197.7364979704626;1217.1236709569096;1220.8107743299802;6553.836154096186;6601.108850305243;6624.370684784938;6644.700988455531;6695.966520167465;443.4545509023919;445;445.2786485892874;446.3906767262728;468.1432977650891;5293;5323.228131920927;5337.146056630921;5337.412884582693;5346.4118946915805;7419;8269.503829770112;8402.28580570646;8486.74539763808;8530.317574594143;8230.465019773696;8356.582170891432;8366.49801011929;8384.329253659693;8405.747827565183;6368.77709280173;6501.252355979028;6720.092787473726;6792.898106528406;6807.183138023469;6795.660216989229;6851.486138539729;6853.109095817711;6866.828329291808;6867.896981545181;7635;7646.006019217466;7722.150563437905;7751.224877512429;7818.17909119557;7810.101838288442;7965.800854978672;7967.322777563972;8024.719134830253;8051.83896322082;5423.322084739408;5629.183768353484;6048.425399587209;6371.108044873628;6430.742770289323;6880.965595171992;6885.827854303682;6893.103896493424;6914.308569143247;6923.273056329013;6442.387973142544;6471.2234531856475;6500.414962653384;6592.637404942774;6694.230163531256;6322.841928951813;6355.078513615592;6509.446697030806;6567.310432404529;6567.376099270562;6628.5028622852515;6642.103316052271;6646.235682896336;6664.933350666432;6668.133142691419;5803.100519419497;5953.226080609493;5953.7023148843255;6042.456178943916;6049.66726830011;6156.907646385397;6215.533834962305;6247.843803904757;6252.249730032425;6305.369463053658 07:00:02 INFO - 2015-12-16 07:00:02,949 DEBUG : BROWSER_OUTPUT: |4;prototype.html;300.2134407851429;308.57724916863884;312.29421507393283;314.95748074010015;315.70481599704294;5543.198460500338;5633.521150702185;5650.152477128428;5703.144528320749;5815.796447124351;5603.859903502414;5650.7174641267975;5671.092625179972;5681.545476361892;5685.232493613361;4238.576142385752;4298.161858437606;4299.075698724773;4308.289132293168;4335.718178318415;4358.673099517533;4377.321515165155;4378.1462614790125;4394.714343567658;4406.735595864242;4336.327869180266;4340.218760623086;4341.044970106572;4345.978270108645;4348.934765978513;4338.522762496139;4350.260455722535;4351.760653164075;4354.042110735649;4359.237133501656;3698.149425632093;3832.7891965941863;3838.6353296436796;3841.2893614681375;3842;5235.424103348629;5396.406395296514;5402.135658294694;5406.189071639246;5409.29679141709;4954.157793175169;4964.354633897607;4968.080905032581;4968.900621987576;4980.576650984671;5886.8822623547285;5902.527797776168;5921.467067963861;5931.258592675916;5932.3177834548715;4011.4785077939973;4114.670826333916;4121.216968775923;4125.133721918401;4142.792860357;6154.8769024619705;6213.627182369118;6225.968870155665;6228.532860035471;6232.34560371159;4264.594863487963;4299.376590394438;4309.84915527955;4317.028668549614;4317.438732964694;4326.502452218036;4328.264195086843;4370.934435983463;4374.103308821684;4374.58441448062;4776.785044672998;4932.383452068491;4936.185529387611;4965.677230979974;4976.402831660224;5878.5003274721275;5881.5882888198275;5892.175095486636;5903.645781253139;5913.349531551526;1509.3962415033855;1542.6451916059368;1543.2669481996186;1543.529223586817;1544.9150296733562;1025.1183981775666;1048.3866937841296;1052.2160990062453;1053.9104176145113;1063.2982231727024;5133.948660513347;5145.202493613421;5165.948340516622;5167.844964651066;5174;6139.416755408229;6140.5701600887505;6157.630542167484;6159.260888693296;6169.352218017133;5148.433672296044;5153.433122356612;5155.355580552431;5159.7678104485385;5167.896642067138;3233.7413006959387;3290.3254832759226;3325.1687078230443;3325.451300535433;3330;5703.201551782754;5774.0761478163295;5792.594518383757;5863.618864773776;5873.559483038789;6324.683765811691;6364.554481186365;6369.936300636934;6389.744410223539;6390.265119511223;5811.651300921958;5828.562857785768;5837.153612726131;5842.591018628656;5850.180974663551;5965.433283838029;6172.351903050115;6179.5056395489155;6180.690965451619;6192.380761923771;5959.73181206838;6042.395760423922;6044.395560444096;6044.75820967174;6045.153678485103;5764.884702306014;5811.4479124483105;5831.329397119216;5836.737346819318;5842.2405087338375;4125.711200215956;4177.164567086656;4182.5399206086695;4182.623563879144;4195.139996300812;6035.5473339500595;6148.846278843064;6153.876922461436;6173.9073913892225;6174.38256174379;5886.705664716833;5888.205092312483;5895.174675545341;5895.351511333835;5897.70511474416;5903.940960590511;5907.113932910098;5910.024845900378;5913.319968203712;5923.7926672566255;5649.604527683023;5770.942290577041;5812.18629391877;5814.098814683731;5815.476607105381;5973.820785376446;5982.312034116132;5982.88034239304;5988.431099045583;5991.580589358703;5750.654960702372;5803.912941305968;5822.650640961556;5826.796062137805;5826.883462330815 07:00:02 INFO - 2015-12-16 07:00:02,950 DEBUG : BROWSER_OUTPUT: |5;yui.html;643.9903401448978;668.9866202675945;682.7780971184367;749.295662077647;757.1028331427256;12195.14633975621;12250.509979600827;12294.815577766318;12319.938400307998;12348.5060597576;13625.931870340659;13854.515091971783;13870.861291387084;13884.652883677913;13890.444382224725;818.136865606786;822.1860358245324;829.7801082713086;831.0816547714779;836.3351135847016;812.1796985045117;818.4516374029415;822.9629666664985;828.6519661742053;829.2536716954759;823.9176082391742;864.9178328058824;866.4411454611771;876.1019954546578;879.2262808728342;852.1946760311508;858.4591707224408;860.4106187261746;861.9267362274214;864.3733293362294;640.7437025189914;643.5173619785161;644.8226737647137;647.786230543924;649.4414803269185;12386.132970692055;12475.251484910934;12481.812772808415;12513.49946002168;12542.561010364594;10748.677539673823;10806.135509159249;10868.510917008674;11295.774084518345;11611.129165312552;8965.417247878868;9068.909310906873;9193;9200.953995230047;9243.953780231122;3156.305612765188;3158.8578513966695;3193.952090718641;3197.488401855715;3269.3134441767256;38399.42400863989;38720.612793872264;38734.225315493815;39002.02494937621;39157;8660.22058014769;8801.559922003875;8853.930116837919;8910.55447227636;8918.019017908025;15011.849881501044;15015.549533514011;15019.624509387353;15023.924880375529;15035.774463383059;6139.6009259398;6157.9384206158265;6335.3981371769605;6410.519211059096;6434.388733070351;3485.35520928629;3531.2000237658026;3532.6114127445962;3550.201204728967;3596.1549035976523;2395.5927492326346;2420.721617014031;2423.333583264616;2439.597466418021;2458.643496693005;460.0591789789821;470.2452563635316;498.55877548369955;509.74257999710653;512.5028722139518;510.2295533744073;566.4675205306999;571.2545128607125;586.551288264478;590.4449817171844;7566.924330756732;7584.848303033908;8005.679772809139;8047.356211503065;8174.754757357289;606.3057798820327;611.9816405507842;620.5097972601684;623.7723231020735;636.5130675033511;3618.6019537850816;3917.0794863207125;3962.445257663872;3993.4209539616595;4010.21800748857;46818.76590617025;47056.5294347059;47086.05827883423;47207.291890621666;47405.52594474011;41957;46604;47730;47788.7610561945;48856.26715599269;38864.22271554553;39256.60743392586;39847;40496.19007619831;40825;7976.680932762624;8001.199880011952;8439.409241353047;8452.197041281068;8572.357073219659;29490.262743431587;29744.702552974195;30392.848035759678;30963.225919352197;31144.844275778476;34271.828640856635;34398.14004649904;34492.65507344894;37802.0549486265;38122.809385952896;9981.351212171186;10140.797184056426;10188.541515631963;10293.794124117327;10680.305780124267;11118.555257789598;11323.377214253294;11338.546458141913;11474.082073433938;11504.424778760862;10236.232282578687;10472.633457829244;10605.098566621924;11121.833172502256;11149;10681.252312338373;10902.563897444013;10939.890601093886;11065.944670276596;11373;9773.41359518431;9828.361156524803;10076;10146.239032072477;10325.432101234504;8874.86687699672;9161.587728552098;9351.53242337894;9379.624815007322;9448.196903263299;8629.525376104124;9187.402818816756;9248.306377021885;9265.351425400157;9430.57562409707 07:00:02 INFO - 2015-12-16 07:00:02,950 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:00:02 INFO - 2015-12-16 07:00:02,950 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:00:02 INFO - 2015-12-16 07:00:02,950 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,325 07:00:02 INFO - 2015-12-16 07:00:02,950 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:00:02 INFO - 2015-12-16 07:00:02,951 DEBUG : BROWSER_OUTPUT: __startTimestamp1450278002937__endTimestamp 07:00:02 INFO - 2015-12-16 07:00:02,951 DEBUG : BROWSER_OUTPUT: 07:00:02 INFO - 2015-12-16 07:00:02,951 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:00:02 INFO - 2015-12-16 07:00:02,951 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:00:02 INFO - 2015-12-16 07:00:02,951 DEBUG : BROWSER_OUTPUT: 07:00:02 INFO - 2015-12-16 07:00:02,951 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4738.74 Median:4875.41 stddev:510.41 (10.5%) stddev-sans-first:485.97 07:00:02 INFO - 2015-12-16 07:00:02,951 DEBUG : BROWSER_OUTPUT: Values: 2688.2 2730.4 2762.8 2766.9 2778.5 4586.7 4831.7 4841.5 4851.5 4875.4 4730.1 4748.1 4750.7 4808.5 4820.2 4295.1 4337.4 4424.3 4441.5 4474.5 4212.4 4399.4 4438.8 4470.4 4500.8 4320.3 4356.4 4369.2 4404.1 4436.1 4382.7 4405.0 4405.1 4448.0 4464.2 4210.2 4322.4 4376.8 4388.3 4429.1 4617.1 4716.3 4725.3 4739.2 4742.3 5127.7 5184.9 5191.5 5197.3 5235.1 4899.0 5050.1 5053.1 5219.3 5226.9 4723.2 4759.6 4771.1 4828.0 4854.2 5296.9 5331.9 5340.0 5340.6 5345.7 4869.4 5082.6 5086.2 5107.9 5113.3 5054.8 5122.6 5179.9 5208.5 5249.5 5133.1 5139.0 5146.4 5163.5 5167.1 4854.8 4925.3 5110.8 5114.4 5116.9 4163.0 4210.7 4220.7 4255.6 4270.6 3758.4 3761.7 3765.2 3793.3 3797.4 4263.9 4345.2 4369.1 4415.7 4489.3 5132.6 5171.7 5200.8 5220.4 5221.6 4456.3 4463.8 4477.6 4489.8 4501.5 4308.4 4399.8 4415.9 4519.7 4569.7 4894.6 4925.8 4940.5 4944.0 5000.9 5196.9 5210.1 5214.8 5216.6 5224.8 4699.8 4780.1 4843.5 4869.9 4883.2 5101.8 5131.2 5146.5 5149.0 5203.5 4962.5 5236.7 5238.3 5240.6 5242.7 4886.5 4906.8 4942.0 4981.2 5010.6 5009.0 5072.0 5077.4 5079.5 5123.6 4675.7 4836.3 4900.4 5001.7 5017.3 4918.0 4935.6 4974.5 4975.9 5032.8 4922.8 4956.7 4978.8 4983.5 5019.7 07:00:02 INFO - 2015-12-16 07:00:02,951 DEBUG : BROWSER_OUTPUT: 07:00:02 INFO - 2015-12-16 07:00:02,951 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38205.02 Median:18720.38 stddev:58243.67 (311.1%) stddev-sans-first:58338.46 07:00:02 INFO - 2015-12-16 07:00:02,953 DEBUG : BROWSER_OUTPUT: Values: 557.2 557.3 571.2 572.7 573.4 26335.3 34558.8 34852.3 34857.5 34885.0 39558.8 39976.4 40116.8 40150.8 40248.2 7895.5 8065.3 8066.1 8075.4 8080.5 7801.6 7934.3 7939.6 7946.9 7972.4 7811.1 7840.0 7849.4 7884.1 7924.6 7885.0 7888.0 7952.0 7974.7 7976.0 7731.1 7902.1 7903.5 7913.9 7945.7 36300.0 36894.0 36903.7 36918.4 36941.3 2931.8 3285.8 3447.3 3665.0 3699.1 27477.0 28006.0 28100.9 28216.9 28470.1 3421.6 3471.6 3517.6 3547.3 3555.2 204802.0 205030.0 205468.0 206803.0 207159.0 46914.0 48127.3 52484.5 52672.5 53838.5 54124.0 54188.5 54247.5 54382.5 54419.2 14585.0 14775.3 14809.0 14822.9 14840.3 11051.2 11116.4 11131.4 11144.7 11222.3 18656.9 18900.7 18910.2 19051.0 19143.8 7486.4 7674.5 7706.2 7746.1 7750.3 899.8 908.5 927.2 947.7 989.8 25108.4 26084.7 26947.5 27000.0 27004.5 943.6 957.8 971.2 972.4 999.5 12351.3 13962.7 14060.4 14421.3 14430.5 260112.0 260832.0 262425.0 262586.0 263216.0 46537.3 46690.5 46776.5 46938.8 47038.0 1225.2 1226.6 1233.3 1237.6 1239.6 25512.9 26712.3 26725.3 27028.0 27254.2 36765.8 36838.8 37102.8 37246.6 37273.4 198295.0 199280.0 199957.0 200798.0 201109.0 27991.2 29122.3 29536.7 29656.9 29683.0 33725.0 33818.7 34019.1 34348.0 34450.7 30302.7 32401.4 33021.7 33228.3 33354.0 31276.5 31917.5 31924.2 32110.0 32214.7 31064.2 31072.4 31330.8 31758.0 31787.7 26989.5 28206.7 29428.4 29771.9 29777.9 23232.9 23240.2 23406.1 23548.0 23599.3 07:00:02 INFO - 2015-12-16 07:00:02,953 DEBUG : BROWSER_OUTPUT: 07:00:02 INFO - 2015-12-16 07:00:02,953 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25708.27 Median:2439.99 stddev:78518.86 (3218.0%) stddev-sans-first:78716.02 07:00:02 INFO - 2015-12-16 07:00:02,953 DEBUG : BROWSER_OUTPUT: Values: 340.0 340.4 340.8 342.7 343.4 15158.3 15209.2 16283.3 16291.3 16691.2 9768.6 10112.6 13742.3 15339.6 15427.2 4432.9 4558.6 4559.2 5154.5 5164.4 5074.4 5079.4 5085.3 5087.4 5105.9 3498.9 4373.3 5049.5 5061.8 5320.4 5267.3 5274.7 5292.9 5310.1 5314.5 4696.9 4822.9 4829.4 4833.2 5081.8 16779.0 17588.0 17719.3 17722.5 18028.4 1754.7 1754.9 1784.5 1804.5 1882.2 8812.6 8895.7 9088.8 9379.0 11952.2 1695.8 1739.1 1744.7 1774.4 1808.4 55552.2 58269.0 58601.4 58790.7 58822.4 9807.2 9994.0 10032.3 10035.2 10096.7 12648.7 12663.1 12670.6 12706.8 12733.4 7222.9 7273.3 7287.4 7287.6 7303.1 6875.6 6899.2 6960.5 6967.2 7063.1 4213.9 4233.0 4298.2 4300.7 4341.5 1676.8 1702.9 1722.6 1756.7 1761.7 381.6 819.5 846.8 930.5 1010.9 9300.9 9433.4 9784.6 9970.5 10098.1 400.5 402.6 417.2 421.1 439.3 5404.7 5457.4 5497.7 5575.8 5585.5 474297.0 475174.0 475274.0 485815.0 488564.0 69145.7 72103.3 72638.6 72866.3 72958.3 443.8 447.1 448.2 451.2 454.0 9136.4 9212.3 9223.3 9257.7 9412.5 29805.1 30355.4 31264.8 31308.2 31670.5 43814.3 44722.3 46591.3 46829.0 47245.0 8648.7 8677.1 8711.1 8747.5 9005.4 10503.7 10545.5 10653.4 11123.9 16247.4 13311.2 13710.0 13994.4 14122.2 14328.6 13525.3 13855.8 13917.7 14152.6 14766.1 14242.3 14289.6 14386.4 14412.3 14466.3 8713.9 8753.0 8936.8 8938.5 8945.6 11595.4 13928.7 14029.2 14350.9 14503.2 07:00:02 INFO - 2015-12-16 07:00:02,953 DEBUG : BROWSER_OUTPUT: 07:00:02 INFO - 2015-12-16 07:00:02,953 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4950.68 Median:6225.02 stddev:2559.55 (41.1%) stddev-sans-first:2552.80 07:00:02 INFO - 2015-12-16 07:00:02,953 DEBUG : BROWSER_OUTPUT: Values: 1397.5 1400.5 1520.8 1715.2 1800.4 6136.9 6234.5 7162.7 7381.1 7411.4 6816.9 6889.9 6946.5 6980.1 7017.9 2077.4 2112.7 2113.2 2113.5 2115.1 2084.3 2093.6 2104.5 2107.6 2109.0 2099.8 2099.9 2107.0 2124.3 2125.4 2042.3 2063.5 2070.2 2075.2 2080.5 2037.4 2059.8 2063.8 2066.5 2067.3 6987.5 7062.1 7068.0 7068.5 7079.4 4101.8 4159.7 4160.7 4166.4 4167.2 2590.4 2640.9 2660.5 2678.2 2696.7 853.5 866.9 883.5 893.0 903.8 9209.5 9278.4 9279.5 9280.9 9285.9 3851.4 3880.5 3884.2 3918.2 3931.7 8021.4 8029.2 8117.1 8127.3 8142.0 4125.4 4158.1 4184.3 4190.2 4205.0 3285.5 3356.3 3845.9 3851.3 3858.6 3411.5 3438.1 3447.5 3448.5 3450.8 1101.6 1112.4 1114.4 1116.4 1117.4 1192.1 1196.8 1197.7 1217.1 1220.8 6553.8 6601.1 6624.4 6644.7 6696.0 443.5 445.0 445.3 446.4 468.1 5293.0 5323.2 5337.1 5337.4 5346.4 7419.0 8269.5 8402.3 8486.7 8530.3 8230.5 8356.6 8366.5 8384.3 8405.7 6368.8 6501.3 6720.1 6792.9 6807.2 6795.7 6851.5 6853.1 6866.8 6867.9 7635.0 7646.0 7722.2 7751.2 7818.2 7810.1 7965.8 7967.3 8024.7 8051.8 5423.3 5629.2 6048.4 6371.1 6430.7 6881.0 6885.8 6893.1 6914.3 6923.3 6442.4 6471.2 6500.4 6592.6 6694.2 6322.8 6355.1 6509.4 6567.3 6567.4 6628.5 6642.1 6646.2 6664.9 6668.1 5803.1 5953.2 5953.7 6042.5 6049.7 6156.9 6215.5 6247.8 6252.2 6305.4 07:00:02 INFO - 2015-12-16 07:00:02,953 DEBUG : BROWSER_OUTPUT: 07:00:02 INFO - 2015-12-16 07:00:02,954 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4913.10 Median:5573.53 stddev:1444.28 (25.9%) stddev-sans-first:1406.22 07:00:02 INFO - 2015-12-16 07:00:02,955 DEBUG : BROWSER_OUTPUT: Values: 300.2 308.6 312.3 315.0 315.7 5543.2 5633.5 5650.2 5703.1 5815.8 5603.9 5650.7 5671.1 5681.5 5685.2 4238.6 4298.2 4299.1 4308.3 4335.7 4358.7 4377.3 4378.1 4394.7 4406.7 4336.3 4340.2 4341.0 4346.0 4348.9 4338.5 4350.3 4351.8 4354.0 4359.2 3698.1 3832.8 3838.6 3841.3 3842.0 5235.4 5396.4 5402.1 5406.2 5409.3 4954.2 4964.4 4968.1 4968.9 4980.6 5886.9 5902.5 5921.5 5931.3 5932.3 4011.5 4114.7 4121.2 4125.1 4142.8 6154.9 6213.6 6226.0 6228.5 6232.3 4264.6 4299.4 4309.8 4317.0 4317.4 4326.5 4328.3 4370.9 4374.1 4374.6 4776.8 4932.4 4936.2 4965.7 4976.4 5878.5 5881.6 5892.2 5903.6 5913.3 1509.4 1542.6 1543.3 1543.5 1544.9 1025.1 1048.4 1052.2 1053.9 1063.3 5133.9 5145.2 5165.9 5167.8 5174.0 6139.4 6140.6 6157.6 6159.3 6169.4 5148.4 5153.4 5155.4 5159.8 5167.9 3233.7 3290.3 3325.2 3325.5 3330.0 5703.2 5774.1 5792.6 5863.6 5873.6 6324.7 6364.6 6369.9 6389.7 6390.3 5811.7 5828.6 5837.2 5842.6 5850.2 5965.4 6172.4 6179.5 6180.7 6192.4 5959.7 6042.4 6044.4 6044.8 6045.2 5764.9 5811.4 5831.3 5836.7 5842.2 4125.7 4177.2 4182.5 4182.6 4195.1 6035.5 6148.8 6153.9 6173.9 6174.4 5886.7 5888.2 5895.2 5895.4 5897.7 5903.9 5907.1 5910.0 5913.3 5923.8 5649.6 5770.9 5812.2 5814.1 5815.5 5973.8 5982.3 5982.9 5988.4 5991.6 5750.7 5803.9 5822.7 5826.8 5826.9 07:00:02 INFO - 2015-12-16 07:00:02,955 DEBUG : BROWSER_OUTPUT: 07:00:02 INFO - 2015-12-16 07:00:02,955 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12078.40 Median:23644.51 stddev:13383.85 (56.6%) stddev-sans-first:13393.84 07:00:02 INFO - 2015-12-16 07:00:02,955 DEBUG : BROWSER_OUTPUT: Values: 644.0 669.0 682.8 749.3 757.1 12195.1 12250.5 12294.8 12319.9 12348.5 13625.9 13854.5 13870.9 13884.7 13890.4 818.1 822.2 829.8 831.1 836.3 812.2 818.5 823.0 828.7 829.3 823.9 864.9 866.4 876.1 879.2 852.2 858.5 860.4 861.9 864.4 640.7 643.5 644.8 647.8 649.4 12386.1 12475.3 12481.8 12513.5 12542.6 10748.7 10806.1 10868.5 11295.8 11611.1 8965.4 9068.9 9193.0 9201.0 9244.0 3156.3 3158.9 3194.0 3197.5 3269.3 38399.4 38720.6 38734.2 39002.0 39157.0 8660.2 8801.6 8853.9 8910.6 8918.0 15011.8 15015.5 15019.6 15023.9 15035.8 6139.6 6157.9 6335.4 6410.5 6434.4 3485.4 3531.2 3532.6 3550.2 3596.2 2395.6 2420.7 2423.3 2439.6 2458.6 460.1 470.2 498.6 509.7 512.5 510.2 566.5 571.3 586.6 590.4 7566.9 7584.8 8005.7 8047.4 8174.8 606.3 612.0 620.5 623.8 636.5 3618.6 3917.1 3962.4 3993.4 4010.2 46818.8 47056.5 47086.1 47207.3 47405.5 41957.0 46604.0 47730.0 47788.8 48856.3 38864.2 39256.6 39847.0 40496.2 40825.0 7976.7 8001.2 8439.4 8452.2 8572.4 29490.3 29744.7 30392.8 30963.2 31144.8 34271.8 34398.1 34492.7 37802.1 38122.8 9981.4 10140.8 10188.5 10293.8 10680.3 11118.6 11323.4 11338.5 11474.1 11504.4 10236.2 10472.6 10605.1 11121.8 11149.0 10681.3 10902.6 10939.9 11065.9 11373.0 9773.4 9828.4 10076.0 10146.2 10325.4 8874.9 9161.6 9351.5 9379.6 9448.2 8629.5 9187.4 9248.3 9265.4 9430.6 07:00:02 INFO - 2015-12-16 07:00:02,955 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:00:02 INFO - 2015-12-16 07:00:02,955 DEBUG : BROWSER_OUTPUT: 07:00:03 INFO - 2015-12-16 07:00:03,721 INFO : Browser exited with error code: 0 07:00:03 INFO - 2015-12-16 07:00:03,737 INFO : Completed test dromaeo_css (00:18:35) 07:00:03 INFO - 2015-12-16 07:00:03,738 INFO : Starting test kraken 07:00:03 INFO - 2015-12-16 07:00:03,738 DEBUG : operating with platform_type : linux_ 07:00:03 INFO - 2015-12-16 07:00:03,738 INFO : Initialising browser for kraken test... 07:00:03 INFO - 2015-12-16 07:00:03,744 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOSEI3Q/profile http://localhost:35418/getInfo.html 07:00:08 INFO - 2015-12-16 07:00:08,761 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:00:08 INFO - 2015-12-16 07:00:08,761 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:00:08 INFO - 2015-12-16 07:00:08,761 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:00:08 INFO - 2015-12-16 07:00:08,761 DEBUG : BROWSER_OUTPUT: __metrics 07:00:08 INFO - 2015-12-16 07:00:08,857 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] 07:00:09 INFO - 2015-12-16 07:00:09,753 INFO : Browser initialized. 07:00:09 INFO - 2015-12-16 07:00:09,754 INFO : Running cycle 1/1 for kraken test... 07:00:09 INFO - 2015-12-16 07:00:09,754 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOSEI3Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:00:21 INFO - 2015-12-16 07:00:21,851 DEBUG : BROWSER_OUTPUT: RSS: Main: 142999552 07:00:21 INFO - 2015-12-16 07:00:21,851 DEBUG : BROWSER_OUTPUT: 07:00:24 INFO - 2015-12-16 07:00:24,440 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35418/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35418/tests/kraken/driver.html?testName=audio-beat-detection) 07:00:25 INFO - 2015-12-16 07:00:25,062 DEBUG : BROWSER_OUTPUT: RSS: Main: 141680640 07:00:25 INFO - 2015-12-16 07:00:25,062 DEBUG : BROWSER_OUTPUT: 07:00:27 INFO - 2015-12-16 07:00:27,812 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35418/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35418/tests/kraken/driver.html?testName=audio-dft) 07:00:28 INFO - 2015-12-16 07:00:28,401 DEBUG : BROWSER_OUTPUT: RSS: Main: 141103104 07:00:28 INFO - 2015-12-16 07:00:28,401 DEBUG : BROWSER_OUTPUT: 07:00:31 INFO - 2015-12-16 07:00:31,293 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35418/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35418/tests/kraken/driver.html?testName=audio-fft) 07:00:31 INFO - 2015-12-16 07:00:31,895 DEBUG : BROWSER_OUTPUT: RSS: Main: 138215424 07:00:31 INFO - 2015-12-16 07:00:31,895 DEBUG : BROWSER_OUTPUT: 07:00:33 INFO - 2015-12-16 07:00:33,989 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35418/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35418/tests/kraken/driver.html?testName=audio-oscillator) 07:00:34 INFO - 2015-12-16 07:00:34,570 DEBUG : BROWSER_OUTPUT: RSS: Main: 138768384 07:00:34 INFO - 2015-12-16 07:00:34,570 DEBUG : BROWSER_OUTPUT: 07:00:36 INFO - 2015-12-16 07:00:36,829 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35418/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35418/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:00:37 INFO - 2015-12-16 07:00:37,414 DEBUG : BROWSER_OUTPUT: RSS: Main: 139370496 07:00:37 INFO - 2015-12-16 07:00:37,414 DEBUG : BROWSER_OUTPUT: 07:00:40 INFO - 2015-12-16 07:00:40,495 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35418/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35418/tests/kraken/driver.html?testName=imaging-darkroom) 07:00:41 INFO - 2015-12-16 07:00:41,096 DEBUG : BROWSER_OUTPUT: RSS: Main: 140324864 07:00:41 INFO - 2015-12-16 07:00:41,096 DEBUG : BROWSER_OUTPUT: 07:00:44 INFO - 2015-12-16 07:00:44,639 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35418/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35418/tests/kraken/driver.html?testName=imaging-desaturate) 07:00:45 INFO - 2015-12-16 07:00:45,226 DEBUG : BROWSER_OUTPUT: RSS: Main: 138833920 07:00:45 INFO - 2015-12-16 07:00:45,226 DEBUG : BROWSER_OUTPUT: 07:00:48 INFO - 2015-12-16 07:00:48,145 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35418/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35418/tests/kraken/driver.html?testName=json-parse-financial) 07:00:48 INFO - 2015-12-16 07:00:48,747 DEBUG : BROWSER_OUTPUT: RSS: Main: 139632640 07:00:48 INFO - 2015-12-16 07:00:48,747 DEBUG : BROWSER_OUTPUT: 07:00:50 INFO - 2015-12-16 07:00:50,522 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35418/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35418/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:00:51 INFO - 2015-12-16 07:00:51,103 DEBUG : BROWSER_OUTPUT: RSS: Main: 139804672 07:00:51 INFO - 2015-12-16 07:00:51,104 DEBUG : BROWSER_OUTPUT: 07:00:53 INFO - 2015-12-16 07:00:53,016 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35418/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35418/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:00:53 INFO - 2015-12-16 07:00:53,623 DEBUG : BROWSER_OUTPUT: RSS: Main: 140533760 07:00:53 INFO - 2015-12-16 07:00:53,623 DEBUG : BROWSER_OUTPUT: 07:00:55 INFO - 2015-12-16 07:00:55,782 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35418/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35418/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:00:56 INFO - 2015-12-16 07:00:56,385 DEBUG : BROWSER_OUTPUT: RSS: Main: 140304384 07:00:56 INFO - 2015-12-16 07:00:56,386 DEBUG : BROWSER_OUTPUT: 07:00:58 INFO - 2015-12-16 07:00:58,953 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35418/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35418/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:00:59 INFO - 2015-12-16 07:00:59,558 DEBUG : BROWSER_OUTPUT: RSS: Main: 140734464 07:00:59 INFO - 2015-12-16 07:00:59,559 DEBUG : BROWSER_OUTPUT: 07:01:02 INFO - 2015-12-16 07:01:02,234 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35418/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35418/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:01:02 INFO - 2015-12-16 07:01:02,828 DEBUG : BROWSER_OUTPUT: RSS: Main: 140296192 07:01:02 INFO - 2015-12-16 07:01:02,828 DEBUG : BROWSER_OUTPUT: 07:01:04 INFO - 2015-12-16 07:01:04,623 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35418/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35418/tests/kraken/driver.html?testName=ai-astar) 07:01:04 INFO - 2015-12-16 07:01:04,873 DEBUG : BROWSER_OUTPUT: RSS: Main: 140640256 07:01:04 INFO - 2015-12-16 07:01:04,873 DEBUG : BROWSER_OUTPUT: 07:01:04 INFO - 2015-12-16 07:01:04,873 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:01:04 INFO - 2015-12-16 07:01:04,873 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:01:04 INFO - 2015-12-16 07:01:04,873 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:01:04 INFO - 2015-12-16 07:01:04,873 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:01:04 INFO - 2015-12-16 07:01:04,874 DEBUG : BROWSER_OUTPUT: |0;ai-astar;117;110;114;115;114;126;114;113;116;115 07:01:04 INFO - 2015-12-16 07:01:04,874 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;146;155;167;131;151;150;131;161;140 07:01:04 INFO - 2015-12-16 07:01:04,874 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;163;164;161;161;165;170;163;164;164 07:01:04 INFO - 2015-12-16 07:01:04,874 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;72;79;76;72;131;73;74;78;72 07:01:04 INFO - 2015-12-16 07:01:04,874 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;131;95;95;96;130;96;96;137 07:01:04 INFO - 2015-12-16 07:01:04,874 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;109;110;111;110;110;110;110 07:01:04 INFO - 2015-12-16 07:01:04,875 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;148;148;149;148;149;148;148;148;147 07:01:04 INFO - 2015-12-16 07:01:04,875 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;98;96;96;96;96;96;96;95;96 07:01:04 INFO - 2015-12-16 07:01:04,875 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;75;74;74;75;77;73;77;73;74;71 07:01:04 INFO - 2015-12-16 07:01:04,875 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;70;70;69;71;72;70;70;70;71 07:01:04 INFO - 2015-12-16 07:01:04,875 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;95;84;96;87;85;94;84;88;85;87 07:01:04 INFO - 2015-12-16 07:01:04,875 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;127;124;123;128;131;125;132;124;122 07:01:04 INFO - 2015-12-16 07:01:04,875 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;145;154;155;151;160;140;157;155;157;141 07:01:04 INFO - 2015-12-16 07:01:04,875 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;72;74;71;71;71;70;71;71;70 07:01:04 INFO - 2015-12-16 07:01:04,875 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:01:04 INFO - 2015-12-16 07:01:04,876 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:01:04 INFO - 2015-12-16 07:01:04,876 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,796 07:01:04 INFO - 2015-12-16 07:01:04,876 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:01:04 INFO - 2015-12-16 07:01:04,876 DEBUG : BROWSER_OUTPUT: __startTimestamp1450278064872__endTimestamp 07:01:04 INFO - 2015-12-16 07:01:04,876 DEBUG : BROWSER_OUTPUT: 07:01:04 INFO - 2015-12-16 07:01:04,879 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:01:04 INFO - 2015-12-16 07:01:04,880 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:01:04 INFO - 2015-12-16 07:01:04,880 DEBUG : BROWSER_OUTPUT: 07:01:04 INFO - 2015-12-16 07:01:04,880 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:115.40 Median:115.00 stddev:4.17 (3.6%) stddev-sans-first:4.38 07:01:04 INFO - 2015-12-16 07:01:04,880 DEBUG : BROWSER_OUTPUT: Values: 117.0 110.0 114.0 115.0 114.0 126.0 114.0 113.0 116.0 115.0 07:01:04 INFO - 2015-12-16 07:01:04,880 DEBUG : BROWSER_OUTPUT: 07:01:04 INFO - 2015-12-16 07:01:04,880 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.70 Median:153.00 stddev:11.94 (7.8%) stddev-sans-first:12.44 07:01:04 INFO - 2015-12-16 07:01:04,880 DEBUG : BROWSER_OUTPUT: Values: 155.0 146.0 155.0 167.0 131.0 151.0 150.0 131.0 161.0 140.0 07:01:04 INFO - 2015-12-16 07:01:04,880 DEBUG : BROWSER_OUTPUT: 07:01:04 INFO - 2015-12-16 07:01:04,880 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.70 Median:164.00 stddev:2.58 (1.6%) stddev-sans-first:2.67 07:01:04 INFO - 2015-12-16 07:01:04,881 DEBUG : BROWSER_OUTPUT: Values: 162.0 163.0 164.0 161.0 161.0 165.0 170.0 163.0 164.0 164.0 07:01:04 INFO - 2015-12-16 07:01:04,881 DEBUG : BROWSER_OUTPUT: 07:01:04 INFO - 2015-12-16 07:01:04,881 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.10 Median:74.00 stddev:18.06 (24.4%) stddev-sans-first:19.02 07:01:04 INFO - 2015-12-16 07:01:04,881 DEBUG : BROWSER_OUTPUT: Values: 74.0 72.0 79.0 76.0 72.0 131.0 73.0 74.0 78.0 72.0 07:01:04 INFO - 2015-12-16 07:01:04,881 DEBUG : BROWSER_OUTPUT: 07:01:04 INFO - 2015-12-16 07:01:04,881 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.60 Median:95.00 stddev:18.08 (19.0%) stddev-sans-first:18.68 07:01:04 INFO - 2015-12-16 07:01:04,881 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 131.0 95.0 95.0 96.0 130.0 96.0 96.0 137.0 07:01:04 INFO - 2015-12-16 07:01:04,881 DEBUG : BROWSER_OUTPUT: 07:01:04 INFO - 2015-12-16 07:01:04,881 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 07:01:04 INFO - 2015-12-16 07:01:04,882 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 109.0 110.0 111.0 110.0 110.0 110.0 110.0 07:01:04 INFO - 2015-12-16 07:01:04,882 DEBUG : BROWSER_OUTPUT: 07:01:04 INFO - 2015-12-16 07:01:04,882 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 07:01:04 INFO - 2015-12-16 07:01:04,882 DEBUG : BROWSER_OUTPUT: Values: 148.0 148.0 148.0 149.0 148.0 149.0 148.0 148.0 148.0 147.0 07:01:04 INFO - 2015-12-16 07:01:04,882 DEBUG : BROWSER_OUTPUT: 07:01:04 INFO - 2015-12-16 07:01:04,882 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 07:01:04 INFO - 2015-12-16 07:01:04,882 DEBUG : BROWSER_OUTPUT: Values: 96.0 98.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 07:01:04 INFO - 2015-12-16 07:01:04,882 DEBUG : BROWSER_OUTPUT: 07:01:04 INFO - 2015-12-16 07:01:04,882 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.30 Median:74.50 stddev:1.83 (2.5%) stddev-sans-first:1.92 07:01:04 INFO - 2015-12-16 07:01:04,883 DEBUG : BROWSER_OUTPUT: Values: 75.0 74.0 74.0 75.0 77.0 73.0 77.0 73.0 74.0 71.0 07:01:04 INFO - 2015-12-16 07:01:04,883 DEBUG : BROWSER_OUTPUT: 07:01:04 INFO - 2015-12-16 07:01:04,883 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:70.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 07:01:04 INFO - 2015-12-16 07:01:04,883 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 70.0 69.0 71.0 72.0 70.0 70.0 70.0 71.0 07:01:04 INFO - 2015-12-16 07:01:04,883 DEBUG : BROWSER_OUTPUT: 07:01:04 INFO - 2015-12-16 07:01:04,883 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:87.50 stddev:4.70 (5.4%) stddev-sans-first:4.35 07:01:04 INFO - 2015-12-16 07:01:04,883 DEBUG : BROWSER_OUTPUT: Values: 95.0 84.0 96.0 87.0 85.0 94.0 84.0 88.0 85.0 87.0 07:01:04 INFO - 2015-12-16 07:01:04,883 DEBUG : BROWSER_OUTPUT: 07:01:04 INFO - 2015-12-16 07:01:04,883 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.60 Median:126.00 stddev:3.86 (3.1%) stddev-sans-first:3.53 07:01:04 INFO - 2015-12-16 07:01:04,883 DEBUG : BROWSER_OUTPUT: Values: 120.0 127.0 124.0 123.0 128.0 131.0 125.0 132.0 124.0 122.0 07:01:04 INFO - 2015-12-16 07:01:04,884 DEBUG : BROWSER_OUTPUT: 07:01:04 INFO - 2015-12-16 07:01:04,884 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.50 Median:155.00 stddev:7.06 (4.6%) stddev-sans-first:7.08 07:01:04 INFO - 2015-12-16 07:01:04,884 DEBUG : BROWSER_OUTPUT: Values: 145.0 154.0 155.0 151.0 160.0 140.0 157.0 155.0 157.0 141.0 07:01:04 INFO - 2015-12-16 07:01:04,884 DEBUG : BROWSER_OUTPUT: 07:01:04 INFO - 2015-12-16 07:01:04,884 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.30 Median:71.00 stddev:1.16 (1.6%) stddev-sans-first:1.20 07:01:04 INFO - 2015-12-16 07:01:04,884 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 74.0 71.0 71.0 71.0 70.0 71.0 71.0 70.0 07:01:04 INFO - 2015-12-16 07:01:04,884 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:01:04 INFO - 2015-12-16 07:01:04,884 DEBUG : BROWSER_OUTPUT: 07:01:05 INFO - 2015-12-16 07:01:05,837 INFO : Browser exited with error code: 0 07:01:05 INFO - 2015-12-16 07:01:05,891 INFO : Completed test kraken (00:01:02) 07:01:05 INFO - 2015-12-16 07:01:05,891 INFO : Starting test v8_7 07:01:05 INFO - 2015-12-16 07:01:05,891 DEBUG : operating with platform_type : linux_ 07:01:05 INFO - 2015-12-16 07:01:05,891 INFO : Initialising browser for v8_7 test... 07:01:05 INFO - 2015-12-16 07:01:05,897 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwNuQWd/profile http://localhost:35418/getInfo.html 07:01:10 INFO - 2015-12-16 07:01:10,981 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:01:10 INFO - 2015-12-16 07:01:10,981 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:01:10 INFO - 2015-12-16 07:01:10,981 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:01:10 INFO - 2015-12-16 07:01:10,981 DEBUG : BROWSER_OUTPUT: __metrics 07:01:11 INFO - 2015-12-16 07:01:11,146 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] 07:01:12 INFO - 2015-12-16 07:01:12,125 INFO : Browser initialized. 07:01:12 INFO - 2015-12-16 07:01:12,125 INFO : Running cycle 1/1 for v8_7 test... 07:01:12 INFO - 2015-12-16 07:01:12,126 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwNuQWd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:01:24 INFO - 2015-12-16 07:01:24,117 DEBUG : BROWSER_OUTPUT: RSS: Main: 143204352 07:01:24 INFO - 2015-12-16 07:01:24,117 DEBUG : BROWSER_OUTPUT: 07:01:45 INFO - 2015-12-16 07:01:45,551 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35418/tests/v8_7/run.html (next: http://localhost:35418/tests/v8_7/run.html) 07:01:45 INFO - 2015-12-16 07:01:45,797 DEBUG : BROWSER_OUTPUT: RSS: Main: 138256384 07:01:45 INFO - 2015-12-16 07:01:45,797 DEBUG : BROWSER_OUTPUT: 07:01:45 INFO - 2015-12-16 07:01:45,797 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:01:45 INFO - 2015-12-16 07:01:45,797 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:01:45 INFO - 2015-12-16 07:01:45,798 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:01:45 INFO - 2015-12-16 07:01:45,798 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:01:45 INFO - 2015-12-16 07:01:45,798 DEBUG : BROWSER_OUTPUT: |0;Richards;168.40687100033682 07:01:45 INFO - 2015-12-16 07:01:45,798 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.64430816404752 07:01:45 INFO - 2015-12-16 07:01:45,798 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.2690582959641 07:01:45 INFO - 2015-12-16 07:01:45,798 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5186.5284974093265 07:01:45 INFO - 2015-12-16 07:01:45,798 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1079.913606911447 07:01:45 INFO - 2015-12-16 07:01:45,798 DEBUG : BROWSER_OUTPUT: |5;Earley;699.5108315863033 07:01:45 INFO - 2015-12-16 07:01:45,799 DEBUG : BROWSER_OUTPUT: |6;Boyer;12207.317073170732 07:01:45 INFO - 2015-12-16 07:01:45,799 DEBUG : BROWSER_OUTPUT: |7;RegExp;27594.594594594593 07:01:45 INFO - 2015-12-16 07:01:45,799 DEBUG : BROWSER_OUTPUT: |8;Splay;635.3240152477764 07:01:45 INFO - 2015-12-16 07:01:45,799 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 07:01:45 INFO - 2015-12-16 07:01:45,799 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:01:45 INFO - 2015-12-16 07:01:45,799 DEBUG : BROWSER_OUTPUT: __startTimestamp1450278105796__endTimestamp 07:01:45 INFO - 2015-12-16 07:01:45,800 DEBUG : BROWSER_OUTPUT: 07:01:45 INFO - 2015-12-16 07:01:45,801 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:01:45 INFO - 2015-12-16 07:01:45,801 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:01:45 INFO - 2015-12-16 07:01:45,801 DEBUG : BROWSER_OUTPUT: 07:01:45 INFO - 2015-12-16 07:01:45,801 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.41 Median:168.41 stddev:0.00 (0.0%) 07:01:45 INFO - 2015-12-16 07:01:45,801 DEBUG : BROWSER_OUTPUT: Values: 168.4 07:01:45 INFO - 2015-12-16 07:01:45,801 DEBUG : BROWSER_OUTPUT: 07:01:45 INFO - 2015-12-16 07:01:45,801 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.64 Median:191.64 stddev:0.00 (0.0%) 07:01:45 INFO - 2015-12-16 07:01:45,801 DEBUG : BROWSER_OUTPUT: Values: 191.6 07:01:45 INFO - 2015-12-16 07:01:45,801 DEBUG : BROWSER_OUTPUT: 07:01:45 INFO - 2015-12-16 07:01:45,801 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.27 Median:280.27 stddev:0.00 (0.0%) 07:01:45 INFO - 2015-12-16 07:01:45,801 DEBUG : BROWSER_OUTPUT: Values: 280.3 07:01:45 INFO - 2015-12-16 07:01:45,801 DEBUG : BROWSER_OUTPUT: 07:01:45 INFO - 2015-12-16 07:01:45,802 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 07:01:45 INFO - 2015-12-16 07:01:45,802 DEBUG : BROWSER_OUTPUT: Values: 5186.5 07:01:45 INFO - 2015-12-16 07:01:45,802 DEBUG : BROWSER_OUTPUT: 07:01:45 INFO - 2015-12-16 07:01:45,802 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1079.91 Median:1079.91 stddev:0.00 (0.0%) 07:01:45 INFO - 2015-12-16 07:01:45,802 DEBUG : BROWSER_OUTPUT: Values: 1079.9 07:01:45 INFO - 2015-12-16 07:01:45,802 DEBUG : BROWSER_OUTPUT: 07:01:45 INFO - 2015-12-16 07:01:45,802 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:699.51 Median:699.51 stddev:0.00 (0.0%) 07:01:45 INFO - 2015-12-16 07:01:45,802 DEBUG : BROWSER_OUTPUT: Values: 699.5 07:01:45 INFO - 2015-12-16 07:01:45,802 DEBUG : BROWSER_OUTPUT: 07:01:45 INFO - 2015-12-16 07:01:45,802 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 07:01:45 INFO - 2015-12-16 07:01:45,802 DEBUG : BROWSER_OUTPUT: Values: 12207.3 07:01:45 INFO - 2015-12-16 07:01:45,802 DEBUG : BROWSER_OUTPUT: 07:01:45 INFO - 2015-12-16 07:01:45,802 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27594.59 Median:27594.59 stddev:0.00 (0.0%) 07:01:45 INFO - 2015-12-16 07:01:45,802 DEBUG : BROWSER_OUTPUT: Values: 27594.6 07:01:45 INFO - 2015-12-16 07:01:45,802 DEBUG : BROWSER_OUTPUT: 07:01:45 INFO - 2015-12-16 07:01:45,802 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:635.32 Median:635.32 stddev:0.00 (0.0%) 07:01:45 INFO - 2015-12-16 07:01:45,803 DEBUG : BROWSER_OUTPUT: Values: 635.3 07:01:45 INFO - 2015-12-16 07:01:45,803 DEBUG : BROWSER_OUTPUT: 07:01:45 INFO - 2015-12-16 07:01:45,803 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 07:01:45 INFO - 2015-12-16 07:01:45,803 DEBUG : BROWSER_OUTPUT: Values: 4835.7 07:01:45 INFO - 2015-12-16 07:01:45,803 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:01:45 INFO - 2015-12-16 07:01:45,803 DEBUG : BROWSER_OUTPUT: 07:01:46 INFO - 2015-12-16 07:01:46,697 INFO : Browser exited with error code: 0 07:01:46 INFO - 2015-12-16 07:01:46,714 INFO : Completed test v8_7 (00:00:40) 07:01:46 INFO - 2015-12-16 07:01:46,792 INFO : Completed test suite (00:20:18) 07:01:46 INFO - 2015-12-16 07:01:46,792 DEBUG : Working with test: dromaeo_css 07:01:46 INFO - 2015-12-16 07:01:46,792 DEBUG : Generating results file: dromaeo_css 07:01:46 INFO - 2015-12-16 07:01:46,794 DEBUG : Working with test: kraken 07:01:46 INFO - 2015-12-16 07:01:46,794 DEBUG : Generating results file: kraken 07:01:46 INFO - 2015-12-16 07:01:46,794 INFO : javascript benchmark 07:01:46 INFO - 2015-12-16 07:01:46,794 DEBUG : Working with test: v8_7 07:01:46 INFO - 2015-12-16 07:01:46,794 DEBUG : Generating results file: v8_7 07:01:46 INFO - 2015-12-16 07:01:46,795 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:01:46 INFO - 2015-12-16 07:01:46,858 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 07:01:46 INFO - 2015-12-16 07:01:46,858 DEBUG : process_Request line: dromaeo_css 6263.86 graph.html#tests=[[72,132,43]] 07:01:46 INFO - 2015-12-16 07:01:46,858 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:01:46 INFO - 2015-12-16 07:01:46,896 DEBUG : process_Request line: kraken 1550.20 graph.html#tests=[[232,132,43]] 07:01:46 INFO - 2015-12-16 07:01:46,897 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:01:46 INFO - 2015-12-16 07:01:46,942 DEBUG : process_Request line: v8_7 21043.60 graph.html#tests=[[230,132,43]] 07:01:46 INFO - 2015-12-16 07:01:46,943 INFO : javascript benchmark 07:01:47 INFO - 2015-12-16 07:01:46,947 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2688.233853351795, 2730.440259746752, 2762.751352378287, 2766.944661106779, 2778.485980093683, 4586.701864378813, 4831.734254615994, 4841.491643377448, 4851.539103785143, 4875.414950205975, 4730.077634861195, 4748.121597504464, 4750.738709370983, 4808.51914808519, 4820.156472617286, 4295.076558539913, 4337.414449049385, 4424.336349547578, 4441.489228738688, 4474.507804141542, 4212.431321771553, 4399.362092496586, 4438.822447102112, 4470.396496472967, 4500.752458614775, 4320.265554855682, 4356.411884395598, 4369.2353838078525, 4404.075144219718, 4436.068425630621, 4382.715123516961, 4404.977975110136, 4405.0969551241915, 4448.021435284232, 4464.196444639963, 4210.242156411845, 4322.416473776031, 4376.846810361622, 4388.29787234041, 4429.069895321986, 4617.12274667812, 4716.316134160562, 4725.314829349725, 4739.241721324572, 4742.264948932921, 5127.743612819344, 5184.870378240536, 5191.532762051395, 5197.324347834795, 5235.057689615867, 4898.975505122487, 5050.116229659795, 5053.065182941167, 5219.321488206547, 5226.895462090737, 4723.244280915072, 4759.571638552477, 4771.093492236464, 4828.0, 4854.17479028566, 5296.894062118813, 5331.920021199685, 5339.973300133474, 5340.599455040888, 5345.679259244458, 4869.391326084239, 5082.644214904995, 5086.18621020635, 5107.897842043139, 5113.335266415343, 5054.772535235923, 5122.564582010571, 5179.922301165486, 5208.505192006829, 5249.47505249472, 5133.101707201225, 5139.0, 5146.382434107931, 5163.535281824654, 5167.0957582422925, 4854.805807767721, 4925.285833554115, 5110.770015349244, 5114.41184263807, 5116.923246151311, 4162.958370416318, 4210.6841986851105, 4220.662347012293, 4255.6169944705125, 4270.636995855387, 3758.398656215047, 3761.6990640748672, 3765.171662234304, 3793.3172029034486, 3797.4493698413576, 4263.914721705549, 4345.196138714348, 4369.104333611602, 4415.712978656377, 4489.2592722201125, 5132.640715149903, 5171.741412929338, 5200.765965531485, 5220.373555173328, 5221.634485586049, 4456.264716321835, 4463.843765468193, 4477.552244775561, 4489.753063581535, 4501.48232953208, 4308.375285583573, 4399.84600538986, 4415.889602759957, 4519.683622146484, 4569.657275704269, 4894.583960363409, 4925.827596034193, 4940.505949405103, 4944.035912997075, 5000.899982000413, 5196.945558424393, 5210.088234559013, 5214.7914083436235, 5216.634835561475, 5224.817131400383, 4699.835505757282, 4780.11567859947, 4843.515648435128, 4869.902601947871, 4883.218685010382, 5101.846944591668, 5131.204663277198, 5146.459621739813, 5148.9742551287, 5203.453637368022, 4962.503749625009, 5236.659617124875, 5238.292830467991, 5240.633155679066, 5242.68543887368, 4886.53577910098, 4906.754662266943, 4941.975290123526, 4981.2030075187795, 5010.624203184703, 5008.974955125347, 5072.0, 5077.441481437113, 5079.517445842786, 5123.5644970177955, 4675.742834144155, 4836.322914791862, 4900.387451568554, 5001.674891132065, 5017.2724954880605, 4918.0, 4935.62982776286, 4974.452810190948, 4975.850724478271, 5032.773525191302, 4922.7538623067985, 4956.653034287565, 4978.7510624467905, 4983.501649835132, 5019.67372120811], "unit": "score", "name": "dojo.html", "value": 4706.436105090086}, {"lowerIsBetter": false, "replicates": [557.1753804369536, 557.2811073714907, 571.1974675580809, 572.6506830833192, 573.3607028163599, 26335.341616459573, 34558.82720586397, 34852.30295394097, 34857.47713784295, 34885.0, 39558.81323560291, 39976.400353994715, 40116.799416002876, 40150.7992460038, 40248.19503609926, 7895.526268423884, 8065.2741253287195, 8066.112727599989, 8075.3539716822515, 8080.474769140016, 7801.648925798324, 7934.3255823255095, 7939.603019849013, 7946.880796788053, 7972.3622110231045, 7811.140774514799, 7840.0, 7849.372050235996, 7884.132745398002, 7924.603769811515, 7885.0, 7888.0, 7951.960240198791, 7974.720884769005, 7975.96012019942, 7731.110922243902, 7902.091259505173, 7903.486273392211, 7913.881291780628, 7945.682172713085, 36300.0, 36894.0, 36903.708370206914, 36918.44622330667, 36941.26117477662, 2931.7508011819023, 3285.78642388244, 3447.2933048725204, 3665.0, 3699.1491956850077, 27477.0, 28006.019789307276, 28100.859495702596, 28216.85891570529, 28470.145895623165, 3421.606515250753, 3471.6181220065773, 3517.56030496188, 3547.255076433952, 3555.1823080691584, 204801.97599012058, 205030.0, 205468.0, 206803.0, 207159.0, 46914.0, 48127.278090828666, 52484.47515524796, 52672.473275267526, 53838.46161538413, 54124.0, 54188.45811541834, 54247.45752542424, 54382.456175437736, 54419.18371224435, 14585.0, 14775.335109920079, 14809.0, 14822.851771482363, 14840.332185051699, 11051.17116216287, 11116.388598627153, 11131.443427828575, 11144.665660030212, 11222.270552414231, 18656.906715466335, 18900.71648925267, 18910.243590256512, 19051.0, 19143.80856191448, 7486.363659088929, 7674.462787604814, 7706.229377062249, 7746.109197442253, 7750.3024727773645, 899.7660608241773, 908.4685459006555, 927.1655510040882, 947.7298969793576, 989.7575094101991, 25108.372290692878, 26084.73915260861, 26947.461050778875, 27000.0, 27004.459910801674, 943.5753910740194, 957.7940742740344, 971.1793534463367, 972.4262685015875, 999.5152351109706, 12351.25892446456, 13962.720745585235, 14060.43758249679, 14421.278936053155, 14430.494932677306, 260112.0, 260832.0, 262425.0, 262586.0, 263216.0, 46537.30194047092, 46690.5330946693, 46776.5322346779, 46938.82652933636, 47038.0, 1225.154643296123, 1226.564569577787, 1233.272369302116, 1237.5730373021293, 1239.5847391123893, 25512.872435637702, 26712.332191695365, 26725.331866703487, 27028.0, 27254.182374528795, 36765.81617092004, 36838.8158059208, 37102.814485927396, 37246.6275337254, 37273.440898386005, 198295.0, 199280.0, 199957.0, 200798.0, 201109.0, 27991.160265192077, 29122.27194320159, 29536.704632954254, 29656.851715741283, 29683.0, 33725.0, 33818.66181338155, 34019.14952126118, 34348.0, 34450.65549344474, 30302.696973029986, 32401.35197296088, 33021.66978330186, 33228.33543329168, 33354.0, 31276.530852036783, 31917.521237180998, 31924.201894952814, 32110.0, 32214.67785322117, 31064.22339441532, 31072.378552428374, 31330.843345783127, 31758.0, 31787.68212317847, 26989.46021079528, 28206.717932820407, 29428.411431770815, 29771.85114074416, 29777.854825528808, 23232.883835580713, 23240.18659346915, 23406.149148935005, 23548.0, 23599.29202123939], "unit": "score", "name": "ext.html", "value": 16604.613265735403}, {"lowerIsBetter": false, "replicates": [340.03599794582374, 340.3890017418733, 340.82447539517153, 342.7052734648202, 343.4453357827109, 15158.317875695593, 15209.239538023096, 16283.267252973616, 16291.266892989828, 16691.165441727924, 9768.560414781334, 10112.595496180162, 13742.312884355768, 15339.616509587266, 15427.228638568055, 4432.867013989578, 4558.566936141078, 4559.247724125516, 5154.484551544834, 5164.354455693038, 5074.416442109149, 5079.390473143209, 5085.262636917663, 5087.389513258414, 5105.872353191163, 3498.860045598173, 4373.278409062516, 5049.520295571915, 5061.772220250079, 5320.441353657869, 5267.341582302212, 5274.736263186864, 5292.947070529303, 5310.097283461801, 5314.468553144713, 4696.929546056812, 4822.879428014293, 4829.444613869415, 4833.226683730586, 5081.771320290596, 16779.0, 17588.0, 17719.291228350852, 17722.46832595024, 18028.36900708482, 1754.7017007108823, 1754.9034803085826, 1784.4735802938164, 1804.5218017225445, 1882.2282864025822, 8812.647494100293, 8895.73312800617, 9088.818223635557, 9379.0, 11952.223105498202, 1695.8049824270242, 1739.147817569382, 1744.72956691713, 1774.4499205246416, 1808.3851490493296, 55552.16671749927, 58269.0, 58601.41398586045, 58790.706046469924, 58822.41177588212, 9807.166390856715, 9994.0, 10032.297739158188, 10035.197184225244, 10096.69709908704, 12648.747025059447, 12663.113582049167, 12670.619881403572, 12706.809397859039, 12733.426995785212, 7222.855542889113, 7273.3453989141235, 7287.380572651384, 7287.562746235243, 7303.087114110736, 6875.5530890491955, 6899.241083480813, 6960.477964152708, 6967.163940327092, 7063.117110361205, 4213.873583792491, 4232.978835105805, 4298.247806633826, 4300.741955482618, 4341.522432532419, 1676.7736355592083, 1702.8807983441288, 1722.586579221003, 1756.6574517968872, 1761.6652835961127, 381.6336317135525, 819.5328662662345, 846.7883029242689, 930.4510338900081, 1010.8736407949007, 9300.8604870927, 9433.433993960247, 9784.608615655294, 9970.501474926225, 10098.091171794575, 400.5333786139115, 402.5833262573281, 417.2447869356414, 421.1198594936597, 439.3080897586314, 5404.675719456845, 5457.399686034533, 5497.697626630574, 5575.804846830422, 5585.497305242548, 474297.0, 475174.0, 475274.0, 485815.0, 488564.0, 69145.65427172832, 72103.27896720966, 72638.63680681668, 72866.27133728594, 72958.27041729621, 443.79585390719984, 447.1057884231537, 448.177594114803, 451.1540860885839, 454.0397060217616, 9136.355456017714, 9212.263018958602, 9223.30825188127, 9257.722268331961, 9412.529373531434, 29805.10584682463, 30355.392892142474, 31264.843675781474, 31308.217294566908, 31670.524942125427, 43814.34278485889, 44722.3291650619, 46591.30113048375, 46829.0, 47245.0, 8648.697295594624, 8677.088905664814, 8711.085336039625, 8747.518886461306, 9005.414648047856, 10503.684889453329, 10545.525451354553, 10653.360798352123, 11123.888761112285, 16247.431339903047, 13311.201327920357, 13710.0, 13994.370253338828, 14122.223277719824, 14328.641783955485, 13525.256110913993, 13855.792163117763, 13917.721645567235, 14152.646183845487, 14766.114033158045, 14242.28788560547, 14289.571312860215, 14386.352614132598, 14412.279386030867, 14466.27668616586, 8713.869291960753, 8752.99340575842, 8936.776580585538, 8938.50838203879, 8945.59744811472, 11595.362255076052, 13928.72142557123, 14029.228392438514, 14350.856491434952, 14503.202323871867], "unit": "score", "name": "jquery.html", "value": 7537.019700491216}, {"lowerIsBetter": false, "replicates": [1397.4619771388013, 1400.5098215624532, 1520.7718842173679, 1715.1938588863234, 1800.3788692900948, 6136.9079463808075, 6234.501239900808, 7162.713491460342, 7381.114266288053, 7411.3700335471485, 6816.863662726755, 6889.862202755942, 6946.47901407394, 6980.092587963571, 7017.929820701792, 2077.356019633911, 2112.7464704235513, 2113.2075471698113, 2113.50332671822, 2115.058798834519, 2084.343431818972, 2093.5603523260133, 2104.5370018595886, 2107.6417009108486, 2108.9982258427203, 2099.7585277693033, 2099.937001889946, 2107.041296210228, 2124.341454149219, 2125.3836387447623, 2042.28520017994, 2063.494443861256, 2070.1512379924234, 2075.1595603780493, 2080.4590806390297, 2037.4295197344768, 2059.814616684491, 2063.7833027532192, 2066.4523901166203, 2067.266120527206, 6987.475939304572, 7062.081929349203, 7067.964660176717, 7068.505204635678, 7079.433645308363, 4101.815418306183, 4159.667226621893, 4160.729552579072, 4166.354215096665, 4167.166566686645, 2590.365360486674, 2640.9471810563873, 2660.4812061647986, 2678.1831541380066, 2696.689880663729, 853.5049671190694, 866.8873046503977, 883.4787475389551, 892.9642814287421, 903.8418276801533, 9209.539523023823, 9278.443293402417, 9279.489628070454, 9280.860787088199, 9285.907140928639, 3851.441540976543, 3880.4761357216416, 3884.1843212925037, 3918.1771827916455, 3931.724779265481, 8021.398395120389, 8029.156938521488, 8117.133059396372, 8127.349812015024, 8142.022957245168, 4125.401816736617, 4158.147579746144, 4184.267753143188, 4190.161967606491, 4204.957950420457, 3285.474324108179, 3356.311956049053, 3845.8846234613006, 3851.287511810324, 3858.5562660294427, 3411.488276758506, 3438.0889064397957, 3447.517347571342, 3448.517207590939, 3450.8447119879665, 1101.6144349477618, 1112.4437781109445, 1114.3982249585133, 1116.4027245423658, 1117.3686866920164, 1192.0999645267768, 1196.8324434579165, 1197.7364979704626, 1217.1236709569096, 1220.8107743299802, 6553.836154096186, 6601.108850305243, 6624.370684784938, 6644.700988455531, 6695.966520167465, 443.4545509023919, 445.0, 445.2786485892874, 446.3906767262728, 468.1432977650891, 5293.0, 5323.228131920927, 5337.146056630921, 5337.412884582693, 5346.4118946915805, 7419.0, 8269.503829770112, 8402.28580570646, 8486.74539763808, 8530.317574594143, 8230.465019773696, 8356.582170891432, 8366.49801011929, 8384.329253659693, 8405.747827565183, 6368.77709280173, 6501.252355979028, 6720.092787473726, 6792.898106528406, 6807.183138023469, 6795.660216989229, 6851.486138539729, 6853.109095817711, 6866.828329291808, 6867.896981545181, 7635.0, 7646.006019217466, 7722.150563437905, 7751.224877512429, 7818.17909119557, 7810.101838288442, 7965.800854978672, 7967.322777563972, 8024.719134830253, 8051.83896322082, 5423.322084739408, 5629.183768353484, 6048.425399587209, 6371.108044873628, 6430.742770289323, 6880.965595171992, 6885.827854303682, 6893.103896493424, 6914.308569143247, 6923.273056329013, 6442.387973142544, 6471.2234531856475, 6500.414962653384, 6592.637404942774, 6694.230163531256, 6322.841928951813, 6355.078513615592, 6509.446697030806, 6567.310432404529, 6567.376099270562, 6628.5028622852515, 6642.103316052271, 6646.235682896336, 6664.933350666432, 6668.133142691419, 5803.100519419497, 5953.226080609493, 5953.7023148843255, 6042.456178943916, 6049.66726830011, 6156.907646385397, 6215.533834962305, 6247.843803904757, 6252.249730032425, 6305.369463053658], "unit": "score", "name": "mootools.html", "value": 4015.846989600397}, {"lowerIsBetter": false, "replicates": [300.2134407851429, 308.57724916863884, 312.29421507393283, 314.95748074010015, 315.70481599704294, 5543.198460500338, 5633.521150702185, 5650.152477128428, 5703.144528320749, 5815.796447124351, 5603.859903502414, 5650.7174641267975, 5671.092625179972, 5681.545476361892, 5685.232493613361, 4238.576142385752, 4298.161858437606, 4299.075698724773, 4308.289132293168, 4335.718178318415, 4358.673099517533, 4377.321515165155, 4378.1462614790125, 4394.714343567658, 4406.735595864242, 4336.327869180266, 4340.218760623086, 4341.044970106572, 4345.978270108645, 4348.934765978513, 4338.522762496139, 4350.260455722535, 4351.760653164075, 4354.042110735649, 4359.237133501656, 3698.149425632093, 3832.7891965941863, 3838.6353296436796, 3841.2893614681375, 3842.0, 5235.424103348629, 5396.406395296514, 5402.135658294694, 5406.189071639246, 5409.29679141709, 4954.157793175169, 4964.354633897607, 4968.080905032581, 4968.900621987576, 4980.576650984671, 5886.8822623547285, 5902.527797776168, 5921.467067963861, 5931.258592675916, 5932.3177834548715, 4011.4785077939973, 4114.670826333916, 4121.216968775923, 4125.133721918401, 4142.792860357, 6154.8769024619705, 6213.627182369118, 6225.968870155665, 6228.532860035471, 6232.34560371159, 4264.594863487963, 4299.376590394438, 4309.84915527955, 4317.028668549614, 4317.438732964694, 4326.502452218036, 4328.264195086843, 4370.934435983463, 4374.103308821684, 4374.58441448062, 4776.785044672998, 4932.383452068491, 4936.185529387611, 4965.677230979974, 4976.402831660224, 5878.5003274721275, 5881.5882888198275, 5892.175095486636, 5903.645781253139, 5913.349531551526, 1509.3962415033855, 1542.6451916059368, 1543.2669481996186, 1543.529223586817, 1544.9150296733562, 1025.1183981775666, 1048.3866937841296, 1052.2160990062453, 1053.9104176145113, 1063.2982231727024, 5133.948660513347, 5145.202493613421, 5165.948340516622, 5167.844964651066, 5174.0, 6139.416755408229, 6140.5701600887505, 6157.630542167484, 6159.260888693296, 6169.352218017133, 5148.433672296044, 5153.433122356612, 5155.355580552431, 5159.7678104485385, 5167.896642067138, 3233.7413006959387, 3290.3254832759226, 3325.1687078230443, 3325.451300535433, 3330.0, 5703.201551782754, 5774.0761478163295, 5792.594518383757, 5863.618864773776, 5873.559483038789, 6324.683765811691, 6364.554481186365, 6369.936300636934, 6389.744410223539, 6390.265119511223, 5811.651300921958, 5828.562857785768, 5837.153612726131, 5842.591018628656, 5850.180974663551, 5965.433283838029, 6172.351903050115, 6179.5056395489155, 6180.690965451619, 6192.380761923771, 5959.73181206838, 6042.395760423922, 6044.395560444096, 6044.75820967174, 6045.153678485103, 5764.884702306014, 5811.4479124483105, 5831.329397119216, 5836.737346819318, 5842.2405087338375, 4125.711200215956, 4177.164567086656, 4182.5399206086695, 4182.623563879144, 4195.139996300812, 6035.5473339500595, 6148.846278843064, 6153.876922461436, 6173.9073913892225, 6174.38256174379, 5886.705664716833, 5888.205092312483, 5895.174675545341, 5895.351511333835, 5897.70511474416, 5903.940960590511, 5907.113932910098, 5910.024845900378, 5913.319968203712, 5923.7926672566255, 5649.604527683023, 5770.942290577041, 5812.18629391877, 5814.098814683731, 5815.476607105381, 5973.820785376446, 5982.312034116132, 5982.88034239304, 5988.431099045583, 5991.580589358703, 5750.654960702372, 5803.912941305968, 5822.650640961556, 5826.796062137805, 5826.883462330815], "unit": "score", "name": "prototype.html", "value": 4446.716218406357}, {"lowerIsBetter": false, "replicates": [643.9903401448978, 668.9866202675945, 682.7780971184367, 749.295662077647, 757.1028331427256, 12195.14633975621, 12250.509979600827, 12294.815577766318, 12319.938400307998, 12348.5060597576, 13625.931870340659, 13854.515091971783, 13870.861291387084, 13884.652883677913, 13890.444382224725, 818.136865606786, 822.1860358245324, 829.7801082713086, 831.0816547714779, 836.3351135847016, 812.1796985045117, 818.4516374029415, 822.9629666664985, 828.6519661742053, 829.2536716954759, 823.9176082391742, 864.9178328058824, 866.4411454611771, 876.1019954546578, 879.2262808728342, 852.1946760311508, 858.4591707224408, 860.4106187261746, 861.9267362274214, 864.3733293362294, 640.7437025189914, 643.5173619785161, 644.8226737647137, 647.786230543924, 649.4414803269185, 12386.132970692055, 12475.251484910934, 12481.812772808415, 12513.49946002168, 12542.561010364594, 10748.677539673823, 10806.135509159249, 10868.510917008674, 11295.774084518345, 11611.129165312552, 8965.417247878868, 9068.909310906873, 9193.0, 9200.953995230047, 9243.953780231122, 3156.305612765188, 3158.8578513966695, 3193.952090718641, 3197.488401855715, 3269.3134441767256, 38399.42400863989, 38720.612793872264, 38734.225315493815, 39002.02494937621, 39157.0, 8660.22058014769, 8801.559922003875, 8853.930116837919, 8910.55447227636, 8918.019017908025, 15011.849881501044, 15015.549533514011, 15019.624509387353, 15023.924880375529, 15035.774463383059, 6139.6009259398, 6157.9384206158265, 6335.3981371769605, 6410.519211059096, 6434.388733070351, 3485.35520928629, 3531.2000237658026, 3532.6114127445962, 3550.201204728967, 3596.1549035976523, 2395.5927492326346, 2420.721617014031, 2423.333583264616, 2439.597466418021, 2458.643496693005, 460.0591789789821, 470.2452563635316, 498.55877548369955, 509.74257999710653, 512.5028722139518, 510.2295533744073, 566.4675205306999, 571.2545128607125, 586.551288264478, 590.4449817171844, 7566.924330756732, 7584.848303033908, 8005.679772809139, 8047.356211503065, 8174.754757357289, 606.3057798820327, 611.9816405507842, 620.5097972601684, 623.7723231020735, 636.5130675033511, 3618.6019537850816, 3917.0794863207125, 3962.445257663872, 3993.4209539616595, 4010.21800748857, 46818.76590617025, 47056.5294347059, 47086.05827883423, 47207.291890621666, 47405.52594474011, 41957.0, 46604.0, 47730.0, 47788.7610561945, 48856.26715599269, 38864.22271554553, 39256.60743392586, 39847.0, 40496.19007619831, 40825.0, 7976.680932762624, 8001.199880011952, 8439.409241353047, 8452.197041281068, 8572.357073219659, 29490.262743431587, 29744.702552974195, 30392.848035759678, 30963.225919352197, 31144.844275778476, 34271.828640856635, 34398.14004649904, 34492.65507344894, 37802.0549486265, 38122.809385952896, 9981.351212171186, 10140.797184056426, 10188.541515631963, 10293.794124117327, 10680.305780124267, 11118.555257789598, 11323.377214253294, 11338.546458141913, 11474.082073433938, 11504.424778760862, 10236.232282578687, 10472.633457829244, 10605.098566621924, 11121.833172502256, 11149.0, 10681.252312338373, 10902.563897444013, 10939.890601093886, 11065.944670276596, 11373.0, 9773.41359518431, 9828.361156524803, 10076.0, 10146.239032072477, 10325.432101234504, 8874.86687699672, 9161.587728552098, 9351.53242337894, 9379.624815007322, 9448.196903263299, 8629.525376104124, 9187.402818816756, 9248.306377021885, 9265.351425400157, 9430.57562409707], "unit": "score", "name": "yui.html", "value": 5742.10180112547}], "name": "dromaeo_css", "value": 6263.853442814521}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 110.0, 114.0, 115.0, 114.0, 126.0, 114.0, 113.0, 116.0, 115.0], "unit": "score", "name": "ai-astar", "value": 115.4}, {"lowerIsBetter": true, "replicates": [155.0, 146.0, 155.0, 167.0, 131.0, 151.0, 150.0, 131.0, 161.0, 140.0], "unit": "score", "name": "audio-beat-detection", "value": 148.7}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 164.0, 161.0, 161.0, 165.0, 170.0, 163.0, 164.0, 164.0], "unit": "score", "name": "audio-dft", "value": 163.7}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 79.0, 76.0, 72.0, 131.0, 73.0, 74.0, 78.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.1}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 131.0, 95.0, 95.0, 96.0, 130.0, 96.0, 96.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 106.6}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 110.0, 111.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 148.0, 149.0, 148.0, 149.0, 148.0, 148.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 148.1}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [75.0, 74.0, 74.0, 75.0, 77.0, 73.0, 77.0, 73.0, 74.0, 71.0], "unit": "score", "name": "json-parse-financial", "value": 74.3}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 70.0, 69.0, 71.0, 72.0, 70.0, 70.0, 70.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.3}, {"lowerIsBetter": true, "replicates": [95.0, 84.0, 96.0, 87.0, 85.0, 94.0, 84.0, 88.0, 85.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.5}, {"lowerIsBetter": true, "replicates": [120.0, 127.0, 124.0, 123.0, 128.0, 131.0, 125.0, 132.0, 124.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.6}, {"lowerIsBetter": true, "replicates": [145.0, 154.0, 155.0, 151.0, 160.0, 140.0, 157.0, 155.0, 157.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.5}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 74.0, 71.0, 71.0, 71.0, 70.0, 71.0, 71.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.3}], "name": "kraken", "value": 1550.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.40687100033682], "unit": "score", "name": "Richards", "value": 209.62327599999995}, {"lowerIsBetter": false, "replicates": [191.64430816404752], "unit": "score", "name": "DeltaBlue", "value": 345.00372400000015}, {"lowerIsBetter": false, "replicates": [280.2690582959641], "unit": "score", "name": "Encrypt", "value": 949.7338080000005}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1079.913606911447], "unit": "score", "name": "RayTrace", "value": 685.2298140000004}, {"lowerIsBetter": false, "replicates": [699.5108315863033], "unit": "score", "name": "Earley", "value": 952.7557972027971}, {"lowerIsBetter": false, "replicates": [12207.317073170732], "unit": "score", "name": "Boyer", "value": 54.595370629370635}, {"lowerIsBetter": false, "replicates": [27594.594594594593], "unit": "score", "name": "RegExp", "value": 33.01316846229187}, {"lowerIsBetter": false, "replicates": [635.3240152477764], "unit": "score", "name": "Splay", "value": 128.26683399999996}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21043.60246080966}]} 07:01:47 INFO - RETURN: dromaeo_css: 6263.86 07:01:47 INFO - RETURN: kraken: 1550.20 07:01:47 INFO - RETURN: v8_7: 21043.60 07:01:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21043.60"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1550.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6263.86"}}} 07:01:47 INFO - Return code: 0 07:01:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:01:47 INFO - # TBPL SUCCESS # 07:01:47 INFO - Running post-action listener: _resource_record_post_action 07:01:47 INFO - Running post-run listener: _resource_record_post_run 07:01:48 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 516915200; Read time: 12; Write time: 541268 07:01:48 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 232284160; Read time: 0; Write time: 410852 07:01:48 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 4096; Write bytes: 273281024; Read time: 12; Write time: 121352 07:01:48 INFO - Running post-run listener: _upload_blobber_files 07:01:48 INFO - Blob upload gear active. 07:01:48 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:01:48 INFO - Copying logs to upload dir... 07:01:48 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1271.738461 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-16 07:01:48.215793) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 07:01:48.219776) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1450276363.192137-1622430701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/14DTxexDSSmMU-eFukCKuA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010052 build_url: 'https://queue.taskcluster.net/v1/task/14DTxexDSSmMU-eFukCKuA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 07:01:48.271442) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 07:01:48.271780) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1450276363.192137-1622430701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004563 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 07:01:48.321172) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 07:01:48.321485) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 07:01:48.321778) ========= ========= Total master_lag: 0.26 =========