builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-048 starttime: 1450283176.62 results: success (0) buildid: 20151216073608 builduid: 153ed67a8969405fb52f767469c35ad4 revision: ac9c0f02ef3357c1a6b7ca8f43781e9f15f86d63 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 08:26:16.623026) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 08:26:16.623494) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 08:26:16.623780) ========= 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=fdc9337702648c539b2c5dbe000001aa-1450283176.438375-1600336487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006361 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 08:26:16.646695) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 08:26:16.646999) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 08:26:16.660339) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 08:26:16.660712) ========= 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=fdc9337702648c539b2c5dbe000001aa-1450283176.438375-1600336487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004542 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 08:26:16.709491) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 08:26:16.709794) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 08:26:16.710148) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 08:26:16.710429) ========= 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=fdc9337702648c539b2c5dbe000001aa-1450283176.438375-1600336487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-16 08:26:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.5M=0s 2015-12-16 08:26:17 (43.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.193186 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 08:26:16.916234) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 08:26:16.916573) ========= 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=fdc9337702648c539b2c5dbe000001aa-1450283176.438375-1600336487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015031 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 08:26:16.966453) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 08:26:16.966801) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ac9c0f02ef3357c1a6b7ca8f43781e9f15f86d63 --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 ac9c0f02ef3357c1a6b7ca8f43781e9f15f86d63 --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=fdc9337702648c539b2c5dbe000001aa-1450283176.438375-1600336487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-16 08:26:17,468 truncating revision to first 12 chars 2015-12-16 08:26:17,468 Setting DEBUG logging. 2015-12-16 08:26:17,468 attempt 1/10 2015-12-16 08:26:17,468 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ac9c0f02ef33?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-16 08:26:17,959 unpacking tar archive at: fx-team-ac9c0f02ef33/testing/mozharness/ program finished with exit code 0 elapsedTime=0.774037 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 08:26:17.753682) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 08:26:17.753982) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 08:26:17.763859) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 08:26:17.764117) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 08:26:17.764493) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-12-16 08:26:17.764777) ========= /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=fdc9337702648c539b2c5dbe000001aa-1450283176.438375-1600336487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:26:18 INFO - MultiFileLogger online at 20151216 08:26:18 in /builds/slave/test 08:26:18 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 08:26:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:26:18 INFO - {'append_to_log': False, 08:26:18 INFO - 'base_work_dir': '/builds/slave/test', 08:26:18 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:26:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:26:18 INFO - 'branch': 'Fx-Team-Non-PGO', 08:26:18 INFO - 'buildbot_json_path': 'buildprops.json', 08:26:18 INFO - 'config_files': ('talos/linux_config.py',), 08:26:18 INFO - 'default_actions': ('clobber', 08:26:18 INFO - 'read-buildbot-config', 08:26:18 INFO - 'download-and-extract', 08:26:18 INFO - 'populate-webroot', 08:26:18 INFO - 'create-virtualenv', 08:26:18 INFO - 'install', 08:26:18 INFO - 'run-tests'), 08:26:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:26:18 INFO - 'download_minidump_stackwalk': True, 08:26:18 INFO - 'download_symbols': 'ondemand', 08:26:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:26:18 INFO - 'tooltool.py': '/tools/tooltool.py', 08:26:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:26:18 INFO - '/tools/misc-python/virtualenv.py')}, 08:26:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:26:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:26:18 INFO - 'installer_path': 'installer.exe', 08:26:18 INFO - 'log_level': 'info', 08:26:18 INFO - 'log_name': 'talos', 08:26:18 INFO - 'log_to_console': True, 08:26:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:26:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:26:18 INFO - 'opt_config_files': (), 08:26:18 INFO - 'pip_index': False, 08:26:18 INFO - 'sps_profile': False, 08:26:18 INFO - 'sps_profile_interval': 0, 08:26:18 INFO - 'suite': 'dromaeojs-e10s', 08:26:18 INFO - 'system_bits': '64', 08:26:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:26:18 INFO - 'title': 'talos-linux64-ix-048', 08:26:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:26:18 INFO - 'use_talos_json': True, 08:26:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:26:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:26:18 INFO - 'work_dir': 'build'} 08:26:18 INFO - ##### 08:26:18 INFO - ##### Running clobber step. 08:26:18 INFO - ##### 08:26:18 INFO - Running pre-action listener: _resource_record_pre_action 08:26:18 INFO - Running main action method: clobber 08:26:18 INFO - rmtree: /builds/slave/test/build 08:26:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:26:18 INFO - Running post-action listener: _resource_record_post_action 08:26:18 INFO - ##### 08:26:18 INFO - ##### Running read-buildbot-config step. 08:26:18 INFO - ##### 08:26:18 INFO - Running pre-action listener: _resource_record_pre_action 08:26:18 INFO - Running main action method: read_buildbot_config 08:26:18 INFO - Using buildbot properties: 08:26:18 INFO - { 08:26:18 INFO - "properties": { 08:26:18 INFO - "buildnumber": 574, 08:26:18 INFO - "product": "firefox", 08:26:18 INFO - "script_repo_revision": "production", 08:26:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:26:18 INFO - "repository": "", 08:26:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 08:26:18 INFO - "buildid": "20151216073608", 08:26:18 INFO - "slavename": "talos-linux64-ix-048", 08:26:18 INFO - "pgo_build": "False", 08:26:18 INFO - "basedir": "/builds/slave/test", 08:26:18 INFO - "project": "", 08:26:18 INFO - "platform": "ubuntu64_hw", 08:26:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:26:18 INFO - "slavebuilddir": "test", 08:26:18 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:26:18 INFO - "branch": "fx-team", 08:26:18 INFO - "repo_path": "integration/fx-team", 08:26:18 INFO - "stage_platform": "linux64", 08:26:18 INFO - "builduid": "153ed67a8969405fb52f767469c35ad4", 08:26:18 INFO - "revision": "ac9c0f02ef3357c1a6b7ca8f43781e9f15f86d63" 08:26:18 INFO - }, 08:26:18 INFO - "sourcestamp": { 08:26:18 INFO - "repository": "", 08:26:18 INFO - "hasPatch": false, 08:26:18 INFO - "project": "", 08:26:18 INFO - "branch": "fx-team-linux64-talos", 08:26:18 INFO - "changes": [ 08:26:18 INFO - { 08:26:18 INFO - "category": null, 08:26:18 INFO - "files": [ 08:26:18 INFO - { 08:26:18 INFO - "url": null, 08:26:18 INFO - "name": "https://queue.taskcluster.net/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 08:26:18 INFO - } 08:26:18 INFO - ], 08:26:18 INFO - "repository": "", 08:26:18 INFO - "rev": "ac9c0f02ef3357c1a6b7ca8f43781e9f15f86d63", 08:26:18 INFO - "who": "mdeboer@mozilla.com", 08:26:18 INFO - "when": 1450282029, 08:26:18 INFO - "number": 7367027, 08:26:18 INFO - "comments": "Bug 1229933: create the Loop menu item in the browser Tools menu dynamically from the extension and remove it from core browser code. r=Standard8", 08:26:18 INFO - "project": "", 08:26:18 INFO - "at": "Wed 16 Dec 2015 08:07:09", 08:26:18 INFO - "branch": "fx-team-linux64-talos", 08:26:18 INFO - "revlink": "", 08:26:18 INFO - "properties": [ 08:26:18 INFO - [ 08:26:18 INFO - "buildid", 08:26:18 INFO - "20151216073608", 08:26:18 INFO - "Change" 08:26:18 INFO - ], 08:26:18 INFO - [ 08:26:18 INFO - "builduid", 08:26:18 INFO - "153ed67a8969405fb52f767469c35ad4", 08:26:18 INFO - "Change" 08:26:18 INFO - ], 08:26:18 INFO - [ 08:26:18 INFO - "pgo_build", 08:26:18 INFO - "False", 08:26:18 INFO - "Change" 08:26:18 INFO - ] 08:26:18 INFO - ], 08:26:18 INFO - "revision": "ac9c0f02ef3357c1a6b7ca8f43781e9f15f86d63" 08:26:18 INFO - } 08:26:18 INFO - ], 08:26:18 INFO - "revision": "ac9c0f02ef3357c1a6b7ca8f43781e9f15f86d63" 08:26:18 INFO - } 08:26:18 INFO - } 08:26:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 08:26:18 INFO - Running post-action listener: _resource_record_post_action 08:26:18 INFO - ##### 08:26:18 INFO - ##### Running download-and-extract step. 08:26:18 INFO - ##### 08:26:18 INFO - Running pre-action listener: _resource_record_pre_action 08:26:18 INFO - Running main action method: download_and_extract 08:26:18 INFO - mkdir: /builds/slave/test/build/tests 08:26:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:18 INFO - https://queue.taskcluster.net/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:26:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/test_packages.json 08:26:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/test_packages.json 08:26:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:26:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:26:19 INFO - Downloaded 1302 bytes. 08:26:19 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:26:19 INFO - Using the following test package requirements: 08:26:19 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:26:19 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:26:19 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:26:19 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:26:19 INFO - u'jsshell-linux-x86_64.zip'], 08:26:19 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:26:19 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:26:19 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:26:19 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:26:19 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:26:19 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:26:19 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:26:19 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:26:19 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:26:19 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:26:19 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:26:19 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:26:19 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:26:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:19 INFO - https://queue.taskcluster.net/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:26:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:26:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:26:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/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 08:26:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/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 08:26:20 INFO - Downloaded 21870297 bytes. 08:26:20 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 08:26:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:26:20 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 08:26:22 INFO - Return code: 0 08:26:22 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 08:26:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:22 INFO - https://queue.taskcluster.net/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:26:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:26:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:26:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/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 08:26:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/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 08:26:23 INFO - Downloaded 21870297 bytes. 08:26:23 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 08:26:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:26:23 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 08:26:24 INFO - Return code: 0 08:26:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:24 INFO - https://queue.taskcluster.net/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:26:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:26:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:26:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/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 08:26:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/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 08:26:25 INFO - Downloaded 11132052 bytes. 08:26:25 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 08:26:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:26:25 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 08:26:25 INFO - Return code: 0 08:26:25 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')]} 08:26:25 INFO - https://queue.taskcluster.net/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:26:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:26:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:26:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/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 08:26:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/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 08:26:27 INFO - Downloaded 57750859 bytes. 08:26:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:26:27 INFO - mkdir: /builds/slave/test/properties 08:26:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:26:27 INFO - Writing to file /builds/slave/test/properties/build_url 08:26:27 INFO - Contents: 08:26:27 INFO - build_url:https://queue.taskcluster.net/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:26:27 INFO - Running post-action listener: _resource_record_post_action 08:26:27 INFO - Running post-action listener: set_extra_try_arguments 08:26:27 INFO - ##### 08:26:27 INFO - ##### Running populate-webroot step. 08:26:27 INFO - ##### 08:26:27 INFO - Running pre-action listener: _resource_record_pre_action 08:26:27 INFO - Running main action method: populate_webroot 08:26:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:26:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:26:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:26:27 INFO - '--tppagecycles', 08:26:27 INFO - '7'], 08:26:27 INFO - 'tests': ['tsvgm']}}, 08:26:27 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:26:27 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:26:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:26:27 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:26:27 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:26:27 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:26:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:26:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:27 INFO - 'talos_options': ['--e10s'], 08:26:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:26:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:27 INFO - 'tests': ['damp', 'tps']}, 08:26:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:27 INFO - 'talos_options': ['--e10s'], 08:26:27 INFO - 'tests': ['damp', 'tps']}, 08:26:27 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:26:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:26:27 INFO - 'other': {'tests': ['a11yr', 08:26:27 INFO - 'ts_paint', 08:26:27 INFO - 'tpaint', 08:26:27 INFO - 'sessionrestore', 08:26:27 INFO - 'sessionrestore_no_auto_restore']}, 08:26:27 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:26:27 INFO - 'tests': ['a11yr', 08:26:27 INFO - 'ts_paint', 08:26:27 INFO - 'tpaint', 08:26:27 INFO - 'sessionrestore', 08:26:27 INFO - 'sessionrestore_no_auto_restore']}, 08:26:27 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:26:27 INFO - 'tests': ['a11yr', 08:26:27 INFO - 'ts_paint', 08:26:27 INFO - 'tpaint', 08:26:27 INFO - 'sessionrestore', 08:26:27 INFO - 'sessionrestore_no_auto_restore']}, 08:26:27 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:26:27 INFO - 'tests': ['a11yr', 08:26:27 INFO - 'ts_paint', 08:26:27 INFO - 'tpaint', 08:26:27 INFO - 'sessionrestore', 08:26:27 INFO - 'sessionrestore_no_auto_restore']}, 08:26:27 INFO - 'other_l64': {'tests': ['a11yr', 08:26:27 INFO - 'ts_paint', 08:26:27 INFO - 'tpaint', 08:26:27 INFO - 'sessionrestore', 08:26:27 INFO - 'sessionrestore_no_auto_restore']}, 08:26:27 INFO - 'other_nol64': {'tests': ['a11yr', 08:26:27 INFO - 'ts_paint', 08:26:27 INFO - 'tpaint', 08:26:27 INFO - 'sessionrestore', 08:26:27 INFO - 'sessionrestore_no_auto_restore']}, 08:26:27 INFO - 'svgr': {'tests': ['tsvgx', 08:26:27 INFO - 'tsvgr_opacity', 08:26:27 INFO - 'tart', 08:26:27 INFO - 'tscrollx', 08:26:27 INFO - 'cart']}, 08:26:27 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:26:27 INFO - 'tests': ['tsvgx', 08:26:27 INFO - 'tsvgr_opacity', 08:26:27 INFO - 'tart', 08:26:27 INFO - 'tscrollx', 08:26:27 INFO - 'cart']}, 08:26:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:27 INFO - 'tests': ['tp5o']}, 08:26:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:27 INFO - 'talos_options': ['--e10s'], 08:26:27 INFO - 'tests': ['tp5o']}, 08:26:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:27 INFO - 'talos_options': ['--xperf_path', 08:26:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:26:27 INFO - 'tests': ['tp5n']}, 08:26:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:27 INFO - 'talos_options': ['--e10s', 08:26:27 INFO - '--xperf_path', 08:26:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:26:27 INFO - 'tests': ['tp5n']}}, 08:26:27 INFO - 'talos.zip': {'path': '', 08:26:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:26:27 INFO - Running post-action listener: _resource_record_post_action 08:26:27 INFO - ##### 08:26:27 INFO - ##### Running create-virtualenv step. 08:26:27 INFO - ##### 08:26:27 INFO - Running pre-action listener: _resource_record_pre_action 08:26:27 INFO - Running main action method: create_virtualenv 08:26:27 INFO - Creating virtualenv /builds/slave/test/build/venv 08:26:27 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 08:26:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:26:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:26:27 INFO - Using real prefix '/usr' 08:26:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:26:27 INFO - Installing distribute.............................................................................................................................................................................................done. 08:26:29 INFO - Installing pip.................done. 08:26:29 INFO - Return code: 0 08:26:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:26:29 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')]} 08:26:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:29 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')]} 08:26:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:29 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 0x7f47f72dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17860b0>, '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 0x1786fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1787440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1450283176.438375-1600336487', '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 08:26:29 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 08:26:29 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 08:26:29 INFO - Using env: {'DISPLAY': ':0', 08:26:29 INFO - 'HOME': '/home/cltbld', 08:26:29 INFO - 'LANG': 'en_US.UTF-8', 08:26:29 INFO - 'LANGUAGE': 'en_US:en', 08:26:29 INFO - 'LOGNAME': 'cltbld', 08:26:29 INFO - 'MAIL': '/var/mail/cltbld', 08:26:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:29 INFO - 'MOZ_NO_REMOTE': '1', 08:26:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:29 INFO - 'NO_EM_RESTART': '1', 08:26:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:29 INFO - 'PWD': '/builds/slave/test', 08:26:29 INFO - 'SHELL': '/bin/bash', 08:26:29 INFO - 'SHLVL': '1', 08:26:29 INFO - 'TERM': 'linux', 08:26:29 INFO - 'TMOUT': '86400', 08:26:29 INFO - 'USER': 'cltbld', 08:26:29 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1450283176.438375-1600336487', 08:26:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:29 INFO - '_': '/tools/buildbot/bin/python'} 08:26:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:30 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 08:26:30 INFO - Cleaning up... 08:26:30 INFO - Return code: 0 08:26:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:26:30 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')]} 08:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:30 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')]} 08:26:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:30 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 0x7f47f72dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17860b0>, '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 0x1786fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1787440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1450283176.438375-1600336487', '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 08:26:30 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 08:26:30 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 08:26:30 INFO - Using env: {'DISPLAY': ':0', 08:26:30 INFO - 'HOME': '/home/cltbld', 08:26:30 INFO - 'LANG': 'en_US.UTF-8', 08:26:30 INFO - 'LANGUAGE': 'en_US:en', 08:26:30 INFO - 'LOGNAME': 'cltbld', 08:26:30 INFO - 'MAIL': '/var/mail/cltbld', 08:26:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:30 INFO - 'MOZ_NO_REMOTE': '1', 08:26:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:30 INFO - 'NO_EM_RESTART': '1', 08:26:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:30 INFO - 'PWD': '/builds/slave/test', 08:26:30 INFO - 'SHELL': '/bin/bash', 08:26:30 INFO - 'SHLVL': '1', 08:26:30 INFO - 'TERM': 'linux', 08:26:30 INFO - 'TMOUT': '86400', 08:26:30 INFO - 'USER': 'cltbld', 08:26:30 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1450283176.438375-1600336487', 08:26:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:30 INFO - '_': '/tools/buildbot/bin/python'} 08:26:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:30 INFO - Downloading/unpacking psutil>=0.7.1 08:26:30 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 08:26:30 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 08:26:30 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 08:26:30 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 08:26:30 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 08:26:30 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 08:26:32 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 08:26:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:26:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:26:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:26:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:26:32 INFO - Installing collected packages: psutil 08:26:32 INFO - Running setup.py install for psutil 08:26:32 INFO - building 'psutil._psutil_linux' extension 08:26:32 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 08:26:32 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 08:26:32 INFO - building 'psutil._psutil_posix' extension 08:26:32 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 08:26:32 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 08:26:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:26:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:26:32 INFO - Successfully installed psutil 08:26:32 INFO - Cleaning up... 08:26:32 INFO - Return code: 0 08:26:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:26:32 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')]} 08:26:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:32 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')]} 08:26:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:32 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 0x7f47f72dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17860b0>, '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 0x1786fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1787440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1450283176.438375-1600336487', '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 08:26:32 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 08:26:32 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 08:26:32 INFO - Using env: {'DISPLAY': ':0', 08:26:32 INFO - 'HOME': '/home/cltbld', 08:26:32 INFO - 'LANG': 'en_US.UTF-8', 08:26:32 INFO - 'LANGUAGE': 'en_US:en', 08:26:32 INFO - 'LOGNAME': 'cltbld', 08:26:32 INFO - 'MAIL': '/var/mail/cltbld', 08:26:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:32 INFO - 'MOZ_NO_REMOTE': '1', 08:26:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:32 INFO - 'NO_EM_RESTART': '1', 08:26:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:32 INFO - 'PWD': '/builds/slave/test', 08:26:32 INFO - 'SHELL': '/bin/bash', 08:26:32 INFO - 'SHLVL': '1', 08:26:32 INFO - 'TERM': 'linux', 08:26:32 INFO - 'TMOUT': '86400', 08:26:32 INFO - 'USER': 'cltbld', 08:26:32 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1450283176.438375-1600336487', 08:26:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:32 INFO - '_': '/tools/buildbot/bin/python'} 08:26:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:26:32 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 08:26:32 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 08:26:32 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 08:26:32 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 08:26:32 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 08:26:32 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 08:26:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:26:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:26:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:26:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:26:34 INFO - Installing collected packages: mozsystemmonitor 08:26:34 INFO - Running setup.py install for mozsystemmonitor 08:26:34 INFO - Successfully installed mozsystemmonitor 08:26:34 INFO - Cleaning up... 08:26:34 INFO - Return code: 0 08:26:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:26:34 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')]} 08:26:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:34 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')]} 08:26:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:34 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 0x7f47f72dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17860b0>, '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 0x1786fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1787440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1450283176.438375-1600336487', '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 08:26:34 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 08:26:34 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 08:26:34 INFO - Using env: {'DISPLAY': ':0', 08:26:34 INFO - 'HOME': '/home/cltbld', 08:26:34 INFO - 'LANG': 'en_US.UTF-8', 08:26:34 INFO - 'LANGUAGE': 'en_US:en', 08:26:34 INFO - 'LOGNAME': 'cltbld', 08:26:34 INFO - 'MAIL': '/var/mail/cltbld', 08:26:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:34 INFO - 'MOZ_NO_REMOTE': '1', 08:26:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:34 INFO - 'NO_EM_RESTART': '1', 08:26:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:34 INFO - 'PWD': '/builds/slave/test', 08:26:34 INFO - 'SHELL': '/bin/bash', 08:26:34 INFO - 'SHLVL': '1', 08:26:34 INFO - 'TERM': 'linux', 08:26:34 INFO - 'TMOUT': '86400', 08:26:34 INFO - 'USER': 'cltbld', 08:26:34 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1450283176.438375-1600336487', 08:26:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:34 INFO - '_': '/tools/buildbot/bin/python'} 08:26:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:35 INFO - Downloading/unpacking blobuploader==1.2.4 08:26:35 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 08:26:35 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 08:26:35 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 08:26:35 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 08:26:35 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 08:26:35 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 08:26:36 INFO - Downloading blobuploader-1.2.4.tar.gz 08:26:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:26:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:26:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:26:36 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 08:26:36 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 08:26:36 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 08:26:36 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 08:26:36 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 08:26:36 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 08:26:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:26:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:26:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:26:37 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 08:26:37 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 08:26:37 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 08:26:37 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 08:26:37 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 08:26:37 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 08:26:37 INFO - Downloading docopt-0.6.1.tar.gz 08:26:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:26:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:26:37 INFO - Installing collected packages: blobuploader, requests, docopt 08:26:37 INFO - Running setup.py install for blobuploader 08:26:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:26:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:26:37 INFO - Running setup.py install for requests 08:26:37 INFO - Running setup.py install for docopt 08:26:37 INFO - Successfully installed blobuploader requests docopt 08:26:37 INFO - Cleaning up... 08:26:38 INFO - Return code: 0 08:26:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:26:38 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')]} 08:26:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:38 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')]} 08:26:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:38 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 0x7f47f72dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17860b0>, '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 0x1786fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1787440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1450283176.438375-1600336487', '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 08:26:38 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 08:26:38 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 08:26:38 INFO - Using env: {'DISPLAY': ':0', 08:26:38 INFO - 'HOME': '/home/cltbld', 08:26:38 INFO - 'LANG': 'en_US.UTF-8', 08:26:38 INFO - 'LANGUAGE': 'en_US:en', 08:26:38 INFO - 'LOGNAME': 'cltbld', 08:26:38 INFO - 'MAIL': '/var/mail/cltbld', 08:26:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:38 INFO - 'MOZ_NO_REMOTE': '1', 08:26:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:38 INFO - 'NO_EM_RESTART': '1', 08:26:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:38 INFO - 'PWD': '/builds/slave/test', 08:26:38 INFO - 'SHELL': '/bin/bash', 08:26:38 INFO - 'SHLVL': '1', 08:26:38 INFO - 'TERM': 'linux', 08:26:38 INFO - 'TMOUT': '86400', 08:26:38 INFO - 'USER': 'cltbld', 08:26:38 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1450283176.438375-1600336487', 08:26:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:38 INFO - '_': '/tools/buildbot/bin/python'} 08:26:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:26:38 INFO - Running setup.py (path:/tmp/pip-QoqDiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:26:38 INFO - Running setup.py (path:/tmp/pip-aD9aH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:26:38 INFO - Running setup.py (path:/tmp/pip-TlUclQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:26:38 INFO - Running setup.py (path:/tmp/pip-NI9QmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:26:38 INFO - Running setup.py (path:/tmp/pip-fsbIk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:26:38 INFO - Running setup.py (path:/tmp/pip-ai_pwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:26:38 INFO - Running setup.py (path:/tmp/pip-Fk8t7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:26:38 INFO - Running setup.py (path:/tmp/pip-c9Y1Th-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:26:38 INFO - Running setup.py (path:/tmp/pip-hCy9yN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:26:38 INFO - Running setup.py (path:/tmp/pip-wFQza8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:26:38 INFO - Running setup.py (path:/tmp/pip-wyVEJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:26:39 INFO - Running setup.py (path:/tmp/pip-Bgu1BU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:26:39 INFO - Running setup.py (path:/tmp/pip-mC6S_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:26:39 INFO - Running setup.py (path:/tmp/pip-sGWjnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:26:39 INFO - Running setup.py (path:/tmp/pip-hmAwiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:26:39 INFO - Running setup.py (path:/tmp/pip-dJ7sdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:26:39 INFO - Running setup.py (path:/tmp/pip-84ABw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:26:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:26:39 INFO - Running setup.py install for manifestparser 08:26:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:26:39 INFO - Running setup.py install for mozcrash 08:26:39 INFO - Running setup.py install for mozdebug 08:26:39 INFO - Running setup.py install for mozdevice 08:26:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:26:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:26:39 INFO - Running setup.py install for mozfile 08:26:39 INFO - Running setup.py install for mozhttpd 08:26:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:26:40 INFO - Running setup.py install for mozinfo 08:26:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:26:40 INFO - Running setup.py install for mozInstall 08:26:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:26:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:26:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:26:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:26:40 INFO - Running setup.py install for mozleak 08:26:40 INFO - Running setup.py install for mozlog 08:26:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:26:40 INFO - Running setup.py install for moznetwork 08:26:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:26:40 INFO - Running setup.py install for mozprocess 08:26:40 INFO - Running setup.py install for mozprofile 08:26:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:26:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:26:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:26:40 INFO - Running setup.py install for mozrunner 08:26:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:26:40 INFO - Running setup.py install for mozscreenshot 08:26:41 INFO - Running setup.py install for moztest 08:26:41 INFO - Running setup.py install for mozversion 08:26:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:26:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:26:41 INFO - Cleaning up... 08:26:41 INFO - Return code: 0 08:26:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:26: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')]} 08:26:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26: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')]} 08:26:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:41 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 0x7f47f72dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17860b0>, '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 0x1786fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1787440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1450283176.438375-1600336487', '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 08:26:41 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 08:26:41 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 08:26:41 INFO - Using env: {'DISPLAY': ':0', 08:26:41 INFO - 'HOME': '/home/cltbld', 08:26:41 INFO - 'LANG': 'en_US.UTF-8', 08:26:41 INFO - 'LANGUAGE': 'en_US:en', 08:26:41 INFO - 'LOGNAME': 'cltbld', 08:26:41 INFO - 'MAIL': '/var/mail/cltbld', 08:26:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:41 INFO - 'MOZ_NO_REMOTE': '1', 08:26:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:41 INFO - 'NO_EM_RESTART': '1', 08:26:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:41 INFO - 'PWD': '/builds/slave/test', 08:26:41 INFO - 'SHELL': '/bin/bash', 08:26:41 INFO - 'SHLVL': '1', 08:26:41 INFO - 'TERM': 'linux', 08:26:41 INFO - 'TMOUT': '86400', 08:26:41 INFO - 'USER': 'cltbld', 08:26:41 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1450283176.438375-1600336487', 08:26:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:41 INFO - '_': '/tools/buildbot/bin/python'} 08:26:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:26:41 INFO - Running setup.py (path:/tmp/pip-rigMA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:26:41 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)) 08:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:26:41 INFO - Running setup.py (path:/tmp/pip-QCjF81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:26:41 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)) 08:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:26:41 INFO - Running setup.py (path:/tmp/pip-rVxtSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:26:41 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)) 08:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:26:41 INFO - Running setup.py (path:/tmp/pip-aVEx5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:26:41 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)) 08:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:26:41 INFO - Running setup.py (path:/tmp/pip-cmL8nU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:26:41 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)) 08:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:26:41 INFO - Running setup.py (path:/tmp/pip-WhB9y8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:26:41 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)) 08:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:26:41 INFO - Running setup.py (path:/tmp/pip-nW3Oil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:26:41 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)) 08:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:26:41 INFO - Running setup.py (path:/tmp/pip-nQ2yFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:26:42 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)) 08:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:26:42 INFO - Running setup.py (path:/tmp/pip-gVUf4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:26:42 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)) 08:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:26:42 INFO - Running setup.py (path:/tmp/pip-5zDGIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:26:42 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)) 08:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:26:42 INFO - Running setup.py (path:/tmp/pip-i9tcMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:26:42 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)) 08:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:26:42 INFO - Running setup.py (path:/tmp/pip-gmMQ4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:26:42 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)) 08:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:26:42 INFO - Running setup.py (path:/tmp/pip-TKLbpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:26:42 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)) 08:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:26:42 INFO - Running setup.py (path:/tmp/pip-J4MYtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:26:42 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)) 08:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:26:42 INFO - Running setup.py (path:/tmp/pip-Aht27Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:26:42 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)) 08:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:26:42 INFO - Running setup.py (path:/tmp/pip-NnskCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:26:42 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)) 08:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:26:42 INFO - Running setup.py (path:/tmp/pip-CqKIfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:26:42 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)) 08:26:42 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)) 08:26:42 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)) 08:26:42 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)) 08:26:42 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)) 08:26:42 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)) 08:26:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:26:42 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 08:26:42 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 08:26:42 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 08:26:42 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 08:26:42 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 08:26:42 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 08:26:44 INFO - Downloading blessings-1.5.1.tar.gz 08:26:44 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 08:26:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:26:44 INFO - Installing collected packages: blessings 08:26:44 INFO - Running setup.py install for blessings 08:26:44 INFO - Successfully installed blessings 08:26:44 INFO - Cleaning up... 08:26:44 INFO - Return code: 0 08:26:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:26:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:26:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:26:44 INFO - Reading from file tmpfile_stdout 08:26:44 INFO - Current package versions: 08:26:44 INFO - argparse == 1.2.1 08:26:44 INFO - blessings == 1.5.1 08:26:44 INFO - blobuploader == 1.2.4 08:26:44 INFO - docopt == 0.6.1 08:26:44 INFO - manifestparser == 1.1 08:26:44 INFO - mozInstall == 1.12 08:26:44 INFO - mozcrash == 0.16 08:26:44 INFO - mozdebug == 0.1 08:26:44 INFO - mozdevice == 0.47 08:26:44 INFO - mozfile == 1.2 08:26:44 INFO - mozhttpd == 0.7 08:26:44 INFO - mozinfo == 0.9 08:26:44 INFO - mozleak == 0.1 08:26:44 INFO - mozlog == 3.1 08:26:44 INFO - moznetwork == 0.27 08:26:44 INFO - mozprocess == 0.22 08:26:44 INFO - mozprofile == 0.27 08:26:44 INFO - mozrunner == 6.11 08:26:44 INFO - mozscreenshot == 0.1 08:26:44 INFO - mozsystemmonitor == 0.0 08:26:44 INFO - moztest == 0.7 08:26:44 INFO - mozversion == 1.4 08:26:44 INFO - psutil == 3.1.1 08:26:44 INFO - requests == 1.2.3 08:26:44 INFO - wsgiref == 0.1.2 08:26:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:26: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')]} 08:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26: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')]} 08:26:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:44 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 0x7f47f72dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17860b0>, '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 0x1786fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1787440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1450283176.438375-1600336487', '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 08:26:44 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 08:26:44 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 08:26:44 INFO - Using env: {'DISPLAY': ':0', 08:26:44 INFO - 'HOME': '/home/cltbld', 08:26:44 INFO - 'LANG': 'en_US.UTF-8', 08:26:44 INFO - 'LANGUAGE': 'en_US:en', 08:26:44 INFO - 'LOGNAME': 'cltbld', 08:26:44 INFO - 'MAIL': '/var/mail/cltbld', 08:26:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:44 INFO - 'MOZ_NO_REMOTE': '1', 08:26:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:44 INFO - 'NO_EM_RESTART': '1', 08:26:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:44 INFO - 'PWD': '/builds/slave/test', 08:26:44 INFO - 'SHELL': '/bin/bash', 08:26:44 INFO - 'SHLVL': '1', 08:26:44 INFO - 'TERM': 'linux', 08:26:44 INFO - 'TMOUT': '86400', 08:26:44 INFO - 'USER': 'cltbld', 08:26:44 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1450283176.438375-1600336487', 08:26:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:44 INFO - '_': '/tools/buildbot/bin/python'} 08:26:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:45 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)) 08:26:45 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)) 08:26:45 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)) 08:26:45 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)) 08:26:45 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)) 08:26:45 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)) 08:26:45 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)) 08:26:45 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)) 08:26:45 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)) 08:26:45 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)) 08:26:45 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)) 08:26:45 INFO - Cleaning up... 08:26:45 INFO - Return code: 0 08:26:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:26: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')]} 08:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26: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')]} 08:26:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:45 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 0x7f47f72dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17860b0>, '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 0x1786fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1787440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1450283176.438375-1600336487', '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 08:26:45 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 08:26:45 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 08:26:45 INFO - Using env: {'DISPLAY': ':0', 08:26:45 INFO - 'HOME': '/home/cltbld', 08:26:45 INFO - 'LANG': 'en_US.UTF-8', 08:26:45 INFO - 'LANGUAGE': 'en_US:en', 08:26:45 INFO - 'LOGNAME': 'cltbld', 08:26:45 INFO - 'MAIL': '/var/mail/cltbld', 08:26:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:45 INFO - 'MOZ_NO_REMOTE': '1', 08:26:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:45 INFO - 'NO_EM_RESTART': '1', 08:26:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:45 INFO - 'PWD': '/builds/slave/test', 08:26:45 INFO - 'SHELL': '/bin/bash', 08:26:45 INFO - 'SHLVL': '1', 08:26:45 INFO - 'TERM': 'linux', 08:26:45 INFO - 'TMOUT': '86400', 08:26:45 INFO - 'USER': 'cltbld', 08:26:45 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1450283176.438375-1600336487', 08:26:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:45 INFO - '_': '/tools/buildbot/bin/python'} 08:26:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:45 INFO - Downloading/unpacking jsonschema 08:26:45 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 08:26:45 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 08:26:45 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 08:26:45 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 08:26:45 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 08:26:45 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 08:26:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:26:47 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 08:26:47 INFO - Downloading/unpacking functools32 (from jsonschema) 08:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:48 INFO - Downloading functools32-3.2.3-2.tar.gz 08:26:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 08:26:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:26:48 INFO - warning: no files found matching '*.txt' 08:26:48 INFO - no previously-included directories found matching 'build' 08:26:48 INFO - no previously-included directories found matching 'dist' 08:26:48 INFO - no previously-included directories found matching '.git*' 08:26:48 INFO - Installing collected packages: jsonschema, functools32 08:26:48 INFO - Running setup.py install for functools32 08:26:48 INFO - warning: no files found matching '*.txt' 08:26:48 INFO - no previously-included directories found matching 'build' 08:26:48 INFO - no previously-included directories found matching 'dist' 08:26:48 INFO - no previously-included directories found matching '.git*' 08:26:48 INFO - Successfully installed jsonschema functools32 08:26:48 INFO - Cleaning up... 08:26:48 INFO - Return code: 0 08:26:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:48 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 0x7f47f72dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17860b0>, '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 0x1786fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1787440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1450283176.438375-1600336487', '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 08:26:48 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 08:26:48 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 08:26:48 INFO - Using env: {'DISPLAY': ':0', 08:26:48 INFO - 'HOME': '/home/cltbld', 08:26:48 INFO - 'LANG': 'en_US.UTF-8', 08:26:48 INFO - 'LANGUAGE': 'en_US:en', 08:26:48 INFO - 'LOGNAME': 'cltbld', 08:26:48 INFO - 'MAIL': '/var/mail/cltbld', 08:26:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:48 INFO - 'MOZ_NO_REMOTE': '1', 08:26:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:48 INFO - 'NO_EM_RESTART': '1', 08:26:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:48 INFO - 'PWD': '/builds/slave/test', 08:26:48 INFO - 'SHELL': '/bin/bash', 08:26:48 INFO - 'SHLVL': '1', 08:26:48 INFO - 'TERM': 'linux', 08:26:48 INFO - 'TMOUT': '86400', 08:26:48 INFO - 'USER': 'cltbld', 08:26:48 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1450283176.438375-1600336487', 08:26:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:48 INFO - '_': '/tools/buildbot/bin/python'} 08:26:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:48 INFO - Downloading/unpacking flake8 08:26:48 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 08:26:48 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 08:26:48 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 08:26:48 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 08:26:48 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 08:26:48 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 08:26:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:26:50 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 08:26:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:26:50 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 08:26:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:50 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 08:26:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 08:26:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:26:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:26:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:26:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:26:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:26:50 INFO - no previously-included directories found matching 'docs/_build' 08:26:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:26:51 INFO - Running setup.py install for pep8 08:26:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:26:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:26:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:26:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:26:51 INFO - no previously-included directories found matching 'docs/_build' 08:26:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:26:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:26:51 INFO - Cleaning up... 08:26:51 INFO - Return code: 0 08:26:51 INFO - Running post-action listener: _resource_record_post_action 08:26:51 INFO - Running post-action listener: _start_resource_monitoring 08:26:51 INFO - Starting resource monitoring. 08:26:51 INFO - ##### 08:26:51 INFO - ##### Running install step. 08:26:51 INFO - ##### 08:26:51 INFO - Running pre-action listener: _resource_record_pre_action 08:26:51 INFO - Running main action method: install 08:26:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:26:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:26:51 INFO - Reading from file tmpfile_stdout 08:26:51 INFO - Detecting whether we're running mozinstall >=1.0... 08:26:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:26:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:26:51 INFO - Reading from file tmpfile_stdout 08:26:51 INFO - Output received: 08:26:51 INFO - Usage: mozinstall [options] installer 08:26:51 INFO - Options: 08:26:51 INFO - -h, --help show this help message and exit 08:26:51 INFO - -d DEST, --destination=DEST 08:26:51 INFO - Directory to install application into. [default: 08:26:51 INFO - "/builds/slave/test"] 08:26:51 INFO - --app=APP Application being installed. [default: firefox] 08:26:51 INFO - mkdir: /builds/slave/test/build/application 08:26:51 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'] 08:26:51 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 08:27:06 INFO - Reading from file tmpfile_stdout 08:27:06 INFO - Output received: 08:27:06 INFO - /builds/slave/test/build/application/firefox/firefox 08:27:06 INFO - Running post-action listener: _resource_record_post_action 08:27:06 INFO - ##### 08:27:06 INFO - ##### Running run-tests step. 08:27:06 INFO - ##### 08:27:06 INFO - Running pre-action listener: _resource_record_pre_action 08:27:06 INFO - Running main action method: run_tests 08:27:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:27:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:27:06 INFO - Python 2.7.3 08:27:06 INFO - Return code: 0 08:27:06 INFO - grabbing minidump binary from tooltool 08:27:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:27:06 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 0x17860b0>, '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 0x1786fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1787440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:27:06 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 08:27:06 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 08:27:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:27:06 INFO - Return code: 0 08:27:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:27:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:27:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:27:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:27:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:27:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:27:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:27:07 INFO - Return code: 0 08:27:07 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/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost'] in /builds/slave/test/build 08:27:07 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/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost 08:27:07 INFO - Using env: {'DISPLAY': ':0', 08:27:07 INFO - 'HOME': '/home/cltbld', 08:27:07 INFO - 'LANG': 'en_US.UTF-8', 08:27:07 INFO - 'LANGUAGE': 'en_US:en', 08:27:07 INFO - 'LOGNAME': 'cltbld', 08:27:07 INFO - 'MAIL': '/var/mail/cltbld', 08:27:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:27:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:27:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:07 INFO - 'MOZ_NO_REMOTE': '1', 08:27:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:27:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:27:07 INFO - 'NO_EM_RESTART': '1', 08:27:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:27:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:07 INFO - 'PWD': '/builds/slave/test', 08:27:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:27:07 INFO - 'SHELL': '/bin/bash', 08:27:07 INFO - 'SHLVL': '1', 08:27:07 INFO - 'TERM': 'linux', 08:27:07 INFO - 'TMOUT': '86400', 08:27:07 INFO - 'USER': 'cltbld', 08:27:07 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1450283176.438375-1600336487', 08:27:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:07 INFO - '_': '/tools/buildbot/bin/python'} 08:27:07 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/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost'] with output_timeout 3600 08:27:07 INFO - mozversion INFO | application_buildid: 20151216073608 08:27:07 INFO - mozversion INFO | application_changeset: ac9c0f02ef3357c1a6b7ca8f43781e9f15f86d63 08:27:07 INFO - mozversion INFO | application_display_name: Nightly 08:27:07 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:27:07 INFO - mozversion INFO | application_name: Firefox 08:27:07 INFO - mozversion INFO | application_remotingname: firefox 08:27:07 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 08:27:07 INFO - mozversion INFO | application_vendor: Mozilla 08:27:07 INFO - mozversion INFO | application_version: 46.0a1 08:27:07 INFO - mozversion INFO | platform_buildid: 20151216073608 08:27:07 INFO - mozversion INFO | platform_changeset: ac9c0f02ef3357c1a6b7ca8f43781e9f15f86d63 08:27:07 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 08:27:07 INFO - mozversion INFO | platform_version: 46.0a1 08:27:07 INFO - 2015-12-16 08:27:07,273 DEBUG : using testdate: 1450283227 08:27:07 INFO - 2015-12-16 08:27:07,273 DEBUG : actual date: 1450283227 08:27:07 INFO - 2015-12-16 08:27:07,297 INFO : starting webserver on 'localhost:45160' 08:27:07 INFO - 2015-12-16 08:27:07,298 INFO : Starting test suite talos-linux64-ix-048.e 08:27:07 INFO - 2015-12-16 08:27:07,298 INFO : Starting test dromaeo_css 08:27:07 INFO - 2015-12-16 08:27:07,298 DEBUG : operating with platform_type : linux_ 08:27:07 INFO - 2015-12-16 08:27:07,298 INFO : Initialising browser for dromaeo_css test... 08:27:07 INFO - 2015-12-16 08:27:07,312 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo4SJcZ/profile http://localhost:45160/getInfo.html 08:27:12 INFO - 2015-12-16 08:27:12,394 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:27:12 INFO - 2015-12-16 08:27:12,395 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:27:12 INFO - 2015-12-16 08:27:12,395 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:27:12 INFO - 2015-12-16 08:27:12,395 DEBUG : BROWSER_OUTPUT: __metrics 08:27:12 INFO - 2015-12-16 08:27:12,516 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] 08:27:13 INFO - 2015-12-16 08:27:13,458 INFO : Browser initialized. 08:27:13 INFO - 2015-12-16 08:27:13,459 INFO : Running cycle 1/1 for dromaeo_css test... 08:27:13 INFO - 2015-12-16 08:27:13,459 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo4SJcZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:27:25 INFO - 2015-12-16 08:27:25,443 DEBUG : BROWSER_OUTPUT: RSS: Main: 143417344 08:27:25 INFO - 2015-12-16 08:27:25,443 DEBUG : BROWSER_OUTPUT: 08:28:15 INFO - 2015-12-16 08:28:15,076 DEBUG : BROWSER_OUTPUT: 1450283295075 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] 08:30:26 INFO - 2015-12-16 08:30:26,870 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45160/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45160/tests/dromaeo/cssquery-ext.html) 08:30:27 INFO - 2015-12-16 08:30:27,914 DEBUG : BROWSER_OUTPUT: RSS: Main: 144642048 08:30:27 INFO - 2015-12-16 08:30:27,915 DEBUG : BROWSER_OUTPUT: 08:33:30 INFO - 2015-12-16 08:33:30,000 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45160/tests/dromaeo/cssquery-ext.html (next: http://localhost:45160/tests/dromaeo/cssquery-jquery.html) 08:33:30 INFO - 2015-12-16 08:33:30,602 DEBUG : BROWSER_OUTPUT: RSS: Main: 145342464 08:33:30 INFO - 2015-12-16 08:33:30,602 DEBUG : BROWSER_OUTPUT: 08:36:32 INFO - 2015-12-16 08:36:32,415 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45160/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45160/tests/dromaeo/cssquery-mootools.html) 08:36:33 INFO - 2015-12-16 08:36:33,016 DEBUG : BROWSER_OUTPUT: RSS: Main: 145440768 08:36:33 INFO - 2015-12-16 08:36:33,016 DEBUG : BROWSER_OUTPUT: 08:39:34 INFO - 2015-12-16 08:39:34,752 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45160/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45160/tests/dromaeo/cssquery-prototype.html) 08:39:35 INFO - 2015-12-16 08:39:35,358 DEBUG : BROWSER_OUTPUT: RSS: Main: 144498688 08:39:35 INFO - 2015-12-16 08:39:35,358 DEBUG : BROWSER_OUTPUT: 08:42:37 INFO - 2015-12-16 08:42:37,998 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45160/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45160/tests/dromaeo/cssquery-yui.html) 08:42:38 INFO - 2015-12-16 08:42:38,626 DEBUG : BROWSER_OUTPUT: RSS: Main: 143855616 08:42:38 INFO - 2015-12-16 08:42:38,626 DEBUG : BROWSER_OUTPUT: 08:45:40 INFO - 2015-12-16 08:45:40,902 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45160/tests/dromaeo/cssquery-yui.html (next: http://localhost:45160/tests/dromaeo/cssquery-dojo.html) 08:45:41 INFO - 2015-12-16 08:45:41,160 DEBUG : BROWSER_OUTPUT: RSS: Main: 147996672 08:45:41 INFO - 2015-12-16 08:45:41,160 DEBUG : BROWSER_OUTPUT: 08:45:41 INFO - 2015-12-16 08:45:41,160 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:45:41 INFO - 2015-12-16 08:45:41,160 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:45:41 INFO - 2015-12-16 08:45:41,160 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:45:41 INFO - 2015-12-16 08:45:41,161 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:45:41 INFO - 2015-12-16 08:45:41,161 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2682.342826007628;2707.769839563637;2737.1651646247897;2753.201571544252;2759.613654088428;4697.953020469794;4783.497732738065;4825.2279635258365;4827.082854257688;4866.878328041801;4636.629069674426;4739.928901066478;4773.832915847946;4779.426468823746;4797.760111994404;4421.535738747433;4425.269830477975;4501.819927202908;4502.729836209822;4511.661625378093;4258.893527661802;4466.776661166945;4521.638268938494;4576.199165146103;4587.15137699525;4388.670849686287;4422.358757980091;4451.9777401113115;4482;4487.057717879249;4422.535633758441;4424.159409712144;4431.069475410168;4484.148011877733;4524.3213517972235;4279.40088387626;4348.152110338485;4425.579569940883;4430.9556904430865;4462.308342206963;4615.100055489181;4660.37084993525;4672.3925889634465;4673.205555055649;4688.320193571913;5167.612429067835;5206.427292997767;5222.8694282642855;5232.686038837682;5257.684538927639;4994.450610432849;5078.695278283278;5081.136206844808;5281.419043905167;5296.655717378358;4720.575148236675;4723.315119307716;4738.763061846894;4770.61835053195;4821.734804585782;5268.552173065255;5317.282166907496;5328.0675881720545;5333.12003519415;5365.195220716846;4926.4088309403105;5037.19404895215;5088.872778180576;5093.159628661229;5102.464241254689;5050.545450909436;5128.179491281452;5133.076046311699;5150.4334523202415;5151.716655583904;5138.871528211825;5185.533302002837;5188.169892817131;5196.45437229093;5240.213967904845;4888.877778055506;4938.308636790852;5140.254663073908;5164.225366195101;5165.974170129125;4214.199302132585;4237.427947227146;4258.148370325947;4281.636060934793;4295.463067116611;3746.1571146492365;3747.662710356081;3751.0809851586537;3778.017715394017;3781.978865706244;4308.116836048603;4376.584224498668;4399.5820397062225;4455.910881782411;4467.374567560544;5200.193969934666;5206.557442617344;5209.114450543341;5221.947780522146;5223.503767142115;4480.910381792346;4485.259932111165;4496.3705081288645;4516.164509565675;4524.321351797257;4379.934300985424;4474.530174331713;4486.753228572395;4557.293619488984;4582.610478109332;4925.975370123127;4935.679180853233;4938.629602779734;4946.62900282473;5004.799808007639;5215.45237750046;5215.869603259949;5221.556167725786;5225.268462415341;5228.320318358741;4743.952560474351;4809.903801923872;4851.126797176542;4857.6599638025;4862.586680132228;5131.818272670818;5207.583393328448;5218;5219.712915789516;5272.947270527246;4988.152014157675;5276.894462110813;5286.577073834007;5290.338707661543;5305.12465443213;4892.461829198856;4904.852854414374;4953.554180123806;4966.528179822911;4999.575036121825;5027.824026159067;5035.219540971156;5052.469490703424;5065.848024559269;5091.109055915274;4719.2921061841;4901.681390709592;4946.480619534897;4955.454899961073;4973.950260497349;4893.168161412497;4967.925481117858;4989.625778066587;5004.299398084198;5054.545090941833;4946.406431228132;4946.629002824874;4947.925781113214;4953.405591329064;4960.7767650456535 08:45:41 INFO - 2015-12-16 08:45:41,161 DEBUG : BROWSER_OUTPUT: |1;ext.html;548.0655482402505;551.495381725721;554.5979165105298;566.7534622439237;615.587556337254;36025.81987090064;36680.44979325312;36715.44926826096;36762.26475470489;36885;36588.451173232424;37153.62846371535;37157.81421092898;37159.25681486375;37272.25455490888;7759.534427934328;7914.28771410573;7935.761927142195;7941.36469082472;7968.12350641429;7741.690332386698;7840.686372545091;7854.214578542129;7864.252895974902;7864.4888082274465;7652.502587331805;7706.7302644407455;7728.420368472359;7742.8451430971345;7756.0692716874055;7792.610369481532;7869.48848324857;7879.330256928168;7901.960490197513;7931.24653157952;7732.768016959444;7847.568383738892;7875.251851074138;7877.054753429625;7886.369090472748;34784.47823282653;35293.29413411743;35393.11517212065;35406.64593354059;35467.113322167155;2832.9575056373965;2842.2325971987652;2875.0656036788127;2990.491616425213;3232.385846689145;27680.446391072066;28206.717932820615;28267.717322826713;28394.574081388797;28938.71061289381;3315.5855518060243;3341.565596472443;3385.0860267727576;3402.574678165229;3430.8456119474686;206814;208280;208632;208808;210315;54365;54531.18203226955;54589.72705136449;54690.72654636701;54697.72651136798;63013;63771.681141593996;64032;64157;64391.356086438536;13357.732845343233;13415.597532073858;13553.796693049415;13575.52485662997;13599.728005440034;10674.946625266979;10683.786324273471;10692.411917344622;10699.090577300862;10711.78576428467;19564.21743130259;19948.401547953585;19964.101615427342;20020.399388018384;20026.299079532146;7813.960930195312;8087.150849160871;8174.509529428254;8179.386546009073;8264.917350826414;856.5246288309924;872.4547158026234;889.3196704521047;970.5593670438172;1020.0717347213999;26328.47343053128;26398.472030559282;26635.33411664724;26638.866805665846;29853.253668658457;984.3650845204803;986.5018165826211;1014.5130337437923;1055.5250137438184;1094.370736826328;14426.711465770626;14437.494687685881;14479.710405791826;14661.853381466262;14762.261886905611;285494;288487;289516;289751;290439;47647.28529072067;47725.284120738215;48008.03983920302;48101.518984810406;48151.27773083407;1260.0864373329264;1261.0983147050088;1278.1180985120238;1286.9356532173354;1292.8901043411227;26455.33861653474;26745.06392276261;27180.864095679393;27276;30804.691953081077;43586;44287.11425771531;44362.556374435844;44389.77805110954;44481;242693;242811;244851;246936;247004;39259.41110883396;40964.38553421761;41749.956251093965;41966.1606767869;42008.36987445252;38550.2289954205;39292.60707392889;39514.40728389134;39520.407193892686;39781.60218397895;33392.1651958703;33960.15099622529;34010.31979360448;34154.48768268428;34359.828200858836;33578.3284334307;33746.66253337533;33801.83099084489;33977.66022339745;34235.4864677025;33476.49785253272;33590.49614255837;33943.83028084844;33985.490217646264;34046.48930265998;28423.71576284211;30291.21359830021;30785.538216926318;30808.53787193149;30845;24134;24163.15428959978;24217.51564968726;24247.636285456087;24325.344779619194 08:45:41 INFO - 2015-12-16 08:45:41,161 DEBUG : BROWSER_OUTPUT: |2;jquery.html;342.8937029520849;344.50219432919425;344.50735448308916;346.2123668653814;346.81272113058964;12485.5005799768;14843.703125937474;15440;16020.59948501288;16529.752053719203;15369.770418366532;15580.610484737887;15627.609309767233;15653;15982;4494.640428765691;4620.630349572026;4625.606823420013;4626.398568186131;4636.721796692193;4446.97776511117;4455.443069616298;4476.350929115276;4491.1242307749835;4492.910141797179;4387.956120438803;4497.14554234696;4847.200211965039;4982.227754698028;5000.149974504325;4971.751412429364;5008.874778130539;5019.347484826967;5025.597952163818;5053.823116190934;4991.875203119915;5008.5993120550265;5040.6471546991725;5044.949550504484;5045.596352291808;11113.166512511594;11235.662930112028;11329.716757081056;11506.137039722054;11650.592229272019;1821.6994195957784;1853.4254381141889;1881.7271495633192;1914.3873960332699;1940.602176553803;8807.559622018873;9017.774555636095;9071.773205669844;9111.225545828545;9210.539473026389;1722.810490846006;1765.3732924811636;1785.4108144312345;1794.4168145352683;1820.2718912435;49471.50528494705;49901.25148122781;50774;55283.170752438746;59306.703466482824;9147.679831205876;9480.810383792286;9973.900260997443;9983.60065597368;9991.250656200815;12426.75146497065;12429.937850310691;12444.75110497785;12463.75072498545;12463.937680311541;6912;6974.79075627732;7083.256258092929;7085.397741192057;7087.787366379017;6739.326067393222;6741.831454213684;6776.627285499345;6783.321667833177;6791.558548694319;4173.311403618369;4176;4206.8737937861915;4220.662347012231;4241.384999175102;1709.623882745794;1726.7323564847468;1734.0376091269213;1764.514758441439;1771.7076682347526;409.05100167611454;815.7702313504498;869.2437579305918;927.9860802087974;970.8640790289365;9230.76923076915;9536.141747242642;9571.569279382444;9696.369735967139;9761.707148785548;396.21944768805406;406.0863058119232;414.0745433955108;416.2382839403884;434.3072798885772;5268.2097685346735;5299.33758280215;5305.283786688748;5331.306930099062;5338.519533242027;477480;479879;491909;500802;508672;69143;69865.65067174632;72298;72871.63564182146;73061;438.4497455693085;441.457007880309;441.99337009944236;443.5586591341571;447.50997657564915;8588.441751286146;8630.352723545633;8709.216170544682;8741;8831.072737362741;30850;30884.53673194859;31070.378592427573;31084.533731993586;31195.84402077975;43573.78213109041;44544.331835021854;44816;45282;46738.065238695715;8426.452280601741;8623.611937462954;8720.215180633773;9096;9146.405483643543;15920.442784502487;16206.351745930031;16283.511494655178;16391.918040410197;16676.749848752035;2440.2435245074084;10571.2600117991;13328.534581009202;13555.390007449885;14089.577312680636;12714.427850746924;12747.745045099231;12759.106862519535;13279.86720132825;13367.799483007957;13249.47002119943;13629.454821807016;13751.862481375458;14016.579502614937;14155.363008664428;8776.254018408252;8851.69019084329;8929.151730585583;8995.325350598861;9005.81988360216;13174.40715167839;13471.393787279792;13724.725505490034;13827;13991.440342386191 08:45:41 INFO - 2015-12-16 08:45:41,161 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1509.6527798606328;1629.3156874112874;1711.2556038123416;1724.3447489953824;1753.4476639858444;6081.118237855509;6235.563510554263;7061.2232654408035;7251.3836323912465;7269.982202491648;6761.763338283161;6966.4078553323025;7015.298470152982;7053.506254562183;7069.434445244381;2065.7004734313514;2098.422933693239;2099.191811152702;2101.4956410461455;2104.032145213204;2067.607154640621;2098.9790102098937;2105.1368938735122;2107.473131717071;2111.229401268541;1983.4842940835415;2012.657848165808;2041.9795802041938;2042.458748431667;2043.9080241389174;2077.9999999999923;2079.2099002379073;2094.1518684932626;2094.675325324577;2104.3581707579183;2003.3489116037347;2005.2279872249144;2038.9592208155902;2039.9796002040086;2046;7098.3256590623805;7152.070230870006;7173.0675012248075;7180.964095179543;7197.172325182619;4023.657989070903;4079.1637714268504;4096.938545921814;4100.200460910124;4102.979485102585;2666.280104371828;2729.849858257795;2730.276476733667;2737.4935636907235;2760.3651160233258;825.8100636853497;837.2632083766308;839.7354833227574;861.9439736417113;874.4534665833854;9821.410715357102;9824.459654718987;9835.114839664464;9854.458004809732;9860.852087218698;3890.513685789276;3898.941515877264;3944.5660977292473;3945.487086678771;3948.309045916953;8431.494110353398;8483.321334293241;8486.19381158789;8496.447730897471;8519.659213631385;4238.682098842599;4244.808983595745;4256.382824490432;4265.4241677373775;4270.316749320094;3772.603876592973;3845.692344612424;3846.826892789831;3875.5930627284292;3892.4550562921213;3112.579801726783;3136.7961082529564;3147.3390587976323;3209.743220542351;3235.3044095519576;958.9616415343309;963.8650588917557;970.4662435660358;970.8689326940914;976.5898322704481;1201.195199216527;1205.3430880170329;1208.957686480969;1221.780079585683;1228.969275768113;6638.900416493757;6674.699638516278;6690.163729533809;6693.364130407604;6771.932280677229;441.52977079410323;441.71067950492477;446.2636649528304;450.49544510148843;452.0687383988993;5319.601029922771;5322.121849894801;5378.9462105379225;5406.702631355313;5413.106837371868;8270.131636178116;8414.579271036546;8422.199891010345;8510.48937063778;8650.826983460296;8313.958430207811;8355.080941096474;8377.120402357787;8383.496990180609;8407.873881891777;6666.633335166613;6687.632180230037;6764.458843292525;6801.421879140328;6807.285235050347;6794.93205067943;6835.863282734417;6841.281665425058;6854.897176542256;6872.6907289173105;7634.656440460081;7671.194524575062;7831.2560306770765;7841.607919604111;7863.41024423182;7786.221377862168;7999.4400391972;8037.156098609562;8045.155258697987;8057.153998830273;5144.151215049625;5188.377394712658;6411.71147298382;6494.64279464634;6504.512161587805;6735.427488663322;6841.350071743176;6886.793396198122;6887.586744795329;6897.310268973062;6261.467775238973;6267.185265915402;6374.649394283359;6409.391107844747;6420.2937676856445;6364.140840986408;6412.23053233615;6428.8071357859335;6502.869942601027;6507.902381464187;6360.300366959538;6413.903791443039;6418.93581064202;6431.935680643133;6433.581817181868;5974.880502390015;6062.181605483203;6064.302605200459;6076.088586712029;6076.665783381956;6076.118962750465;6105.175801266772;6114.5414093942245;6117.051856962178;6137.324894261538 08:45:41 INFO - 2015-12-16 08:45:41,162 DEBUG : BROWSER_OUTPUT: |4;prototype.html;307.2595045939286;312.302005018783;315.96524382317943;316.2930849551251;317.1342235696547;5528.834134975952;5590.7204639768;5645.1814486899375;5694.430556944303;5702.3157221133415;5538.556915446765;5562.7774889004495;5579.330480342354;5582.804601838937;5588.077967135428;4149.937750933738;4277;4305.05288836457;4325;4326.199653064177;4268.253055715253;4284.785760711968;4294.506131794837;4295.828166873322;4303.053328267776;4239.046214601705;4242.512111107231;4254.383114448403;4256.829726810924;4258.233517966764;4253.064325848309;4256.574342565734;4257.659387249013;4261.083866968616;4267.594578515067;3618.2582570572968;3699.6300369963055;3701.0932321581117;3703.518542589473;3709.4806727058235;5281.181416880389;5394.460553944574;5405.459454054602;5414.5668346532575;5417.51242388187;4851.636127290467;4861;4861.562459378673;4861.975690121527;4865.3918260217115;5905.734241959122;5907.645541267495;5915.645061296336;5923.555733320019;5928.436798504135;3912.452256684038;3948.9732669505847;3991.2815693175216;3995.2808494470983;3997.1805779815068;6145.938540614581;6169;6187.319394866561;6200.007998720228;6209.068639704035;4150.584941505826;4165.333546632524;4167.395727619478;4169.061961058737;4177.97911010443;4198.992241861931;4229.069604686964;4230.027093768451;4235.237657221668;4237.533871274158;4758.809647614056;4819.59033482151;4858.076965376567;4862.732549709729;4867.464578896389;5860.941390586125;5866.266716660418;5867;5871.794487192928;5894;1466.3035058347414;1478.1648368671665;1484.665950161205;1488.8287846897529;1488.8734457571227;983.8032393521324;984.9310548261697;987.6197663899451;999.9850002249972;1005.4671024357102;5137.537621614073;5138.049460849755;5148.845534633967;5150.201718733528;5162.793488260502;6110.602810817282;6116.969415152896;6118.3269840317525;6122.051082082285;6124.11200375943;5132.153194722903;5146.433892271847;5158.071547121479;5161.483851614808;5165.199394093921;3261.3314270574474;3309.3546758382367;3314.834258287076;3318.4856347266214;3334.8832790852202;5671.262735844396;5770.221020162225;5778.797742079007;5782.10377391505;5856.326522449973;6324.968375158095;6341.492680585542;6360.268569114519;6369.363063693593;6391.201099862517;5814;5819.796307129315;5821.621594596338;5834.416558344216;5838.9124163137585;6011.248593925759;6173.629582225081;6177.135201071944;6180.412860778219;6199.938000619936;6008.609440386361;6011.489023433057;6016.849578760566;6031.849203769941;6034.396560344106;5832.1543376209365;5841.561882858718;5847.327557330961;5848.941510584839;5853.678047707417;4140.4617399737845;4180.728252663567;4183.602557757008;4185.204811085884;4185.66514678831;6046.395360463918;6155.076738489262;6160.199174107337;6162.537809664203;6167.722452489559;5896.056630939029;5914.290285165807;5921.940780592139;5935.732892019956;5942.851428714317;5936.901673190474;5939.376365481735;5940.732667029907;5944.048952167633;5954.583179177416;5624.212610234488;5772.787714579985;5796;5817.447342502455;5825.475707186373;5941.643501389931;5942.227510423617;5965.7471930895;5984;6006.339302676614;5817.476427121579;5835.824925252249;5851.912221316768;5858.179854820243;5860.2967643883 08:45:41 INFO - 2015-12-16 08:45:41,162 DEBUG : BROWSER_OUTPUT: |5;yui.html;773.2151865856157;774.2721841469018;783.1111688233852;786.3434032582793;791.7466410748556;11520.654380368593;11567.190296679215;11664.241824281416;11696.883031169697;11713.70715732107;11219.495122719476;11543.884561154386;11690.123240756935;11765;11776.411179441015;812.4069429316603;827.2761333832897;827.404268926375;827.6234313387395;829.0134739659816;825.2119226139023;829.1335554345724;829.8423299573062;830.7341650671788;831.9084900660922;857.1385757313891;858.6608289725555;858.9785255368603;865.4936861935744;867.9913200867974;851.2041241439274;853.1937319233327;853.2534032721369;853.63293783673;854.4915775113798;633.0599060395309;633.8510450044236;635.7933671556763;637.6620391192629;637.7767781276563;12088.879111208864;12105.334206618632;12175.93912030443;12190.756184876342;12304;10821.296615719953;11267.774644507146;11663.825042624367;11710.238834475731;11891.456126120329;9276.953615231949;9397.342186046979;9419.905800941971;9471.526423678857;9476.099770521789;3140.2463408781955;3231.4991176367703;3236.6116066072223;3243.416185086707;3307.3219989902013;36086.278274434364;37258;37272.62727372719;37344.626553734386;38294;8741.868871966926;8908.883034249588;9064.909350906539;9098.909010909807;9159.404638698463;14818.073650425376;14890.106593604418;14932.178730169728;15003.624909377135;15055.171965542;5743.253377060955;5767.798127065616;5788.18965344852;5889.941100589025;5977.581569290108;3565.893023209308;3583.516225309602;3590.9640903591153;3640.690541304019;3643.854245830137;2570.0362364113457;2574.7811436027773;2582.083360407066;2598.7141414444395;2614.830036047651;454.4637327952981;464.17145395468924;468.60871172570603;469.1227404753133;476.77114984807486;528.0231571592523;581.4127730991644;582.2140110850319;608.1971797227617;645.7578408096964;7861.882071768928;7883.093444253869;8177.264046235868;8223.136570660114;8237.752867413987;604.280905722198;606.7785258380748;612.2194202391986;613.7238242790672;633.499535367064;3776.754510956779;3825.885223443301;3900.7854567998465;3909.7654140751647;3941.684665226775;45501.54498454973;46572;46649;50931;51491.48508514867;38441;38573.80713096417;38665;39053.41419878704;39773.80113099474;40952.38571421431;43705.78147109244;43833;44208.557914420446;44344.55655443469;7837.25546073145;7975.521468711896;8068.99137607799;8088.433809633269;8332.16678332162;30277.848610756806;30580.388392231587;30791.2302192447;31308.060758177293;31912.202194945312;37393;38007.2398552033;39485.40771888482;39561.60438395579;39929.40105898472;10421.270511064153;10435.582576696846;10513.158947284046;10540.472976351306;10615.203859710708;11102.61140860066;11436.771264574496;11560.30638161713;11713.765724685629;11773.646790595953;10912.890871091187;10916.345019298868;10968;11292.661220163409;11688.70778230551;10600.893991059991;10737;10768.192385570957;10806.189535785004;11145.72135696614;10677.412742298937;10688.732781680521;10776.245662803529;10858;11051.115910726961;9317.34778565494;9416.670416535388;9462.810743785223;9829.361091529028;9890;9190.264778817813;9246.4914429707;9337.206337461392;9377.156055954996;9451.858222126812 08:45:41 INFO - 2015-12-16 08:45:41,162 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:45:41 INFO - 2015-12-16 08:45:41,162 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:45:41 INFO - 2015-12-16 08:45:41,162 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,335 08:45:41 INFO - 2015-12-16 08:45:41,162 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:45:41 INFO - 2015-12-16 08:45:41,163 DEBUG : BROWSER_OUTPUT: __startTimestamp1450284341153__endTimestamp 08:45:41 INFO - 2015-12-16 08:45:41,163 DEBUG : BROWSER_OUTPUT: 08:45:41 INFO - 2015-12-16 08:45:41,163 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:45:41 INFO - 2015-12-16 08:45:41,163 DEBUG : BROWSER_OUTPUT: Number of tests: 6 08:45:41 INFO - 2015-12-16 08:45:41,163 DEBUG : BROWSER_OUTPUT: 08:45:41 INFO - 2015-12-16 08:45:41,163 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4755.81 Median:4892.46 stddev:509.89 (10.4%) stddev-sans-first:484.82 08:45:41 INFO - 2015-12-16 08:45:41,164 DEBUG : BROWSER_OUTPUT: Values: 2682.3 2707.8 2737.2 2753.2 2759.6 4698.0 4783.5 4825.2 4827.1 4866.9 4636.6 4739.9 4773.8 4779.4 4797.8 4421.5 4425.3 4501.8 4502.7 4511.7 4258.9 4466.8 4521.6 4576.2 4587.2 4388.7 4422.4 4452.0 4482.0 4487.1 4422.5 4424.2 4431.1 4484.1 4524.3 4279.4 4348.2 4425.6 4431.0 4462.3 4615.1 4660.4 4672.4 4673.2 4688.3 5167.6 5206.4 5222.9 5232.7 5257.7 4994.5 5078.7 5081.1 5281.4 5296.7 4720.6 4723.3 4738.8 4770.6 4821.7 5268.6 5317.3 5328.1 5333.1 5365.2 4926.4 5037.2 5088.9 5093.2 5102.5 5050.5 5128.2 5133.1 5150.4 5151.7 5138.9 5185.5 5188.2 5196.5 5240.2 4888.9 4938.3 5140.3 5164.2 5166.0 4214.2 4237.4 4258.1 4281.6 4295.5 3746.2 3747.7 3751.1 3778.0 3782.0 4308.1 4376.6 4399.6 4455.9 4467.4 5200.2 5206.6 5209.1 5221.9 5223.5 4480.9 4485.3 4496.4 4516.2 4524.3 4379.9 4474.5 4486.8 4557.3 4582.6 4926.0 4935.7 4938.6 4946.6 5004.8 5215.5 5215.9 5221.6 5225.3 5228.3 4744.0 4809.9 4851.1 4857.7 4862.6 5131.8 5207.6 5218.0 5219.7 5272.9 4988.2 5276.9 5286.6 5290.3 5305.1 4892.5 4904.9 4953.6 4966.5 4999.6 5027.8 5035.2 5052.5 5065.8 5091.1 4719.3 4901.7 4946.5 4955.5 4974.0 4893.2 4967.9 4989.6 5004.3 5054.5 4946.4 4946.6 4947.9 4953.4 4960.8 08:45:41 INFO - 2015-12-16 08:45:41,164 DEBUG : BROWSER_OUTPUT: 08:45:41 INFO - 2015-12-16 08:45:41,164 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41598.43 Median:34194.99 stddev:65076.43 (190.3%) stddev-sans-first:65186.00 08:45:41 INFO - 2015-12-16 08:45:41,164 DEBUG : BROWSER_OUTPUT: Values: 548.1 551.5 554.6 566.8 615.6 36025.8 36680.4 36715.4 36762.3 36885.0 36588.5 37153.6 37157.8 37159.3 37272.3 7759.5 7914.3 7935.8 7941.4 7968.1 7741.7 7840.7 7854.2 7864.3 7864.5 7652.5 7706.7 7728.4 7742.8 7756.1 7792.6 7869.5 7879.3 7902.0 7931.2 7732.8 7847.6 7875.3 7877.1 7886.4 34784.5 35293.3 35393.1 35406.6 35467.1 2833.0 2842.2 2875.1 2990.5 3232.4 27680.4 28206.7 28267.7 28394.6 28938.7 3315.6 3341.6 3385.1 3402.6 3430.8 206814.0 208280.0 208632.0 208808.0 210315.0 54365.0 54531.2 54589.7 54690.7 54697.7 63013.0 63771.7 64032.0 64157.0 64391.4 13357.7 13415.6 13553.8 13575.5 13599.7 10674.9 10683.8 10692.4 10699.1 10711.8 19564.2 19948.4 19964.1 20020.4 20026.3 7814.0 8087.2 8174.5 8179.4 8264.9 856.5 872.5 889.3 970.6 1020.1 26328.5 26398.5 26635.3 26638.9 29853.3 984.4 986.5 1014.5 1055.5 1094.4 14426.7 14437.5 14479.7 14661.9 14762.3 285494.0 288487.0 289516.0 289751.0 290439.0 47647.3 47725.3 48008.0 48101.5 48151.3 1260.1 1261.1 1278.1 1286.9 1292.9 26455.3 26745.1 27180.9 27276.0 30804.7 43586.0 44287.1 44362.6 44389.8 44481.0 242693.0 242811.0 244851.0 246936.0 247004.0 39259.4 40964.4 41750.0 41966.2 42008.4 38550.2 39292.6 39514.4 39520.4 39781.6 33392.2 33960.2 34010.3 34154.5 34359.8 33578.3 33746.7 33801.8 33977.7 34235.5 33476.5 33590.5 33943.8 33985.5 34046.5 28423.7 30291.2 30785.5 30808.5 30845.0 24134.0 24163.2 24217.5 24247.6 24325.3 08:45:41 INFO - 2015-12-16 08:45:41,165 DEBUG : BROWSER_OUTPUT: 08:45:41 INFO - 2015-12-16 08:45:41,165 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25650.98 Median:2461.93 stddev:80441.17 (3267.4%) stddev-sans-first:80644.38 08:45:41 INFO - 2015-12-16 08:45:41,166 DEBUG : BROWSER_OUTPUT: Values: 342.9 344.5 344.5 346.2 346.8 12485.5 14843.7 15440.0 16020.6 16529.8 15369.8 15580.6 15627.6 15653.0 15982.0 4494.6 4620.6 4625.6 4626.4 4636.7 4447.0 4455.4 4476.4 4491.1 4492.9 4388.0 4497.1 4847.2 4982.2 5000.1 4971.8 5008.9 5019.3 5025.6 5053.8 4991.9 5008.6 5040.6 5044.9 5045.6 11113.2 11235.7 11329.7 11506.1 11650.6 1821.7 1853.4 1881.7 1914.4 1940.6 8807.6 9017.8 9071.8 9111.2 9210.5 1722.8 1765.4 1785.4 1794.4 1820.3 49471.5 49901.3 50774.0 55283.2 59306.7 9147.7 9480.8 9973.9 9983.6 9991.3 12426.8 12429.9 12444.8 12463.8 12463.9 6912.0 6974.8 7083.3 7085.4 7087.8 6739.3 6741.8 6776.6 6783.3 6791.6 4173.3 4176.0 4206.9 4220.7 4241.4 1709.6 1726.7 1734.0 1764.5 1771.7 409.1 815.8 869.2 928.0 970.9 9230.8 9536.1 9571.6 9696.4 9761.7 396.2 406.1 414.1 416.2 434.3 5268.2 5299.3 5305.3 5331.3 5338.5 477480.0 479879.0 491909.0 500802.0 508672.0 69143.0 69865.7 72298.0 72871.6 73061.0 438.4 441.5 442.0 443.6 447.5 8588.4 8630.4 8709.2 8741.0 8831.1 30850.0 30884.5 31070.4 31084.5 31195.8 43573.8 44544.3 44816.0 45282.0 46738.1 8426.5 8623.6 8720.2 9096.0 9146.4 15920.4 16206.4 16283.5 16391.9 16676.7 2440.2 10571.3 13328.5 13555.4 14089.6 12714.4 12747.7 12759.1 13279.9 13367.8 13249.5 13629.5 13751.9 14016.6 14155.4 8776.3 8851.7 8929.2 8995.3 9005.8 13174.4 13471.4 13724.7 13827.0 13991.4 08:45:41 INFO - 2015-12-16 08:45:41,166 DEBUG : BROWSER_OUTPUT: 08:45:41 INFO - 2015-12-16 08:45:41,166 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4974.85 Median:6313.74 stddev:2615.91 (41.4%) stddev-sans-first:2610.29 08:45:41 INFO - 2015-12-16 08:45:41,166 DEBUG : BROWSER_OUTPUT: Values: 1509.7 1629.3 1711.3 1724.3 1753.4 6081.1 6235.6 7061.2 7251.4 7270.0 6761.8 6966.4 7015.3 7053.5 7069.4 2065.7 2098.4 2099.2 2101.5 2104.0 2067.6 2099.0 2105.1 2107.5 2111.2 1983.5 2012.7 2042.0 2042.5 2043.9 2078.0 2079.2 2094.2 2094.7 2104.4 2003.3 2005.2 2039.0 2040.0 2046.0 7098.3 7152.1 7173.1 7181.0 7197.2 4023.7 4079.2 4096.9 4100.2 4103.0 2666.3 2729.8 2730.3 2737.5 2760.4 825.8 837.3 839.7 861.9 874.5 9821.4 9824.5 9835.1 9854.5 9860.9 3890.5 3898.9 3944.6 3945.5 3948.3 8431.5 8483.3 8486.2 8496.4 8519.7 4238.7 4244.8 4256.4 4265.4 4270.3 3772.6 3845.7 3846.8 3875.6 3892.5 3112.6 3136.8 3147.3 3209.7 3235.3 959.0 963.9 970.5 970.9 976.6 1201.2 1205.3 1209.0 1221.8 1229.0 6638.9 6674.7 6690.2 6693.4 6771.9 441.5 441.7 446.3 450.5 452.1 5319.6 5322.1 5378.9 5406.7 5413.1 8270.1 8414.6 8422.2 8510.5 8650.8 8314.0 8355.1 8377.1 8383.5 8407.9 6666.6 6687.6 6764.5 6801.4 6807.3 6794.9 6835.9 6841.3 6854.9 6872.7 7634.7 7671.2 7831.3 7841.6 7863.4 7786.2 7999.4 8037.2 8045.2 8057.2 5144.2 5188.4 6411.7 6494.6 6504.5 6735.4 6841.4 6886.8 6887.6 6897.3 6261.5 6267.2 6374.6 6409.4 6420.3 6364.1 6412.2 6428.8 6502.9 6507.9 6360.3 6413.9 6418.9 6431.9 6433.6 5974.9 6062.2 6064.3 6076.1 6076.7 6076.1 6105.2 6114.5 6117.1 6137.3 08:45:41 INFO - 2015-12-16 08:45:41,166 DEBUG : BROWSER_OUTPUT: 08:45:41 INFO - 2015-12-16 08:45:41,166 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4878.16 Median:5585.44 stddev:1460.39 (26.1%) stddev-sans-first:1423.61 08:45:41 INFO - 2015-12-16 08:45:41,166 DEBUG : BROWSER_OUTPUT: Values: 307.3 312.3 316.0 316.3 317.1 5528.8 5590.7 5645.2 5694.4 5702.3 5538.6 5562.8 5579.3 5582.8 5588.1 4149.9 4277.0 4305.1 4325.0 4326.2 4268.3 4284.8 4294.5 4295.8 4303.1 4239.0 4242.5 4254.4 4256.8 4258.2 4253.1 4256.6 4257.7 4261.1 4267.6 3618.3 3699.6 3701.1 3703.5 3709.5 5281.2 5394.5 5405.5 5414.6 5417.5 4851.6 4861.0 4861.6 4862.0 4865.4 5905.7 5907.6 5915.6 5923.6 5928.4 3912.5 3949.0 3991.3 3995.3 3997.2 6145.9 6169.0 6187.3 6200.0 6209.1 4150.6 4165.3 4167.4 4169.1 4178.0 4199.0 4229.1 4230.0 4235.2 4237.5 4758.8 4819.6 4858.1 4862.7 4867.5 5860.9 5866.3 5867.0 5871.8 5894.0 1466.3 1478.2 1484.7 1488.8 1488.9 983.8 984.9 987.6 1000.0 1005.5 5137.5 5138.0 5148.8 5150.2 5162.8 6110.6 6117.0 6118.3 6122.1 6124.1 5132.2 5146.4 5158.1 5161.5 5165.2 3261.3 3309.4 3314.8 3318.5 3334.9 5671.3 5770.2 5778.8 5782.1 5856.3 6325.0 6341.5 6360.3 6369.4 6391.2 5814.0 5819.8 5821.6 5834.4 5838.9 6011.2 6173.6 6177.1 6180.4 6199.9 6008.6 6011.5 6016.8 6031.8 6034.4 5832.2 5841.6 5847.3 5848.9 5853.7 4140.5 4180.7 4183.6 4185.2 4185.7 6046.4 6155.1 6160.2 6162.5 6167.7 5896.1 5914.3 5921.9 5935.7 5942.9 5936.9 5939.4 5940.7 5944.0 5954.6 5624.2 5772.8 5796.0 5817.4 5825.5 5941.6 5942.2 5965.7 5984.0 6006.3 5817.5 5835.8 5851.9 5858.2 5860.3 08:45:41 INFO - 2015-12-16 08:45:41,166 DEBUG : BROWSER_OUTPUT: 08:45:41 INFO - 2015-12-16 08:45:41,166 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12035.68 Median:42329.08 stddev:13280.12 (31.4%) stddev-sans-first:13290.44 08:45:41 INFO - 2015-12-16 08:45:41,168 DEBUG : BROWSER_OUTPUT: Values: 773.2 774.3 783.1 786.3 791.7 11520.7 11567.2 11664.2 11696.9 11713.7 11219.5 11543.9 11690.1 11765.0 11776.4 812.4 827.3 827.4 827.6 829.0 825.2 829.1 829.8 830.7 831.9 857.1 858.7 859.0 865.5 868.0 851.2 853.2 853.3 853.6 854.5 633.1 633.9 635.8 637.7 637.8 12088.9 12105.3 12175.9 12190.8 12304.0 10821.3 11267.8 11663.8 11710.2 11891.5 9277.0 9397.3 9419.9 9471.5 9476.1 3140.2 3231.5 3236.6 3243.4 3307.3 36086.3 37258.0 37272.6 37344.6 38294.0 8741.9 8908.9 9064.9 9098.9 9159.4 14818.1 14890.1 14932.2 15003.6 15055.2 5743.3 5767.8 5788.2 5889.9 5977.6 3565.9 3583.5 3591.0 3640.7 3643.9 2570.0 2574.8 2582.1 2598.7 2614.8 454.5 464.2 468.6 469.1 476.8 528.0 581.4 582.2 608.2 645.8 7861.9 7883.1 8177.3 8223.1 8237.8 604.3 606.8 612.2 613.7 633.5 3776.8 3825.9 3900.8 3909.8 3941.7 45501.5 46572.0 46649.0 50931.0 51491.5 38441.0 38573.8 38665.0 39053.4 39773.8 40952.4 43705.8 43833.0 44208.6 44344.6 7837.3 7975.5 8069.0 8088.4 8332.2 30277.8 30580.4 30791.2 31308.1 31912.2 37393.0 38007.2 39485.4 39561.6 39929.4 10421.3 10435.6 10513.2 10540.5 10615.2 11102.6 11436.8 11560.3 11713.8 11773.6 10912.9 10916.3 10968.0 11292.7 11688.7 10600.9 10737.0 10768.2 10806.2 11145.7 10677.4 10688.7 10776.2 10858.0 11051.1 9317.3 9416.7 9462.8 9829.4 9890.0 9190.3 9246.5 9337.2 9377.2 9451.9 08:45:41 INFO - 2015-12-16 08:45:41,168 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:45:41 INFO - 2015-12-16 08:45:41,168 DEBUG : BROWSER_OUTPUT: 08:45:41 INFO - 2015-12-16 08:45:41,935 INFO : Browser exited with error code: 0 08:45:41 INFO - 2015-12-16 08:45:41,956 INFO : Completed test dromaeo_css (00:18:34) 08:45:41 INFO - 2015-12-16 08:45:41,956 INFO : Starting test kraken 08:45:41 INFO - 2015-12-16 08:45:41,956 DEBUG : operating with platform_type : linux_ 08:45:41 INFO - 2015-12-16 08:45:41,956 INFO : Initialising browser for kraken test... 08:45:41 INFO - 2015-12-16 08:45:41,962 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjZnOLX/profile http://localhost:45160/getInfo.html 08:45:46 INFO - 2015-12-16 08:45:46,502 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:45:46 INFO - 2015-12-16 08:45:46,502 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:45:46 INFO - 2015-12-16 08:45:46,502 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:45:46 INFO - 2015-12-16 08:45:46,502 DEBUG : BROWSER_OUTPUT: __metrics 08:45:46 INFO - 2015-12-16 08:45:46,659 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] 08:45:47 INFO - 2015-12-16 08:45:47,559 INFO : Browser initialized. 08:45:47 INFO - 2015-12-16 08:45:47,559 INFO : Running cycle 1/1 for kraken test... 08:45:47 INFO - 2015-12-16 08:45:47,560 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjZnOLX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:45:59 INFO - 2015-12-16 08:45:59,581 DEBUG : BROWSER_OUTPUT: RSS: Main: 143298560 08:45:59 INFO - 2015-12-16 08:45:59,581 DEBUG : BROWSER_OUTPUT: 08:46:02 INFO - 2015-12-16 08:46:02,197 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45160/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45160/tests/kraken/driver.html?testName=audio-beat-detection) 08:46:02 INFO - 2015-12-16 08:46:02,820 DEBUG : BROWSER_OUTPUT: RSS: Main: 143683584 08:46:02 INFO - 2015-12-16 08:46:02,820 DEBUG : BROWSER_OUTPUT: 08:46:05 INFO - 2015-12-16 08:46:05,578 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45160/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45160/tests/kraken/driver.html?testName=audio-dft) 08:46:06 INFO - 2015-12-16 08:46:06,166 DEBUG : BROWSER_OUTPUT: RSS: Main: 144240640 08:46:06 INFO - 2015-12-16 08:46:06,166 DEBUG : BROWSER_OUTPUT: 08:46:09 INFO - 2015-12-16 08:46:09,078 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45160/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45160/tests/kraken/driver.html?testName=audio-fft) 08:46:09 INFO - 2015-12-16 08:46:09,663 DEBUG : BROWSER_OUTPUT: RSS: Main: 137584640 08:46:09 INFO - 2015-12-16 08:46:09,663 DEBUG : BROWSER_OUTPUT: 08:46:11 INFO - 2015-12-16 08:46:11,750 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45160/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45160/tests/kraken/driver.html?testName=audio-oscillator) 08:46:12 INFO - 2015-12-16 08:46:12,378 DEBUG : BROWSER_OUTPUT: RSS: Main: 138629120 08:46:12 INFO - 2015-12-16 08:46:12,378 DEBUG : BROWSER_OUTPUT: 08:46:14 INFO - 2015-12-16 08:46:14,664 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45160/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45160/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:46:15 INFO - 2015-12-16 08:46:15,250 DEBUG : BROWSER_OUTPUT: RSS: Main: 139145216 08:46:15 INFO - 2015-12-16 08:46:15,250 DEBUG : BROWSER_OUTPUT: 08:46:18 INFO - 2015-12-16 08:46:18,277 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45160/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45160/tests/kraken/driver.html?testName=imaging-darkroom) 08:46:18 INFO - 2015-12-16 08:46:18,870 DEBUG : BROWSER_OUTPUT: RSS: Main: 140292096 08:46:18 INFO - 2015-12-16 08:46:18,870 DEBUG : BROWSER_OUTPUT: 08:46:22 INFO - 2015-12-16 08:46:22,361 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45160/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45160/tests/kraken/driver.html?testName=imaging-desaturate) 08:46:22 INFO - 2015-12-16 08:46:22,963 DEBUG : BROWSER_OUTPUT: RSS: Main: 138944512 08:46:22 INFO - 2015-12-16 08:46:22,963 DEBUG : BROWSER_OUTPUT: 08:46:25 INFO - 2015-12-16 08:46:25,911 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45160/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45160/tests/kraken/driver.html?testName=json-parse-financial) 08:46:26 INFO - 2015-12-16 08:46:26,512 DEBUG : BROWSER_OUTPUT: RSS: Main: 139714560 08:46:26 INFO - 2015-12-16 08:46:26,513 DEBUG : BROWSER_OUTPUT: 08:46:28 INFO - 2015-12-16 08:46:28,283 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45160/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45160/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:46:28 INFO - 2015-12-16 08:46:28,872 DEBUG : BROWSER_OUTPUT: RSS: Main: 140574720 08:46:28 INFO - 2015-12-16 08:46:28,873 DEBUG : BROWSER_OUTPUT: 08:46:30 INFO - 2015-12-16 08:46:30,784 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45160/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45160/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:46:31 INFO - 2015-12-16 08:46:31,405 DEBUG : BROWSER_OUTPUT: RSS: Main: 139739136 08:46:31 INFO - 2015-12-16 08:46:31,406 DEBUG : BROWSER_OUTPUT: 08:46:33 INFO - 2015-12-16 08:46:33,559 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45160/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45160/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:46:34 INFO - 2015-12-16 08:46:34,152 DEBUG : BROWSER_OUTPUT: RSS: Main: 140091392 08:46:34 INFO - 2015-12-16 08:46:34,152 DEBUG : BROWSER_OUTPUT: 08:46:36 INFO - 2015-12-16 08:46:36,740 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45160/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45160/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:46:37 INFO - 2015-12-16 08:46:37,341 DEBUG : BROWSER_OUTPUT: RSS: Main: 140824576 08:46:37 INFO - 2015-12-16 08:46:37,341 DEBUG : BROWSER_OUTPUT: 08:46:40 INFO - 2015-12-16 08:46:40,017 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45160/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45160/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:46:40 INFO - 2015-12-16 08:46:40,610 DEBUG : BROWSER_OUTPUT: RSS: Main: 140500992 08:46:40 INFO - 2015-12-16 08:46:40,610 DEBUG : BROWSER_OUTPUT: 08:46:42 INFO - 2015-12-16 08:46:42,399 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45160/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45160/tests/kraken/driver.html?testName=ai-astar) 08:46:42 INFO - 2015-12-16 08:46:42,645 DEBUG : BROWSER_OUTPUT: RSS: Main: 141418496 08:46:42 INFO - 2015-12-16 08:46:42,645 DEBUG : BROWSER_OUTPUT: 08:46:42 INFO - 2015-12-16 08:46:42,649 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:46:42 INFO - 2015-12-16 08:46:42,649 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:46:42 INFO - 2015-12-16 08:46:42,649 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:46:42 INFO - 2015-12-16 08:46:42,649 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:46:42 INFO - 2015-12-16 08:46:42,649 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;109;113;113;116;125;115;114;115;115 08:46:42 INFO - 2015-12-16 08:46:42,649 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;169;131;152;164;132;152;151;132;167;135 08:46:42 INFO - 2015-12-16 08:46:42,650 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;163;164;162;165;166;169;163;164;164 08:46:42 INFO - 2015-12-16 08:46:42,650 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;74;73;74;73;141;73;73;75 08:46:42 INFO - 2015-12-16 08:46:42,650 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;138;95;96;97;133;96;95;140 08:46:42 INFO - 2015-12-16 08:46:42,650 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;109;110;110;110;110;109;110 08:46:42 INFO - 2015-12-16 08:46:42,650 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;148;147;147;148;147;148;151;149;149 08:46:42 INFO - 2015-12-16 08:46:42,650 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;97;96;97;96;97;96;95;96 08:46:42 INFO - 2015-12-16 08:46:42,650 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;75;74;74;75;73;77;76;83;72 08:46:42 INFO - 2015-12-16 08:46:42,650 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;68;68;69;70;67;67;69;68 08:46:42 INFO - 2015-12-16 08:46:42,651 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;86;87;87;87;88;87;86;87;85 08:46:42 INFO - 2015-12-16 08:46:42,651 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;126;129;122;127;125;126;133;128;127;129 08:46:42 INFO - 2015-12-16 08:46:42,651 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;151;165;150;151;145;152;153;157;140 08:46:42 INFO - 2015-12-16 08:46:42,651 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;70;73;71;73;69;77;69;70;70 08:46:42 INFO - 2015-12-16 08:46:42,651 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:46:42 INFO - 2015-12-16 08:46:42,651 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:46:42 INFO - 2015-12-16 08:46:42,651 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,783 08:46:42 INFO - 2015-12-16 08:46:42,652 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:46:42 INFO - 2015-12-16 08:46:42,652 DEBUG : BROWSER_OUTPUT: __startTimestamp1450284402647__endTimestamp 08:46:42 INFO - 2015-12-16 08:46:42,652 DEBUG : BROWSER_OUTPUT: 08:46:42 INFO - 2015-12-16 08:46:42,659 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:46:42 INFO - 2015-12-16 08:46:42,660 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:46:42 INFO - 2015-12-16 08:46:42,660 DEBUG : BROWSER_OUTPUT: 08:46:42 INFO - 2015-12-16 08:46:42,660 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:115.00 Median:115.00 stddev:4.03 (3.5%) stddev-sans-first:4.27 08:46:42 INFO - 2015-12-16 08:46:42,660 DEBUG : BROWSER_OUTPUT: Values: 115.0 109.0 113.0 113.0 116.0 125.0 115.0 114.0 115.0 115.0 08:46:42 INFO - 2015-12-16 08:46:42,660 DEBUG : BROWSER_OUTPUT: 08:46:42 INFO - 2015-12-16 08:46:42,660 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.50 Median:152.00 stddev:15.15 (10.0%) stddev-sans-first:14.14 08:46:42 INFO - 2015-12-16 08:46:42,660 DEBUG : BROWSER_OUTPUT: Values: 169.0 131.0 152.0 164.0 132.0 152.0 151.0 132.0 167.0 135.0 08:46:42 INFO - 2015-12-16 08:46:42,660 DEBUG : BROWSER_OUTPUT: 08:46:42 INFO - 2015-12-16 08:46:42,660 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.30 Median:164.00 stddev:2.00 (1.2%) stddev-sans-first:2.07 08:46:42 INFO - 2015-12-16 08:46:42,661 DEBUG : BROWSER_OUTPUT: Values: 163.0 163.0 164.0 162.0 165.0 166.0 169.0 163.0 164.0 164.0 08:46:42 INFO - 2015-12-16 08:46:42,661 DEBUG : BROWSER_OUTPUT: 08:46:42 INFO - 2015-12-16 08:46:42,661 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.10 Median:73.00 stddev:21.41 (29.3%) stddev-sans-first:22.51 08:46:42 INFO - 2015-12-16 08:46:42,661 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 74.0 73.0 74.0 73.0 141.0 73.0 73.0 75.0 08:46:42 INFO - 2015-12-16 08:46:42,661 DEBUG : BROWSER_OUTPUT: 08:46:42 INFO - 2015-12-16 08:46:42,661 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:108.00 Median:95.00 stddev:20.09 (21.2%) stddev-sans-first:20.76 08:46:42 INFO - 2015-12-16 08:46:42,661 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 138.0 95.0 96.0 97.0 133.0 96.0 95.0 140.0 08:46:42 INFO - 2015-12-16 08:46:42,661 DEBUG : BROWSER_OUTPUT: 08:46:42 INFO - 2015-12-16 08:46:42,661 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:46:42 INFO - 2015-12-16 08:46:42,662 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 109.0 110.0 110.0 110.0 110.0 109.0 110.0 08:46:42 INFO - 2015-12-16 08:46:42,662 DEBUG : BROWSER_OUTPUT: 08:46:42 INFO - 2015-12-16 08:46:42,662 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:1.23 (0.8%) stddev-sans-first:1.30 08:46:42 INFO - 2015-12-16 08:46:42,662 DEBUG : BROWSER_OUTPUT: Values: 148.0 148.0 147.0 147.0 148.0 147.0 148.0 151.0 149.0 149.0 08:46:42 INFO - 2015-12-16 08:46:42,662 DEBUG : BROWSER_OUTPUT: 08:46:42 INFO - 2015-12-16 08:46:42,662 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 08:46:42 INFO - 2015-12-16 08:46:42,662 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 97.0 96.0 97.0 96.0 97.0 96.0 95.0 96.0 08:46:42 INFO - 2015-12-16 08:46:42,662 DEBUG : BROWSER_OUTPUT: 08:46:42 INFO - 2015-12-16 08:46:42,663 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:75.30 Median:75.00 stddev:3.06 (4.1%) stddev-sans-first:3.21 08:46:42 INFO - 2015-12-16 08:46:42,663 DEBUG : BROWSER_OUTPUT: Values: 74.0 75.0 74.0 74.0 75.0 73.0 77.0 76.0 83.0 72.0 08:46:42 INFO - 2015-12-16 08:46:42,663 DEBUG : BROWSER_OUTPUT: 08:46:42 INFO - 2015-12-16 08:46:42,663 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.99 (1.5%) stddev-sans-first:0.97 08:46:42 INFO - 2015-12-16 08:46:42,663 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 68.0 68.0 69.0 70.0 67.0 67.0 69.0 68.0 08:46:42 INFO - 2015-12-16 08:46:42,663 DEBUG : BROWSER_OUTPUT: 08:46:42 INFO - 2015-12-16 08:46:42,663 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:87.00 stddev:0.84 (1.0%) stddev-sans-first:0.87 08:46:42 INFO - 2015-12-16 08:46:42,663 DEBUG : BROWSER_OUTPUT: Values: 86.0 86.0 87.0 87.0 87.0 88.0 87.0 86.0 87.0 85.0 08:46:42 INFO - 2015-12-16 08:46:42,663 DEBUG : BROWSER_OUTPUT: 08:46:42 INFO - 2015-12-16 08:46:42,663 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.20 Median:127.50 stddev:2.90 (2.3%) stddev-sans-first:3.04 08:46:42 INFO - 2015-12-16 08:46:42,664 DEBUG : BROWSER_OUTPUT: Values: 126.0 129.0 122.0 127.0 125.0 126.0 133.0 128.0 127.0 129.0 08:46:42 INFO - 2015-12-16 08:46:42,664 DEBUG : BROWSER_OUTPUT: 08:46:42 INFO - 2015-12-16 08:46:42,664 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.50 Median:151.50 stddev:7.40 (4.9%) stddev-sans-first:7.00 08:46:42 INFO - 2015-12-16 08:46:42,664 DEBUG : BROWSER_OUTPUT: Values: 141.0 151.0 165.0 150.0 151.0 145.0 152.0 153.0 157.0 140.0 08:46:42 INFO - 2015-12-16 08:46:42,664 DEBUG : BROWSER_OUTPUT: 08:46:42 INFO - 2015-12-16 08:46:42,664 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.30 Median:71.00 stddev:2.45 (3.5%) stddev-sans-first:2.60 08:46:42 INFO - 2015-12-16 08:46:42,664 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 73.0 71.0 73.0 69.0 77.0 69.0 70.0 70.0 08:46:42 INFO - 2015-12-16 08:46:42,664 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:46:42 INFO - 2015-12-16 08:46:42,664 DEBUG : BROWSER_OUTPUT: 08:46:43 INFO - 2015-12-16 08:46:43,547 INFO : Browser exited with error code: 0 08:46:43 INFO - 2015-12-16 08:46:43,598 INFO : Completed test kraken (00:01:01) 08:46:43 INFO - 2015-12-16 08:46:43,598 INFO : Starting test v8_7 08:46:43 INFO - 2015-12-16 08:46:43,598 DEBUG : operating with platform_type : linux_ 08:46:43 INFO - 2015-12-16 08:46:43,598 INFO : Initialising browser for v8_7 test... 08:46:43 INFO - 2015-12-16 08:46:43,604 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLp_5QM/profile http://localhost:45160/getInfo.html 08:46:48 INFO - 2015-12-16 08:46:48,189 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:46:48 INFO - 2015-12-16 08:46:48,190 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:46:48 INFO - 2015-12-16 08:46:48,190 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:46:48 INFO - 2015-12-16 08:46:48,190 DEBUG : BROWSER_OUTPUT: __metrics 08:46:48 INFO - 2015-12-16 08:46:48,306 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] 08:46:49 INFO - 2015-12-16 08:46:49,199 INFO : Browser initialized. 08:46:49 INFO - 2015-12-16 08:46:49,199 INFO : Running cycle 1/1 for v8_7 test... 08:46:49 INFO - 2015-12-16 08:46:49,199 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLp_5QM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:47:01 INFO - 2015-12-16 08:47:01,288 DEBUG : BROWSER_OUTPUT: RSS: Main: 143376384 08:47:01 INFO - 2015-12-16 08:47:01,288 DEBUG : BROWSER_OUTPUT: 08:47:22 INFO - 2015-12-16 08:47:22,675 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45160/tests/v8_7/run.html (next: http://localhost:45160/tests/v8_7/run.html) 08:47:22 INFO - 2015-12-16 08:47:22,925 DEBUG : BROWSER_OUTPUT: RSS: Main: 138260480 08:47:22 INFO - 2015-12-16 08:47:22,926 DEBUG : BROWSER_OUTPUT: 08:47:22 INFO - 2015-12-16 08:47:22,926 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:47:22 INFO - 2015-12-16 08:47:22,926 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:47:22 INFO - 2015-12-16 08:47:22,926 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:47:22 INFO - 2015-12-16 08:47:22,926 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:47:22 INFO - 2015-12-16 08:47:22,926 DEBUG : BROWSER_OUTPUT: |0;Richards;165.80998176090202 08:47:22 INFO - 2015-12-16 08:47:22,927 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.59762435040832 08:47:22 INFO - 2015-12-16 08:47:22,927 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.00945232137894 08:47:22 INFO - 2015-12-16 08:47:22,927 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5138.461538461538 08:47:22 INFO - 2015-12-16 08:47:22,927 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1063.8297872340424 08:47:22 INFO - 2015-12-16 08:47:22,927 DEBUG : BROWSER_OUTPUT: |5;Earley;700.2801120448179 08:47:22 INFO - 2015-12-16 08:47:22,927 DEBUG : BROWSER_OUTPUT: |6;Boyer;11858.823529411764 08:47:22 INFO - 2015-12-16 08:47:22,927 DEBUG : BROWSER_OUTPUT: |7;RegExp;26605.263157894737 08:47:22 INFO - 2015-12-16 08:47:22,928 DEBUG : BROWSER_OUTPUT: |8;Splay;600.9615384615385 08:47:22 INFO - 2015-12-16 08:47:22,928 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 08:47:22 INFO - 2015-12-16 08:47:22,928 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:47:22 INFO - 2015-12-16 08:47:22,928 DEBUG : BROWSER_OUTPUT: __startTimestamp1450284442924__endTimestamp 08:47:22 INFO - 2015-12-16 08:47:22,928 DEBUG : BROWSER_OUTPUT: 08:47:22 INFO - 2015-12-16 08:47:22,929 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:47:22 INFO - 2015-12-16 08:47:22,929 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:47:22 INFO - 2015-12-16 08:47:22,929 DEBUG : BROWSER_OUTPUT: 08:47:22 INFO - 2015-12-16 08:47:22,930 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.81 Median:165.81 stddev:0.00 (0.0%) 08:47:22 INFO - 2015-12-16 08:47:22,930 DEBUG : BROWSER_OUTPUT: Values: 165.8 08:47:22 INFO - 2015-12-16 08:47:22,930 DEBUG : BROWSER_OUTPUT: 08:47:22 INFO - 2015-12-16 08:47:22,930 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.60 Median:185.60 stddev:0.00 (0.0%) 08:47:22 INFO - 2015-12-16 08:47:22,930 DEBUG : BROWSER_OUTPUT: Values: 185.6 08:47:22 INFO - 2015-12-16 08:47:22,931 DEBUG : BROWSER_OUTPUT: 08:47:22 INFO - 2015-12-16 08:47:22,931 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.01 Median:278.01 stddev:0.00 (0.0%) 08:47:22 INFO - 2015-12-16 08:47:22,931 DEBUG : BROWSER_OUTPUT: Values: 278.0 08:47:22 INFO - 2015-12-16 08:47:22,932 DEBUG : BROWSER_OUTPUT: 08:47:22 INFO - 2015-12-16 08:47:22,932 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5138.46 Median:5138.46 stddev:0.00 (0.0%) 08:47:22 INFO - 2015-12-16 08:47:22,932 DEBUG : BROWSER_OUTPUT: Values: 5138.5 08:47:22 INFO - 2015-12-16 08:47:22,932 DEBUG : BROWSER_OUTPUT: 08:47:22 INFO - 2015-12-16 08:47:22,932 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1063.83 Median:1063.83 stddev:0.00 (0.0%) 08:47:22 INFO - 2015-12-16 08:47:22,932 DEBUG : BROWSER_OUTPUT: Values: 1063.8 08:47:22 INFO - 2015-12-16 08:47:22,932 DEBUG : BROWSER_OUTPUT: 08:47:22 INFO - 2015-12-16 08:47:22,932 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:700.28 Median:700.28 stddev:0.00 (0.0%) 08:47:22 INFO - 2015-12-16 08:47:22,932 DEBUG : BROWSER_OUTPUT: Values: 700.3 08:47:22 INFO - 2015-12-16 08:47:22,932 DEBUG : BROWSER_OUTPUT: 08:47:22 INFO - 2015-12-16 08:47:22,932 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11858.82 Median:11858.82 stddev:0.00 (0.0%) 08:47:22 INFO - 2015-12-16 08:47:22,932 DEBUG : BROWSER_OUTPUT: Values: 11858.8 08:47:22 INFO - 2015-12-16 08:47:22,932 DEBUG : BROWSER_OUTPUT: 08:47:22 INFO - 2015-12-16 08:47:22,932 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26605.26 Median:26605.26 stddev:0.00 (0.0%) 08:47:22 INFO - 2015-12-16 08:47:22,933 DEBUG : BROWSER_OUTPUT: Values: 26605.3 08:47:22 INFO - 2015-12-16 08:47:22,933 DEBUG : BROWSER_OUTPUT: 08:47:22 INFO - 2015-12-16 08:47:22,933 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:600.96 Median:600.96 stddev:0.00 (0.0%) 08:47:22 INFO - 2015-12-16 08:47:22,933 DEBUG : BROWSER_OUTPUT: Values: 601.0 08:47:22 INFO - 2015-12-16 08:47:22,933 DEBUG : BROWSER_OUTPUT: 08:47:22 INFO - 2015-12-16 08:47:22,933 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 08:47:22 INFO - 2015-12-16 08:47:22,933 DEBUG : BROWSER_OUTPUT: Values: 4830.9 08:47:22 INFO - 2015-12-16 08:47:22,933 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:47:22 INFO - 2015-12-16 08:47:22,933 DEBUG : BROWSER_OUTPUT: 08:47:23 INFO - 2015-12-16 08:47:23,887 INFO : Browser exited with error code: 0 08:47:23 INFO - 2015-12-16 08:47:23,905 INFO : Completed test v8_7 (00:00:40) 08:47:23 INFO - 2015-12-16 08:47:23,966 INFO : Completed test suite (00:20:16) 08:47:23 INFO - 2015-12-16 08:47:23,966 DEBUG : Working with test: dromaeo_css 08:47:23 INFO - 2015-12-16 08:47:23,966 DEBUG : Generating results file: dromaeo_css 08:47:23 INFO - 2015-12-16 08:47:23,968 DEBUG : Working with test: kraken 08:47:23 INFO - 2015-12-16 08:47:23,968 DEBUG : Generating results file: kraken 08:47:23 INFO - 2015-12-16 08:47:23,968 INFO : javascript benchmark 08:47:23 INFO - 2015-12-16 08:47:23,968 DEBUG : Working with test: v8_7 08:47:23 INFO - 2015-12-16 08:47:23,968 DEBUG : Generating results file: v8_7 08:47:23 INFO - 2015-12-16 08:47:23,969 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:47:24 INFO - 2015-12-16 08:47:24,018 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 08:47:24 INFO - 2015-12-16 08:47:24,019 DEBUG : process_Request line: dromaeo_css 6275.66 graph.html#tests=[[72,132,43]] 08:47:24 INFO - 2015-12-16 08:47:24,019 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:47:24 INFO - 2015-12-16 08:47:24,048 DEBUG : process_Request line: kraken 1549.20 graph.html#tests=[[232,132,43]] 08:47:24 INFO - 2015-12-16 08:47:24,048 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:47:24 INFO - 2015-12-16 08:47:24,085 DEBUG : process_Request line: v8_7 21467.78 graph.html#tests=[[230,132,43]] 08:47:24 INFO - 2015-12-16 08:47:24,087 INFO : javascript benchmark 08:47:24 INFO - 2015-12-16 08:47:24,090 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2682.342826007628, 2707.769839563637, 2737.1651646247897, 2753.201571544252, 2759.613654088428, 4697.953020469794, 4783.497732738065, 4825.2279635258365, 4827.082854257688, 4866.878328041801, 4636.629069674426, 4739.928901066478, 4773.832915847946, 4779.426468823746, 4797.760111994404, 4421.535738747433, 4425.269830477975, 4501.819927202908, 4502.729836209822, 4511.661625378093, 4258.893527661802, 4466.776661166945, 4521.638268938494, 4576.199165146103, 4587.15137699525, 4388.670849686287, 4422.358757980091, 4451.9777401113115, 4482.0, 4487.057717879249, 4422.535633758441, 4424.159409712144, 4431.069475410168, 4484.148011877733, 4524.3213517972235, 4279.40088387626, 4348.152110338485, 4425.579569940883, 4430.9556904430865, 4462.308342206963, 4615.100055489181, 4660.37084993525, 4672.3925889634465, 4673.205555055649, 4688.320193571913, 5167.612429067835, 5206.427292997767, 5222.8694282642855, 5232.686038837682, 5257.684538927639, 4994.450610432849, 5078.695278283278, 5081.136206844808, 5281.419043905167, 5296.655717378358, 4720.575148236675, 4723.315119307716, 4738.763061846894, 4770.61835053195, 4821.734804585782, 5268.552173065255, 5317.282166907496, 5328.0675881720545, 5333.12003519415, 5365.195220716846, 4926.4088309403105, 5037.19404895215, 5088.872778180576, 5093.159628661229, 5102.464241254689, 5050.545450909436, 5128.179491281452, 5133.076046311699, 5150.4334523202415, 5151.716655583904, 5138.871528211825, 5185.533302002837, 5188.169892817131, 5196.45437229093, 5240.213967904845, 4888.877778055506, 4938.308636790852, 5140.254663073908, 5164.225366195101, 5165.974170129125, 4214.199302132585, 4237.427947227146, 4258.148370325947, 4281.636060934793, 4295.463067116611, 3746.1571146492365, 3747.662710356081, 3751.0809851586537, 3778.017715394017, 3781.978865706244, 4308.116836048603, 4376.584224498668, 4399.5820397062225, 4455.910881782411, 4467.374567560544, 5200.193969934666, 5206.557442617344, 5209.114450543341, 5221.947780522146, 5223.503767142115, 4480.910381792346, 4485.259932111165, 4496.3705081288645, 4516.164509565675, 4524.321351797257, 4379.934300985424, 4474.530174331713, 4486.753228572395, 4557.293619488984, 4582.610478109332, 4925.975370123127, 4935.679180853233, 4938.629602779734, 4946.62900282473, 5004.799808007639, 5215.45237750046, 5215.869603259949, 5221.556167725786, 5225.268462415341, 5228.320318358741, 4743.952560474351, 4809.903801923872, 4851.126797176542, 4857.6599638025, 4862.586680132228, 5131.818272670818, 5207.583393328448, 5218.0, 5219.712915789516, 5272.947270527246, 4988.152014157675, 5276.894462110813, 5286.577073834007, 5290.338707661543, 5305.12465443213, 4892.461829198856, 4904.852854414374, 4953.554180123806, 4966.528179822911, 4999.575036121825, 5027.824026159067, 5035.219540971156, 5052.469490703424, 5065.848024559269, 5091.109055915274, 4719.2921061841, 4901.681390709592, 4946.480619534897, 4955.454899961073, 4973.950260497349, 4893.168161412497, 4967.925481117858, 4989.625778066587, 5004.299398084198, 5054.545090941833, 4946.406431228132, 4946.629002824874, 4947.925781113214, 4953.405591329064, 4960.7767650456535], "unit": "score", "name": "dojo.html", "value": 4723.291691992963}, {"lowerIsBetter": false, "replicates": [548.0655482402505, 551.495381725721, 554.5979165105298, 566.7534622439237, 615.587556337254, 36025.81987090064, 36680.44979325312, 36715.44926826096, 36762.26475470489, 36885.0, 36588.451173232424, 37153.62846371535, 37157.81421092898, 37159.25681486375, 37272.25455490888, 7759.534427934328, 7914.28771410573, 7935.761927142195, 7941.36469082472, 7968.12350641429, 7741.690332386698, 7840.686372545091, 7854.214578542129, 7864.252895974902, 7864.4888082274465, 7652.502587331805, 7706.7302644407455, 7728.420368472359, 7742.8451430971345, 7756.0692716874055, 7792.610369481532, 7869.48848324857, 7879.330256928168, 7901.960490197513, 7931.24653157952, 7732.768016959444, 7847.568383738892, 7875.251851074138, 7877.054753429625, 7886.369090472748, 34784.47823282653, 35293.29413411743, 35393.11517212065, 35406.64593354059, 35467.113322167155, 2832.9575056373965, 2842.2325971987652, 2875.0656036788127, 2990.491616425213, 3232.385846689145, 27680.446391072066, 28206.717932820615, 28267.717322826713, 28394.574081388797, 28938.71061289381, 3315.5855518060243, 3341.565596472443, 3385.0860267727576, 3402.574678165229, 3430.8456119474686, 206814.0, 208280.0, 208632.0, 208808.0, 210315.0, 54365.0, 54531.18203226955, 54589.72705136449, 54690.72654636701, 54697.72651136798, 63013.0, 63771.681141593996, 64032.0, 64157.0, 64391.356086438536, 13357.732845343233, 13415.597532073858, 13553.796693049415, 13575.52485662997, 13599.728005440034, 10674.946625266979, 10683.786324273471, 10692.411917344622, 10699.090577300862, 10711.78576428467, 19564.21743130259, 19948.401547953585, 19964.101615427342, 20020.399388018384, 20026.299079532146, 7813.960930195312, 8087.150849160871, 8174.509529428254, 8179.386546009073, 8264.917350826414, 856.5246288309924, 872.4547158026234, 889.3196704521047, 970.5593670438172, 1020.0717347213999, 26328.47343053128, 26398.472030559282, 26635.33411664724, 26638.866805665846, 29853.253668658457, 984.3650845204803, 986.5018165826211, 1014.5130337437923, 1055.5250137438184, 1094.370736826328, 14426.711465770626, 14437.494687685881, 14479.710405791826, 14661.853381466262, 14762.261886905611, 285494.0, 288487.0, 289516.0, 289751.0, 290439.0, 47647.28529072067, 47725.284120738215, 48008.03983920302, 48101.518984810406, 48151.27773083407, 1260.0864373329264, 1261.0983147050088, 1278.1180985120238, 1286.9356532173354, 1292.8901043411227, 26455.33861653474, 26745.06392276261, 27180.864095679393, 27276.0, 30804.691953081077, 43586.0, 44287.11425771531, 44362.556374435844, 44389.77805110954, 44481.0, 242693.0, 242811.0, 244851.0, 246936.0, 247004.0, 39259.41110883396, 40964.38553421761, 41749.956251093965, 41966.1606767869, 42008.36987445252, 38550.2289954205, 39292.60707392889, 39514.40728389134, 39520.407193892686, 39781.60218397895, 33392.1651958703, 33960.15099622529, 34010.31979360448, 34154.48768268428, 34359.828200858836, 33578.3284334307, 33746.66253337533, 33801.83099084489, 33977.66022339745, 34235.4864677025, 33476.49785253272, 33590.49614255837, 33943.83028084844, 33985.490217646264, 34046.48930265998, 28423.71576284211, 30291.21359830021, 30785.538216926318, 30808.53787193149, 30845.0, 24134.0, 24163.15428959978, 24217.51564968726, 24247.636285456087, 24325.344779619194], "unit": "score", "name": "ext.html", "value": 17274.093142834292}, {"lowerIsBetter": false, "replicates": [342.8937029520849, 344.50219432919425, 344.50735448308916, 346.2123668653814, 346.81272113058964, 12485.5005799768, 14843.703125937474, 15440.0, 16020.59948501288, 16529.752053719203, 15369.770418366532, 15580.610484737887, 15627.609309767233, 15653.0, 15982.0, 4494.640428765691, 4620.630349572026, 4625.606823420013, 4626.398568186131, 4636.721796692193, 4446.97776511117, 4455.443069616298, 4476.350929115276, 4491.1242307749835, 4492.910141797179, 4387.956120438803, 4497.14554234696, 4847.200211965039, 4982.227754698028, 5000.149974504325, 4971.751412429364, 5008.874778130539, 5019.347484826967, 5025.597952163818, 5053.823116190934, 4991.875203119915, 5008.5993120550265, 5040.6471546991725, 5044.949550504484, 5045.596352291808, 11113.166512511594, 11235.662930112028, 11329.716757081056, 11506.137039722054, 11650.592229272019, 1821.6994195957784, 1853.4254381141889, 1881.7271495633192, 1914.3873960332699, 1940.602176553803, 8807.559622018873, 9017.774555636095, 9071.773205669844, 9111.225545828545, 9210.539473026389, 1722.810490846006, 1765.3732924811636, 1785.4108144312345, 1794.4168145352683, 1820.2718912435, 49471.50528494705, 49901.25148122781, 50774.0, 55283.170752438746, 59306.703466482824, 9147.679831205876, 9480.810383792286, 9973.900260997443, 9983.60065597368, 9991.250656200815, 12426.75146497065, 12429.937850310691, 12444.75110497785, 12463.75072498545, 12463.937680311541, 6912.0, 6974.79075627732, 7083.256258092929, 7085.397741192057, 7087.787366379017, 6739.326067393222, 6741.831454213684, 6776.627285499345, 6783.321667833177, 6791.558548694319, 4173.311403618369, 4176.0, 4206.8737937861915, 4220.662347012231, 4241.384999175102, 1709.623882745794, 1726.7323564847468, 1734.0376091269213, 1764.514758441439, 1771.7076682347526, 409.05100167611454, 815.7702313504498, 869.2437579305918, 927.9860802087974, 970.8640790289365, 9230.76923076915, 9536.141747242642, 9571.569279382444, 9696.369735967139, 9761.707148785548, 396.21944768805406, 406.0863058119232, 414.0745433955108, 416.2382839403884, 434.3072798885772, 5268.2097685346735, 5299.33758280215, 5305.283786688748, 5331.306930099062, 5338.519533242027, 477480.0, 479879.0, 491909.0, 500802.0, 508672.0, 69143.0, 69865.65067174632, 72298.0, 72871.63564182146, 73061.0, 438.4497455693085, 441.457007880309, 441.99337009944236, 443.5586591341571, 447.50997657564915, 8588.441751286146, 8630.352723545633, 8709.216170544682, 8741.0, 8831.072737362741, 30850.0, 30884.53673194859, 31070.378592427573, 31084.533731993586, 31195.84402077975, 43573.78213109041, 44544.331835021854, 44816.0, 45282.0, 46738.065238695715, 8426.452280601741, 8623.611937462954, 8720.215180633773, 9096.0, 9146.405483643543, 15920.442784502487, 16206.351745930031, 16283.511494655178, 16391.918040410197, 16676.749848752035, 2440.2435245074084, 10571.2600117991, 13328.534581009202, 13555.390007449885, 14089.577312680636, 12714.427850746924, 12747.745045099231, 12759.106862519535, 13279.86720132825, 13367.799483007957, 13249.47002119943, 13629.454821807016, 13751.862481375458, 14016.579502614937, 14155.363008664428, 8776.254018408252, 8851.69019084329, 8929.151730585583, 8995.325350598861, 9005.81988360216, 13174.40715167839, 13471.393787279792, 13724.725505490034, 13827.0, 13991.440342386191], "unit": "score", "name": "jquery.html", "value": 7363.942145818782}, {"lowerIsBetter": false, "replicates": [1509.6527798606328, 1629.3156874112874, 1711.2556038123416, 1724.3447489953824, 1753.4476639858444, 6081.118237855509, 6235.563510554263, 7061.2232654408035, 7251.3836323912465, 7269.982202491648, 6761.763338283161, 6966.4078553323025, 7015.298470152982, 7053.506254562183, 7069.434445244381, 2065.7004734313514, 2098.422933693239, 2099.191811152702, 2101.4956410461455, 2104.032145213204, 2067.607154640621, 2098.9790102098937, 2105.1368938735122, 2107.473131717071, 2111.229401268541, 1983.4842940835415, 2012.657848165808, 2041.9795802041938, 2042.458748431667, 2043.9080241389174, 2077.9999999999923, 2079.2099002379073, 2094.1518684932626, 2094.675325324577, 2104.3581707579183, 2003.3489116037347, 2005.2279872249144, 2038.9592208155902, 2039.9796002040086, 2046.0, 7098.3256590623805, 7152.070230870006, 7173.0675012248075, 7180.964095179543, 7197.172325182619, 4023.657989070903, 4079.1637714268504, 4096.938545921814, 4100.200460910124, 4102.979485102585, 2666.280104371828, 2729.849858257795, 2730.276476733667, 2737.4935636907235, 2760.3651160233258, 825.8100636853497, 837.2632083766308, 839.7354833227574, 861.9439736417113, 874.4534665833854, 9821.410715357102, 9824.459654718987, 9835.114839664464, 9854.458004809732, 9860.852087218698, 3890.513685789276, 3898.941515877264, 3944.5660977292473, 3945.487086678771, 3948.309045916953, 8431.494110353398, 8483.321334293241, 8486.19381158789, 8496.447730897471, 8519.659213631385, 4238.682098842599, 4244.808983595745, 4256.382824490432, 4265.4241677373775, 4270.316749320094, 3772.603876592973, 3845.692344612424, 3846.826892789831, 3875.5930627284292, 3892.4550562921213, 3112.579801726783, 3136.7961082529564, 3147.3390587976323, 3209.743220542351, 3235.3044095519576, 958.9616415343309, 963.8650588917557, 970.4662435660358, 970.8689326940914, 976.5898322704481, 1201.195199216527, 1205.3430880170329, 1208.957686480969, 1221.780079585683, 1228.969275768113, 6638.900416493757, 6674.699638516278, 6690.163729533809, 6693.364130407604, 6771.932280677229, 441.52977079410323, 441.71067950492477, 446.2636649528304, 450.49544510148843, 452.0687383988993, 5319.601029922771, 5322.121849894801, 5378.9462105379225, 5406.702631355313, 5413.106837371868, 8270.131636178116, 8414.579271036546, 8422.199891010345, 8510.48937063778, 8650.826983460296, 8313.958430207811, 8355.080941096474, 8377.120402357787, 8383.496990180609, 8407.873881891777, 6666.633335166613, 6687.632180230037, 6764.458843292525, 6801.421879140328, 6807.285235050347, 6794.93205067943, 6835.863282734417, 6841.281665425058, 6854.897176542256, 6872.6907289173105, 7634.656440460081, 7671.194524575062, 7831.2560306770765, 7841.607919604111, 7863.41024423182, 7786.221377862168, 7999.4400391972, 8037.156098609562, 8045.155258697987, 8057.153998830273, 5144.151215049625, 5188.377394712658, 6411.71147298382, 6494.64279464634, 6504.512161587805, 6735.427488663322, 6841.350071743176, 6886.793396198122, 6887.586744795329, 6897.310268973062, 6261.467775238973, 6267.185265915402, 6374.649394283359, 6409.391107844747, 6420.2937676856445, 6364.140840986408, 6412.23053233615, 6428.8071357859335, 6502.869942601027, 6507.902381464187, 6360.300366959538, 6413.903791443039, 6418.93581064202, 6431.935680643133, 6433.581817181868, 5974.880502390015, 6062.181605483203, 6064.302605200459, 6076.088586712029, 6076.665783381956, 6076.118962750465, 6105.175801266772, 6114.5414093942245, 6117.051856962178, 6137.324894261538], "unit": "score", "name": "mootools.html", "value": 4009.59055336474}, {"lowerIsBetter": false, "replicates": [307.2595045939286, 312.302005018783, 315.96524382317943, 316.2930849551251, 317.1342235696547, 5528.834134975952, 5590.7204639768, 5645.1814486899375, 5694.430556944303, 5702.3157221133415, 5538.556915446765, 5562.7774889004495, 5579.330480342354, 5582.804601838937, 5588.077967135428, 4149.937750933738, 4277.0, 4305.05288836457, 4325.0, 4326.199653064177, 4268.253055715253, 4284.785760711968, 4294.506131794837, 4295.828166873322, 4303.053328267776, 4239.046214601705, 4242.512111107231, 4254.383114448403, 4256.829726810924, 4258.233517966764, 4253.064325848309, 4256.574342565734, 4257.659387249013, 4261.083866968616, 4267.594578515067, 3618.2582570572968, 3699.6300369963055, 3701.0932321581117, 3703.518542589473, 3709.4806727058235, 5281.181416880389, 5394.460553944574, 5405.459454054602, 5414.5668346532575, 5417.51242388187, 4851.636127290467, 4861.0, 4861.562459378673, 4861.975690121527, 4865.3918260217115, 5905.734241959122, 5907.645541267495, 5915.645061296336, 5923.555733320019, 5928.436798504135, 3912.452256684038, 3948.9732669505847, 3991.2815693175216, 3995.2808494470983, 3997.1805779815068, 6145.938540614581, 6169.0, 6187.319394866561, 6200.007998720228, 6209.068639704035, 4150.584941505826, 4165.333546632524, 4167.395727619478, 4169.061961058737, 4177.97911010443, 4198.992241861931, 4229.069604686964, 4230.027093768451, 4235.237657221668, 4237.533871274158, 4758.809647614056, 4819.59033482151, 4858.076965376567, 4862.732549709729, 4867.464578896389, 5860.941390586125, 5866.266716660418, 5867.0, 5871.794487192928, 5894.0, 1466.3035058347414, 1478.1648368671665, 1484.665950161205, 1488.8287846897529, 1488.8734457571227, 983.8032393521324, 984.9310548261697, 987.6197663899451, 999.9850002249972, 1005.4671024357102, 5137.537621614073, 5138.049460849755, 5148.845534633967, 5150.201718733528, 5162.793488260502, 6110.602810817282, 6116.969415152896, 6118.3269840317525, 6122.051082082285, 6124.11200375943, 5132.153194722903, 5146.433892271847, 5158.071547121479, 5161.483851614808, 5165.199394093921, 3261.3314270574474, 3309.3546758382367, 3314.834258287076, 3318.4856347266214, 3334.8832790852202, 5671.262735844396, 5770.221020162225, 5778.797742079007, 5782.10377391505, 5856.326522449973, 6324.968375158095, 6341.492680585542, 6360.268569114519, 6369.363063693593, 6391.201099862517, 5814.0, 5819.796307129315, 5821.621594596338, 5834.416558344216, 5838.9124163137585, 6011.248593925759, 6173.629582225081, 6177.135201071944, 6180.412860778219, 6199.938000619936, 6008.609440386361, 6011.489023433057, 6016.849578760566, 6031.849203769941, 6034.396560344106, 5832.1543376209365, 5841.561882858718, 5847.327557330961, 5848.941510584839, 5853.678047707417, 4140.4617399737845, 4180.728252663567, 4183.602557757008, 4185.204811085884, 4185.66514678831, 6046.395360463918, 6155.076738489262, 6160.199174107337, 6162.537809664203, 6167.722452489559, 5896.056630939029, 5914.290285165807, 5921.940780592139, 5935.732892019956, 5942.851428714317, 5936.901673190474, 5939.376365481735, 5940.732667029907, 5944.048952167633, 5954.583179177416, 5624.212610234488, 5772.787714579985, 5796.0, 5817.447342502455, 5825.475707186373, 5941.643501389931, 5942.227510423617, 5965.7471930895, 5984.0, 6006.339302676614, 5817.476427121579, 5835.824925252249, 5851.912221316768, 5858.179854820243, 5860.2967643883], "unit": "score", "name": "prototype.html", "value": 4404.897591942683}, {"lowerIsBetter": false, "replicates": [773.2151865856157, 774.2721841469018, 783.1111688233852, 786.3434032582793, 791.7466410748556, 11520.654380368593, 11567.190296679215, 11664.241824281416, 11696.883031169697, 11713.70715732107, 11219.495122719476, 11543.884561154386, 11690.123240756935, 11765.0, 11776.411179441015, 812.4069429316603, 827.2761333832897, 827.404268926375, 827.6234313387395, 829.0134739659816, 825.2119226139023, 829.1335554345724, 829.8423299573062, 830.7341650671788, 831.9084900660922, 857.1385757313891, 858.6608289725555, 858.9785255368603, 865.4936861935744, 867.9913200867974, 851.2041241439274, 853.1937319233327, 853.2534032721369, 853.63293783673, 854.4915775113798, 633.0599060395309, 633.8510450044236, 635.7933671556763, 637.6620391192629, 637.7767781276563, 12088.879111208864, 12105.334206618632, 12175.93912030443, 12190.756184876342, 12304.0, 10821.296615719953, 11267.774644507146, 11663.825042624367, 11710.238834475731, 11891.456126120329, 9276.953615231949, 9397.342186046979, 9419.905800941971, 9471.526423678857, 9476.099770521789, 3140.2463408781955, 3231.4991176367703, 3236.6116066072223, 3243.416185086707, 3307.3219989902013, 36086.278274434364, 37258.0, 37272.62727372719, 37344.626553734386, 38294.0, 8741.868871966926, 8908.883034249588, 9064.909350906539, 9098.909010909807, 9159.404638698463, 14818.073650425376, 14890.106593604418, 14932.178730169728, 15003.624909377135, 15055.171965542, 5743.253377060955, 5767.798127065616, 5788.18965344852, 5889.941100589025, 5977.581569290108, 3565.893023209308, 3583.516225309602, 3590.9640903591153, 3640.690541304019, 3643.854245830137, 2570.0362364113457, 2574.7811436027773, 2582.083360407066, 2598.7141414444395, 2614.830036047651, 454.4637327952981, 464.17145395468924, 468.60871172570603, 469.1227404753133, 476.77114984807486, 528.0231571592523, 581.4127730991644, 582.2140110850319, 608.1971797227617, 645.7578408096964, 7861.882071768928, 7883.093444253869, 8177.264046235868, 8223.136570660114, 8237.752867413987, 604.280905722198, 606.7785258380748, 612.2194202391986, 613.7238242790672, 633.499535367064, 3776.754510956779, 3825.885223443301, 3900.7854567998465, 3909.7654140751647, 3941.684665226775, 45501.54498454973, 46572.0, 46649.0, 50931.0, 51491.48508514867, 38441.0, 38573.80713096417, 38665.0, 39053.41419878704, 39773.80113099474, 40952.38571421431, 43705.78147109244, 43833.0, 44208.557914420446, 44344.55655443469, 7837.25546073145, 7975.521468711896, 8068.99137607799, 8088.433809633269, 8332.16678332162, 30277.848610756806, 30580.388392231587, 30791.2302192447, 31308.060758177293, 31912.202194945312, 37393.0, 38007.2398552033, 39485.40771888482, 39561.60438395579, 39929.40105898472, 10421.270511064153, 10435.582576696846, 10513.158947284046, 10540.472976351306, 10615.203859710708, 11102.61140860066, 11436.771264574496, 11560.30638161713, 11713.765724685629, 11773.646790595953, 10912.890871091187, 10916.345019298868, 10968.0, 11292.661220163409, 11688.70778230551, 10600.893991059991, 10737.0, 10768.192385570957, 10806.189535785004, 11145.72135696614, 10677.412742298937, 10688.732781680521, 10776.245662803529, 10858.0, 11051.115910726961, 9317.34778565494, 9416.670416535388, 9462.810743785223, 9829.361091529028, 9890.0, 9190.264778817813, 9246.4914429707, 9337.206337461392, 9377.156055954996, 9451.858222126812], "unit": "score", "name": "yui.html", "value": 5756.095280438477}], "name": "dromaeo_css", "value": 6275.662311771121}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 109.0, 113.0, 113.0, 116.0, 125.0, 115.0, 114.0, 115.0, 115.0], "unit": "score", "name": "ai-astar", "value": 115.0}, {"lowerIsBetter": true, "replicates": [169.0, 131.0, 152.0, 164.0, 132.0, 152.0, 151.0, 132.0, 167.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 148.5}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 164.0, 162.0, 165.0, 166.0, 169.0, 163.0, 164.0, 164.0], "unit": "score", "name": "audio-dft", "value": 164.3}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 74.0, 73.0, 74.0, 73.0, 141.0, 73.0, 73.0, 75.0], "unit": "score", "name": "audio-fft", "value": 80.1}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 138.0, 95.0, 96.0, 97.0, 133.0, 96.0, 95.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 108.0}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 147.0, 147.0, 148.0, 147.0, 148.0, 151.0, 149.0, 149.0], "unit": "score", "name": "imaging-darkroom", "value": 148.2}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 96.0, 97.0, 96.0, 97.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 74.0, 74.0, 75.0, 73.0, 77.0, 76.0, 83.0, 72.0], "unit": "score", "name": "json-parse-financial", "value": 75.3}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 68.0, 69.0, 70.0, 67.0, 67.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [86.0, 86.0, 87.0, 87.0, 87.0, 88.0, 87.0, 86.0, 87.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.6}, {"lowerIsBetter": true, "replicates": [126.0, 129.0, 122.0, 127.0, 125.0, 126.0, 133.0, 128.0, 127.0, 129.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.2}, {"lowerIsBetter": true, "replicates": [141.0, 151.0, 165.0, 150.0, 151.0, 145.0, 152.0, 153.0, 157.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.5}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 73.0, 71.0, 73.0, 69.0, 77.0, 69.0, 70.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.3}], "name": "kraken", "value": 1549.1999999999996}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.80998176090202], "unit": "score", "name": "Richards", "value": 212.90636200000006}, {"lowerIsBetter": false, "replicates": [185.59762435040832], "unit": "score", "name": "DeltaBlue", "value": 356.2437839999999}, {"lowerIsBetter": false, "replicates": [278.00945232137894], "unit": "score", "name": "Encrypt", "value": 957.4530570000002}, {"lowerIsBetter": false, "replicates": [5138.461538461538], "unit": "score", "name": "Decrypt", "value": 51.80169161676644}, {"lowerIsBetter": false, "replicates": [1063.8297872340424], "unit": "score", "name": "RayTrace", "value": 695.5896600000003}, {"lowerIsBetter": false, "replicates": [700.2801120448179], "unit": "score", "name": "Earley", "value": 951.7091640000002}, {"lowerIsBetter": false, "replicates": [11858.823529411764], "unit": "score", "name": "Boyer", "value": 56.19975694444442}, {"lowerIsBetter": false, "replicates": [26605.263157894737], "unit": "score", "name": "RegExp", "value": 34.24078140454997}, {"lowerIsBetter": false, "replicates": [600.9615384615385], "unit": "score", "name": "Splay", "value": 135.60102399999994}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21467.7768976348}]} 08:47:24 INFO - RETURN: dromaeo_css: 6275.66 08:47:24 INFO - RETURN: kraken: 1549.20 08:47:24 INFO - RETURN: v8_7: 21467.78 08:47:24 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21467.78"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1549.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6275.66"}}} 08:47:24 INFO - Return code: 0 08:47:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:47:24 INFO - # TBPL SUCCESS # 08:47:24 INFO - Running post-action listener: _resource_record_post_action 08:47:24 INFO - Running post-run listener: _resource_record_post_run 08:47:25 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 4096; Write bytes: 510951424; Read time: 12; Write time: 546120 08:47:25 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 232263680; Read time: 0; Write time: 340636 08:47:25 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 4096; Write bytes: 274628608; Read time: 12; Write time: 204784 08:47:25 INFO - Running post-run listener: _upload_blobber_files 08:47:25 INFO - Blob upload gear active. 08:47:25 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:47:25 INFO - Copying logs to upload dir... 08:47:25 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1267.129536 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-12-16 08:47:24.901593) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 08:47:24.905112) ========= 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=fdc9337702648c539b2c5dbe000001aa-1450283176.438375-1600336487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010009 build_url: 'https://queue.taskcluster.net/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/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 08:47:24.956700) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 08:47:24.957033) ========= 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=fdc9337702648c539b2c5dbe000001aa-1450283176.438375-1600336487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004719 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 08:47:25.006356) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 08:47:25.006742) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 08:47:25.007112) ========= ========= Total master_lag: 0.21 =========