builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-029 starttime: 1449863017.85 results: success (0) buildid: 20151211110732 builduid: f1a7bb67fd304fdaa9079fa65b9b8aea revision: 146f5531e7bd31d92215aaa6b489f62a14994503 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-11 11:43:37.854191) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-11 11:43:37.854694) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-11 11:43:37.855061) ========= 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=1d09c2d9237d126f9c84bbb400000198-1449861998.969139-1555663588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004644 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-11 11:43:37.923511) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-11 11:43:37.923956) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-11 11:43:37.950663) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 11:43:37.950967) ========= 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=1d09c2d9237d126f9c84bbb400000198-1449861998.969139-1555663588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004541 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 11:43:38.007025) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-11 11:43:38.007350) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-11 11:43:38.007737) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 11:43:38.008027) ========= 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=1d09c2d9237d126f9c84bbb400000198-1449861998.969139-1555663588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-11 11:43:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 96.7M=0s 2015-12-11 11:43:40 (96.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111503 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 11:43:38.132771) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 11:43:38.133148) ========= 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=1d09c2d9237d126f9c84bbb400000198-1449861998.969139-1555663588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019515 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 11:43:38.184784) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 11:43:38.185276) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 146f5531e7bd31d92215aaa6b489f62a14994503 --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 146f5531e7bd31d92215aaa6b489f62a14994503 --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=1d09c2d9237d126f9c84bbb400000198-1449861998.969139-1555663588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-11 11:43:40,530 truncating revision to first 12 chars 2015-12-11 11:43:40,530 Setting DEBUG logging. 2015-12-11 11:43:40,530 attempt 1/10 2015-12-11 11:43:40,530 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/146f5531e7bd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-11 11:43:40,748 unpacking tar archive at: fx-team-146f5531e7bd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.472280 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 11:43:38.674860) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-11 11:43:38.675153) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-11 11:43:38.685746) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-11 11:43:38.686026) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-11 11:43:38.686448) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-11 11:43:38.686741) ========= /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=1d09c2d9237d126f9c84bbb400000198-1449861998.969139-1555663588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:43:41 INFO - MultiFileLogger online at 20151211 11:43:41 in /builds/slave/test 11:43:41 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 11:43:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:43:41 INFO - {'append_to_log': False, 11:43:41 INFO - 'base_work_dir': '/builds/slave/test', 11:43:41 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:43:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:43:41 INFO - 'branch': 'Fx-Team-Non-PGO', 11:43:41 INFO - 'buildbot_json_path': 'buildprops.json', 11:43:41 INFO - 'config_files': ('talos/linux_config.py',), 11:43:41 INFO - 'default_actions': ('clobber', 11:43:41 INFO - 'read-buildbot-config', 11:43:41 INFO - 'download-and-extract', 11:43:41 INFO - 'populate-webroot', 11:43:41 INFO - 'create-virtualenv', 11:43:41 INFO - 'install', 11:43:41 INFO - 'run-tests'), 11:43:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:43:41 INFO - 'download_minidump_stackwalk': True, 11:43:41 INFO - 'download_symbols': 'ondemand', 11:43:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:43:41 INFO - 'tooltool.py': '/tools/tooltool.py', 11:43:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:43:41 INFO - '/tools/misc-python/virtualenv.py')}, 11:43:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:43:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:43:41 INFO - 'installer_path': 'installer.exe', 11:43:41 INFO - 'log_level': 'info', 11:43:41 INFO - 'log_name': 'talos', 11:43:41 INFO - 'log_to_console': True, 11:43:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:43:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:43:41 INFO - 'opt_config_files': (), 11:43:41 INFO - 'pip_index': False, 11:43:41 INFO - 'sps_profile': False, 11:43:41 INFO - 'sps_profile_interval': 0, 11:43:41 INFO - 'suite': 'dromaeojs-e10s', 11:43:41 INFO - 'system_bits': '64', 11:43:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:43:41 INFO - 'title': 'talos-linux64-ix-029', 11:43:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:43:41 INFO - 'use_talos_json': True, 11:43:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:43:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:43:41 INFO - 'work_dir': 'build'} 11:43:41 INFO - ##### 11:43:41 INFO - ##### Running clobber step. 11:43:41 INFO - ##### 11:43:41 INFO - Running pre-action listener: _resource_record_pre_action 11:43:41 INFO - Running main action method: clobber 11:43:41 INFO - rmtree: /builds/slave/test/build 11:43:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:43:42 INFO - Running post-action listener: _resource_record_post_action 11:43:42 INFO - ##### 11:43:42 INFO - ##### Running read-buildbot-config step. 11:43:42 INFO - ##### 11:43:42 INFO - Running pre-action listener: _resource_record_pre_action 11:43:42 INFO - Running main action method: read_buildbot_config 11:43:42 INFO - Using buildbot properties: 11:43:42 INFO - { 11:43:42 INFO - "properties": { 11:43:42 INFO - "buildnumber": 814, 11:43:42 INFO - "product": "firefox", 11:43:42 INFO - "script_repo_revision": "production", 11:43:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:43:42 INFO - "repository": "", 11:43:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 11:43:42 INFO - "buildid": "20151211110732", 11:43:42 INFO - "slavename": "talos-linux64-ix-029", 11:43:42 INFO - "pgo_build": "False", 11:43:42 INFO - "basedir": "/builds/slave/test", 11:43:42 INFO - "project": "", 11:43:42 INFO - "platform": "ubuntu64_hw", 11:43:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:43:42 INFO - "slavebuilddir": "test", 11:43:42 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:43:42 INFO - "branch": "fx-team", 11:43:42 INFO - "repo_path": "integration/fx-team", 11:43:42 INFO - "stage_platform": "linux64", 11:43:42 INFO - "builduid": "f1a7bb67fd304fdaa9079fa65b9b8aea", 11:43:42 INFO - "revision": "146f5531e7bd31d92215aaa6b489f62a14994503" 11:43:42 INFO - }, 11:43:42 INFO - "sourcestamp": { 11:43:42 INFO - "repository": "", 11:43:42 INFO - "hasPatch": false, 11:43:42 INFO - "project": "", 11:43:42 INFO - "branch": "fx-team-linux64-talos", 11:43:42 INFO - "changes": [ 11:43:42 INFO - { 11:43:42 INFO - "category": null, 11:43:42 INFO - "files": [ 11:43:42 INFO - { 11:43:42 INFO - "url": null, 11:43:42 INFO - "name": "https://queue.taskcluster.net/v1/task/wcLmEt5RQje3HufTPJI1nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 11:43:42 INFO - } 11:43:42 INFO - ], 11:43:42 INFO - "repository": "", 11:43:42 INFO - "rev": "146f5531e7bd31d92215aaa6b489f62a14994503", 11:43:42 INFO - "who": "ryanvm@gmail.com", 11:43:42 INFO - "when": 1449862979, 11:43:42 INFO - "number": 7354029, 11:43:42 INFO - "comments": "Bug 1232015 - Update pdf.js to version 1.3.72. r=bdahl", 11:43:42 INFO - "project": "", 11:43:42 INFO - "at": "Fri 11 Dec 2015 11:42:59", 11:43:42 INFO - "branch": "fx-team-linux64-talos", 11:43:42 INFO - "revlink": "", 11:43:42 INFO - "properties": [ 11:43:42 INFO - [ 11:43:42 INFO - "buildid", 11:43:42 INFO - "20151211110732", 11:43:42 INFO - "Change" 11:43:42 INFO - ], 11:43:42 INFO - [ 11:43:42 INFO - "builduid", 11:43:42 INFO - "f1a7bb67fd304fdaa9079fa65b9b8aea", 11:43:42 INFO - "Change" 11:43:42 INFO - ], 11:43:42 INFO - [ 11:43:42 INFO - "pgo_build", 11:43:42 INFO - "False", 11:43:42 INFO - "Change" 11:43:42 INFO - ] 11:43:42 INFO - ], 11:43:42 INFO - "revision": "146f5531e7bd31d92215aaa6b489f62a14994503" 11:43:42 INFO - } 11:43:42 INFO - ], 11:43:42 INFO - "revision": "146f5531e7bd31d92215aaa6b489f62a14994503" 11:43:42 INFO - } 11:43:42 INFO - } 11:43:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/wcLmEt5RQje3HufTPJI1nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 11:43:42 INFO - Running post-action listener: _resource_record_post_action 11:43:42 INFO - ##### 11:43:42 INFO - ##### Running download-and-extract step. 11:43:42 INFO - ##### 11:43:42 INFO - Running pre-action listener: _resource_record_pre_action 11:43:42 INFO - Running main action method: download_and_extract 11:43:42 INFO - mkdir: /builds/slave/test/build/tests 11:43:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:42 INFO - https://queue.taskcluster.net/v1/task/wcLmEt5RQje3HufTPJI1nw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:43:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wcLmEt5RQje3HufTPJI1nw/artifacts/public/build/test_packages.json 11:43:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wcLmEt5RQje3HufTPJI1nw/artifacts/public/build/test_packages.json 11:43:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wcLmEt5RQje3HufTPJI1nw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 11:43:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wcLmEt5RQje3HufTPJI1nw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 11:43:50 INFO - Downloaded 1302 bytes. 11:43:50 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:43:50 INFO - Using the following test package requirements: 11:43:50 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:43:50 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:43:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:43:50 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:43:50 INFO - u'jsshell-linux-x86_64.zip'], 11:43:50 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:43:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:43:50 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:43:50 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:43:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:43:50 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:43:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:43:50 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:43:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:43:50 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:43:50 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:43:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:43:50 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:43:50 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')]} 11:43:50 INFO - https://queue.taskcluster.net/v1/task/wcLmEt5RQje3HufTPJI1nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:43:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wcLmEt5RQje3HufTPJI1nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:43:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wcLmEt5RQje3HufTPJI1nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:43:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wcLmEt5RQje3HufTPJI1nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:43:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wcLmEt5RQje3HufTPJI1nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:43:51 INFO - Downloaded 21874385 bytes. 11:43:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 11:43:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:43:51 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:43:52 INFO - Return code: 0 11:43:52 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:43:52 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')]} 11:43:52 INFO - https://queue.taskcluster.net/v1/task/wcLmEt5RQje3HufTPJI1nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:43:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wcLmEt5RQje3HufTPJI1nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:43:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wcLmEt5RQje3HufTPJI1nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:43:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wcLmEt5RQje3HufTPJI1nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:43:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wcLmEt5RQje3HufTPJI1nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:43:55 INFO - Downloaded 21874385 bytes. 11:43:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 11:43:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:43:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:43:57 INFO - Return code: 0 11:43:57 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')]} 11:43:57 INFO - https://queue.taskcluster.net/v1/task/wcLmEt5RQje3HufTPJI1nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:43:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wcLmEt5RQje3HufTPJI1nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:43:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wcLmEt5RQje3HufTPJI1nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:43:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wcLmEt5RQje3HufTPJI1nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:43:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wcLmEt5RQje3HufTPJI1nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:43:58 INFO - Downloaded 11132038 bytes. 11:43:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 11:43:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:43:58 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 11:43:58 INFO - Return code: 0 11:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:58 INFO - https://queue.taskcluster.net/v1/task/wcLmEt5RQje3HufTPJI1nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:43:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wcLmEt5RQje3HufTPJI1nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:43:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wcLmEt5RQje3HufTPJI1nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:43:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wcLmEt5RQje3HufTPJI1nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:43:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wcLmEt5RQje3HufTPJI1nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:44:00 INFO - Downloaded 57731594 bytes. 11:44:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/wcLmEt5RQje3HufTPJI1nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:44:00 INFO - mkdir: /builds/slave/test/properties 11:44:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:44:00 INFO - Writing to file /builds/slave/test/properties/build_url 11:44:00 INFO - Contents: 11:44:00 INFO - build_url:https://queue.taskcluster.net/v1/task/wcLmEt5RQje3HufTPJI1nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:44:00 INFO - Running post-action listener: _resource_record_post_action 11:44:00 INFO - Running post-action listener: set_extra_try_arguments 11:44:00 INFO - ##### 11:44:00 INFO - ##### Running populate-webroot step. 11:44:00 INFO - ##### 11:44:00 INFO - Running pre-action listener: _resource_record_pre_action 11:44:00 INFO - Running main action method: populate_webroot 11:44:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:44:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:44:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:44:00 INFO - '--tppagecycles', 11:44:00 INFO - '7'], 11:44:00 INFO - 'tests': ['tsvgm']}}, 11:44:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:44:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:44:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:44:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:44:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:44:00 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:44:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:44:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:44:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:44:00 INFO - 'talos_options': ['--e10s'], 11:44:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:44:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:44:00 INFO - 'tests': ['damp', 'tps']}, 11:44:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:44:00 INFO - 'talos_options': ['--e10s'], 11:44:00 INFO - 'tests': ['damp', 'tps']}, 11:44:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:44:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:44:00 INFO - 'other': {'tests': ['a11yr', 11:44:00 INFO - 'ts_paint', 11:44:00 INFO - 'tpaint', 11:44:00 INFO - 'sessionrestore', 11:44:00 INFO - 'sessionrestore_no_auto_restore']}, 11:44:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:44:00 INFO - 'tests': ['a11yr', 11:44:00 INFO - 'ts_paint', 11:44:00 INFO - 'tpaint', 11:44:00 INFO - 'sessionrestore', 11:44:00 INFO - 'sessionrestore_no_auto_restore']}, 11:44:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:44:00 INFO - 'tests': ['a11yr', 11:44:00 INFO - 'ts_paint', 11:44:00 INFO - 'tpaint', 11:44:00 INFO - 'sessionrestore', 11:44:00 INFO - 'sessionrestore_no_auto_restore']}, 11:44:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:44:00 INFO - 'tests': ['a11yr', 11:44:00 INFO - 'ts_paint', 11:44:00 INFO - 'tpaint', 11:44:00 INFO - 'sessionrestore', 11:44:00 INFO - 'sessionrestore_no_auto_restore']}, 11:44:00 INFO - 'other_l64': {'tests': ['a11yr', 11:44:00 INFO - 'ts_paint', 11:44:00 INFO - 'tpaint', 11:44:00 INFO - 'sessionrestore', 11:44:00 INFO - 'sessionrestore_no_auto_restore']}, 11:44:00 INFO - 'other_nol64': {'tests': ['a11yr', 11:44:00 INFO - 'ts_paint', 11:44:00 INFO - 'tpaint', 11:44:00 INFO - 'sessionrestore', 11:44:00 INFO - 'sessionrestore_no_auto_restore']}, 11:44:00 INFO - 'svgr': {'tests': ['tsvgx', 11:44:00 INFO - 'tsvgr_opacity', 11:44:00 INFO - 'tart', 11:44:00 INFO - 'tscrollx', 11:44:00 INFO - 'cart']}, 11:44:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:44:00 INFO - 'tests': ['tsvgx', 11:44:00 INFO - 'tsvgr_opacity', 11:44:00 INFO - 'tart', 11:44:00 INFO - 'tscrollx', 11:44:00 INFO - 'cart']}, 11:44:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:44:00 INFO - 'tests': ['tp5o']}, 11:44:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:44:00 INFO - 'talos_options': ['--e10s'], 11:44:00 INFO - 'tests': ['tp5o']}, 11:44:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:44:00 INFO - 'talos_options': ['--xperf_path', 11:44:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:44:00 INFO - 'tests': ['tp5n']}, 11:44:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:44:00 INFO - 'talos_options': ['--e10s', 11:44:00 INFO - '--xperf_path', 11:44:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:44:00 INFO - 'tests': ['tp5n']}}, 11:44:00 INFO - 'talos.zip': {'path': '', 11:44:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:44:00 INFO - Running post-action listener: _resource_record_post_action 11:44:00 INFO - ##### 11:44:00 INFO - ##### Running create-virtualenv step. 11:44:00 INFO - ##### 11:44:00 INFO - Running pre-action listener: _resource_record_pre_action 11:44:00 INFO - Running main action method: create_virtualenv 11:44:00 INFO - Creating virtualenv /builds/slave/test/build/venv 11:44:00 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 11:44:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:44:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:44:00 INFO - Using real prefix '/usr' 11:44:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:44:01 INFO - Installing distribute.............................................................................................................................................................................................done. 11:44:02 INFO - Installing pip.................done. 11:44:03 INFO - Return code: 0 11:44:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:03 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 0x7f24a5736f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c320b0>, '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 0x1c32fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c33440>, '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': '1d09c2d9237d126f9c84bbb400000198-1449861998.969139-1555663588', '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 11:44:03 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 11:44:03 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 11:44:03 INFO - Using env: {'DISPLAY': ':0', 11:44:03 INFO - 'HOME': '/home/cltbld', 11:44:03 INFO - 'LANG': 'en_US.UTF-8', 11:44:03 INFO - 'LANGUAGE': 'en_US:en', 11:44:03 INFO - 'LOGNAME': 'cltbld', 11:44:03 INFO - 'MAIL': '/var/mail/cltbld', 11:44:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:03 INFO - 'MOZ_NO_REMOTE': '1', 11:44:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:03 INFO - 'NO_EM_RESTART': '1', 11:44:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:03 INFO - 'PWD': '/builds/slave/test', 11:44:03 INFO - 'SHELL': '/bin/bash', 11:44:03 INFO - 'SHLVL': '1', 11:44:03 INFO - 'TERM': 'linux', 11:44:03 INFO - 'TMOUT': '86400', 11:44:03 INFO - 'USER': 'cltbld', 11:44:03 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1449861998.969139-1555663588', 11:44:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:03 INFO - '_': '/tools/buildbot/bin/python'} 11:44:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:03 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 11:44:03 INFO - Cleaning up... 11:44:03 INFO - Return code: 0 11:44:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:03 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 0x7f24a5736f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c320b0>, '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 0x1c32fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c33440>, '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': '1d09c2d9237d126f9c84bbb400000198-1449861998.969139-1555663588', '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 11:44:03 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 11:44:03 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 11:44:03 INFO - Using env: {'DISPLAY': ':0', 11:44:03 INFO - 'HOME': '/home/cltbld', 11:44:03 INFO - 'LANG': 'en_US.UTF-8', 11:44:03 INFO - 'LANGUAGE': 'en_US:en', 11:44:03 INFO - 'LOGNAME': 'cltbld', 11:44:03 INFO - 'MAIL': '/var/mail/cltbld', 11:44:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:03 INFO - 'MOZ_NO_REMOTE': '1', 11:44:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:03 INFO - 'NO_EM_RESTART': '1', 11:44:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:03 INFO - 'PWD': '/builds/slave/test', 11:44:03 INFO - 'SHELL': '/bin/bash', 11:44:03 INFO - 'SHLVL': '1', 11:44:03 INFO - 'TERM': 'linux', 11:44:03 INFO - 'TMOUT': '86400', 11:44:03 INFO - 'USER': 'cltbld', 11:44:03 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1449861998.969139-1555663588', 11:44:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:03 INFO - '_': '/tools/buildbot/bin/python'} 11:44:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:03 INFO - Downloading/unpacking psutil>=0.7.1 11:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:05 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 11:44:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:44:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:44:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:44:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:44:05 INFO - Installing collected packages: psutil 11:44:05 INFO - Running setup.py install for psutil 11:44:05 INFO - building 'psutil._psutil_linux' extension 11:44:05 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 11:44:05 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 11:44:05 INFO - building 'psutil._psutil_posix' extension 11:44:05 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 11:44:05 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 11:44:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:44:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:44:05 INFO - Successfully installed psutil 11:44:05 INFO - Cleaning up... 11:44:05 INFO - Return code: 0 11:44:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:44:05 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')]} 11:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:05 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')]} 11:44:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:05 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 0x7f24a5736f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c320b0>, '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 0x1c32fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c33440>, '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': '1d09c2d9237d126f9c84bbb400000198-1449861998.969139-1555663588', '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 11:44:05 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 11:44:05 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 11:44:05 INFO - Using env: {'DISPLAY': ':0', 11:44:05 INFO - 'HOME': '/home/cltbld', 11:44:05 INFO - 'LANG': 'en_US.UTF-8', 11:44:05 INFO - 'LANGUAGE': 'en_US:en', 11:44:05 INFO - 'LOGNAME': 'cltbld', 11:44:05 INFO - 'MAIL': '/var/mail/cltbld', 11:44:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:05 INFO - 'MOZ_NO_REMOTE': '1', 11:44:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:05 INFO - 'NO_EM_RESTART': '1', 11:44:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:05 INFO - 'PWD': '/builds/slave/test', 11:44:05 INFO - 'SHELL': '/bin/bash', 11:44:05 INFO - 'SHLVL': '1', 11:44:05 INFO - 'TERM': 'linux', 11:44:05 INFO - 'TMOUT': '86400', 11:44:05 INFO - 'USER': 'cltbld', 11:44:05 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1449861998.969139-1555663588', 11:44:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:05 INFO - '_': '/tools/buildbot/bin/python'} 11:44:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:44:05 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 11:44:05 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 11:44:05 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 11:44:05 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 11:44:05 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 11:44:05 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 11:44:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:44:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:44:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:44:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:44:07 INFO - Installing collected packages: mozsystemmonitor 11:44:07 INFO - Running setup.py install for mozsystemmonitor 11:44:07 INFO - Successfully installed mozsystemmonitor 11:44:07 INFO - Cleaning up... 11:44:07 INFO - Return code: 0 11:44:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:44:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f24a5736f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c320b0>, '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 0x1c32fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c33440>, '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': '1d09c2d9237d126f9c84bbb400000198-1449861998.969139-1555663588', '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 11:44:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:44:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:44:07 INFO - Using env: {'DISPLAY': ':0', 11:44:07 INFO - 'HOME': '/home/cltbld', 11:44:07 INFO - 'LANG': 'en_US.UTF-8', 11:44:07 INFO - 'LANGUAGE': 'en_US:en', 11:44:07 INFO - 'LOGNAME': 'cltbld', 11:44:07 INFO - 'MAIL': '/var/mail/cltbld', 11:44:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:07 INFO - 'MOZ_NO_REMOTE': '1', 11:44:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:07 INFO - 'NO_EM_RESTART': '1', 11:44:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:07 INFO - 'PWD': '/builds/slave/test', 11:44:07 INFO - 'SHELL': '/bin/bash', 11:44:07 INFO - 'SHLVL': '1', 11:44:07 INFO - 'TERM': 'linux', 11:44:07 INFO - 'TMOUT': '86400', 11:44:07 INFO - 'USER': 'cltbld', 11:44:07 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1449861998.969139-1555663588', 11:44:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:07 INFO - '_': '/tools/buildbot/bin/python'} 11:44:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:08 INFO - Downloading/unpacking blobuploader==1.2.4 11:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:09 INFO - Downloading blobuploader-1.2.4.tar.gz 11:44:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:44:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:44:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:44:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:44:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:44:10 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 11:44:10 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 11:44:10 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 11:44:10 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 11:44:10 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 11:44:10 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 11:44:10 INFO - Downloading docopt-0.6.1.tar.gz 11:44:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:44:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:44:10 INFO - Installing collected packages: blobuploader, requests, docopt 11:44:10 INFO - Running setup.py install for blobuploader 11:44:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:44:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:44:10 INFO - Running setup.py install for requests 11:44:10 INFO - Running setup.py install for docopt 11:44:10 INFO - Successfully installed blobuploader requests docopt 11:44:10 INFO - Cleaning up... 11:44:11 INFO - Return code: 0 11:44:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:44:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:11 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 0x7f24a5736f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c320b0>, '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 0x1c32fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c33440>, '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': '1d09c2d9237d126f9c84bbb400000198-1449861998.969139-1555663588', '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 11:44:11 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 11:44:11 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 11:44:11 INFO - Using env: {'DISPLAY': ':0', 11:44:11 INFO - 'HOME': '/home/cltbld', 11:44:11 INFO - 'LANG': 'en_US.UTF-8', 11:44:11 INFO - 'LANGUAGE': 'en_US:en', 11:44:11 INFO - 'LOGNAME': 'cltbld', 11:44:11 INFO - 'MAIL': '/var/mail/cltbld', 11:44:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:11 INFO - 'MOZ_NO_REMOTE': '1', 11:44:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:11 INFO - 'NO_EM_RESTART': '1', 11:44:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:11 INFO - 'PWD': '/builds/slave/test', 11:44:11 INFO - 'SHELL': '/bin/bash', 11:44:11 INFO - 'SHLVL': '1', 11:44:11 INFO - 'TERM': 'linux', 11:44:11 INFO - 'TMOUT': '86400', 11:44:11 INFO - 'USER': 'cltbld', 11:44:11 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1449861998.969139-1555663588', 11:44:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:11 INFO - '_': '/tools/buildbot/bin/python'} 11:44:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:44:11 INFO - Running setup.py (path:/tmp/pip-i47iE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:44:11 INFO - Running setup.py (path:/tmp/pip-G1Eocq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:44:11 INFO - Running setup.py (path:/tmp/pip-Fd4ZC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:44:11 INFO - Running setup.py (path:/tmp/pip-ZJV8MW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:44:11 INFO - Running setup.py (path:/tmp/pip-1BK7WP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:44:11 INFO - Running setup.py (path:/tmp/pip-fP6CbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:44:11 INFO - Running setup.py (path:/tmp/pip-mQVNWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:44:11 INFO - Running setup.py (path:/tmp/pip-iJLrJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:44:11 INFO - Running setup.py (path:/tmp/pip-K4P4PX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:44:11 INFO - Running setup.py (path:/tmp/pip-wh6bw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:44:11 INFO - Running setup.py (path:/tmp/pip-TUqmL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:44:12 INFO - Running setup.py (path:/tmp/pip-3Xfxaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:44:12 INFO - Running setup.py (path:/tmp/pip-zMtgOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:44:12 INFO - Running setup.py (path:/tmp/pip-FSQ51p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:44:12 INFO - Running setup.py (path:/tmp/pip-P7XtW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:44:12 INFO - Running setup.py (path:/tmp/pip-lKVKTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:44:12 INFO - Running setup.py (path:/tmp/pip-Wpvzqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:44:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:44:12 INFO - Running setup.py install for manifestparser 11:44:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:44:12 INFO - Running setup.py install for mozcrash 11:44:12 INFO - Running setup.py install for mozdebug 11:44:12 INFO - Running setup.py install for mozdevice 11:44:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:44:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:44:12 INFO - Running setup.py install for mozfile 11:44:12 INFO - Running setup.py install for mozhttpd 11:44:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:44:13 INFO - Running setup.py install for mozinfo 11:44:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:44:13 INFO - Running setup.py install for mozInstall 11:44:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:44:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:44:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:44:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:44:13 INFO - Running setup.py install for mozleak 11:44:13 INFO - Running setup.py install for mozlog 11:44:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:44:13 INFO - Running setup.py install for moznetwork 11:44:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:44:13 INFO - Running setup.py install for mozprocess 11:44:13 INFO - Running setup.py install for mozprofile 11:44:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:44:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:44:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:44:13 INFO - Running setup.py install for mozrunner 11:44:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:44:13 INFO - Running setup.py install for mozscreenshot 11:44:14 INFO - Running setup.py install for moztest 11:44:14 INFO - Running setup.py install for mozversion 11:44:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:44:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:44:14 INFO - Cleaning up... 11:44:14 INFO - Return code: 0 11:44:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:44:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:14 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 0x7f24a5736f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c320b0>, '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 0x1c32fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c33440>, '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': '1d09c2d9237d126f9c84bbb400000198-1449861998.969139-1555663588', '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 11:44:14 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 11:44:14 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 11:44:14 INFO - Using env: {'DISPLAY': ':0', 11:44:14 INFO - 'HOME': '/home/cltbld', 11:44:14 INFO - 'LANG': 'en_US.UTF-8', 11:44:14 INFO - 'LANGUAGE': 'en_US:en', 11:44:14 INFO - 'LOGNAME': 'cltbld', 11:44:14 INFO - 'MAIL': '/var/mail/cltbld', 11:44:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:14 INFO - 'MOZ_NO_REMOTE': '1', 11:44:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:14 INFO - 'NO_EM_RESTART': '1', 11:44:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:14 INFO - 'PWD': '/builds/slave/test', 11:44:14 INFO - 'SHELL': '/bin/bash', 11:44:14 INFO - 'SHLVL': '1', 11:44:14 INFO - 'TERM': 'linux', 11:44:14 INFO - 'TMOUT': '86400', 11:44:14 INFO - 'USER': 'cltbld', 11:44:14 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1449861998.969139-1555663588', 11:44:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:14 INFO - '_': '/tools/buildbot/bin/python'} 11:44:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:44:14 INFO - Running setup.py (path:/tmp/pip-ssD6Xv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:44:14 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)) 11:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:44:14 INFO - Running setup.py (path:/tmp/pip-iCNlI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:44:14 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)) 11:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:44:14 INFO - Running setup.py (path:/tmp/pip-sWtEFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:44:14 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)) 11:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:44:14 INFO - Running setup.py (path:/tmp/pip-wz42wS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:44:14 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)) 11:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:44:14 INFO - Running setup.py (path:/tmp/pip-nWRLFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:44:14 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)) 11:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:44:14 INFO - Running setup.py (path:/tmp/pip-9WwYzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:44:14 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)) 11:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:44:14 INFO - Running setup.py (path:/tmp/pip-BSeqiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:44:14 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)) 11:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:44:14 INFO - Running setup.py (path:/tmp/pip-Vz8Il8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:44:15 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)) 11:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:44:15 INFO - Running setup.py (path:/tmp/pip-XYOvFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:44:15 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)) 11:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:44:15 INFO - Running setup.py (path:/tmp/pip-mMP_jR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:44:15 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)) 11:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:44:15 INFO - Running setup.py (path:/tmp/pip-FGlVLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:44:15 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)) 11:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:44:15 INFO - Running setup.py (path:/tmp/pip-3U_kIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:44:15 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)) 11:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:44:15 INFO - Running setup.py (path:/tmp/pip-c9wcCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:44:15 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)) 11:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:44:15 INFO - Running setup.py (path:/tmp/pip-somnfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:44:15 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)) 11:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:44:15 INFO - Running setup.py (path:/tmp/pip-REasE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:44:15 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)) 11:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:44:15 INFO - Running setup.py (path:/tmp/pip-kFIxPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:44:15 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)) 11:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:44:15 INFO - Running setup.py (path:/tmp/pip-aDLWyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:44:15 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)) 11:44:15 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)) 11:44:15 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)) 11:44:15 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)) 11:44:15 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)) 11:44:15 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)) 11:44:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:17 INFO - Downloading blessings-1.5.1.tar.gz 11:44:17 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 11:44:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:44:17 INFO - Installing collected packages: blessings 11:44:17 INFO - Running setup.py install for blessings 11:44:17 INFO - Successfully installed blessings 11:44:17 INFO - Cleaning up... 11:44:17 INFO - Return code: 0 11:44:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:44:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:44:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:44:17 INFO - Reading from file tmpfile_stdout 11:44:17 INFO - Current package versions: 11:44:17 INFO - argparse == 1.2.1 11:44:17 INFO - blessings == 1.5.1 11:44:17 INFO - blobuploader == 1.2.4 11:44:17 INFO - docopt == 0.6.1 11:44:17 INFO - manifestparser == 1.1 11:44:17 INFO - mozInstall == 1.12 11:44:17 INFO - mozcrash == 0.16 11:44:17 INFO - mozdebug == 0.1 11:44:17 INFO - mozdevice == 0.47 11:44:17 INFO - mozfile == 1.2 11:44:17 INFO - mozhttpd == 0.7 11:44:17 INFO - mozinfo == 0.9 11:44:17 INFO - mozleak == 0.1 11:44:17 INFO - mozlog == 3.1 11:44:17 INFO - moznetwork == 0.27 11:44:17 INFO - mozprocess == 0.22 11:44:17 INFO - mozprofile == 0.27 11:44:17 INFO - mozrunner == 6.11 11:44:17 INFO - mozscreenshot == 0.1 11:44:17 INFO - mozsystemmonitor == 0.0 11:44:17 INFO - moztest == 0.7 11:44:17 INFO - mozversion == 1.4 11:44:17 INFO - psutil == 3.1.1 11:44:17 INFO - requests == 1.2.3 11:44:17 INFO - wsgiref == 0.1.2 11:44:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:44:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:17 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 0x7f24a5736f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c320b0>, '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 0x1c32fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c33440>, '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': '1d09c2d9237d126f9c84bbb400000198-1449861998.969139-1555663588', '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 11:44:17 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 11:44:17 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 11:44:17 INFO - Using env: {'DISPLAY': ':0', 11:44:17 INFO - 'HOME': '/home/cltbld', 11:44:17 INFO - 'LANG': 'en_US.UTF-8', 11:44:17 INFO - 'LANGUAGE': 'en_US:en', 11:44:17 INFO - 'LOGNAME': 'cltbld', 11:44:17 INFO - 'MAIL': '/var/mail/cltbld', 11:44:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:17 INFO - 'MOZ_NO_REMOTE': '1', 11:44:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:17 INFO - 'NO_EM_RESTART': '1', 11:44:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:17 INFO - 'PWD': '/builds/slave/test', 11:44:17 INFO - 'SHELL': '/bin/bash', 11:44:17 INFO - 'SHLVL': '1', 11:44:17 INFO - 'TERM': 'linux', 11:44:17 INFO - 'TMOUT': '86400', 11:44:17 INFO - 'USER': 'cltbld', 11:44:17 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1449861998.969139-1555663588', 11:44:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:17 INFO - '_': '/tools/buildbot/bin/python'} 11:44:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:18 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)) 11:44:18 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)) 11:44:18 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)) 11:44:18 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)) 11:44:18 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)) 11:44:18 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)) 11:44:18 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)) 11:44:18 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)) 11:44:18 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)) 11:44:18 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)) 11:44:18 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)) 11:44:18 INFO - Cleaning up... 11:44:18 INFO - Return code: 0 11:44:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:44: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')]} 11:44:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44: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')]} 11:44:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f24a5736f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c320b0>, '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 0x1c32fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c33440>, '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': '1d09c2d9237d126f9c84bbb400000198-1449861998.969139-1555663588', '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 11:44:18 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 11:44:18 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 11:44:18 INFO - Using env: {'DISPLAY': ':0', 11:44:18 INFO - 'HOME': '/home/cltbld', 11:44:18 INFO - 'LANG': 'en_US.UTF-8', 11:44:18 INFO - 'LANGUAGE': 'en_US:en', 11:44:18 INFO - 'LOGNAME': 'cltbld', 11:44:18 INFO - 'MAIL': '/var/mail/cltbld', 11:44:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:18 INFO - 'MOZ_NO_REMOTE': '1', 11:44:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:18 INFO - 'NO_EM_RESTART': '1', 11:44:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:18 INFO - 'PWD': '/builds/slave/test', 11:44:18 INFO - 'SHELL': '/bin/bash', 11:44:18 INFO - 'SHLVL': '1', 11:44:18 INFO - 'TERM': 'linux', 11:44:18 INFO - 'TMOUT': '86400', 11:44:18 INFO - 'USER': 'cltbld', 11:44:18 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1449861998.969139-1555663588', 11:44:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:18 INFO - '_': '/tools/buildbot/bin/python'} 11:44:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:18 INFO - Downloading/unpacking jsonschema 11:44:18 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 11:44:18 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 11:44:18 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 11:44:18 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 11:44:18 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 11:44:18 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 11:44:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:44:19 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 11:44:19 INFO - Downloading/unpacking functools32 (from jsonschema) 11:44:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:20 INFO - Downloading functools32-3.2.3-2.tar.gz 11:44:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 11:44:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:44:20 INFO - warning: no files found matching '*.txt' 11:44:20 INFO - no previously-included directories found matching 'build' 11:44:20 INFO - no previously-included directories found matching 'dist' 11:44:20 INFO - no previously-included directories found matching '.git*' 11:44:20 INFO - Installing collected packages: jsonschema, functools32 11:44:20 INFO - Running setup.py install for functools32 11:44:20 INFO - warning: no files found matching '*.txt' 11:44:20 INFO - no previously-included directories found matching 'build' 11:44:20 INFO - no previously-included directories found matching 'dist' 11:44:20 INFO - no previously-included directories found matching '.git*' 11:44:20 INFO - Successfully installed jsonschema functools32 11:44:20 INFO - Cleaning up... 11:44:20 INFO - Return code: 0 11:44:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f24a5736f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c320b0>, '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 0x1c32fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c33440>, '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': '1d09c2d9237d126f9c84bbb400000198-1449861998.969139-1555663588', '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 11:44:20 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 11:44:20 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 11:44:20 INFO - Using env: {'DISPLAY': ':0', 11:44:20 INFO - 'HOME': '/home/cltbld', 11:44:20 INFO - 'LANG': 'en_US.UTF-8', 11:44:20 INFO - 'LANGUAGE': 'en_US:en', 11:44:20 INFO - 'LOGNAME': 'cltbld', 11:44:20 INFO - 'MAIL': '/var/mail/cltbld', 11:44:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:20 INFO - 'MOZ_NO_REMOTE': '1', 11:44:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:20 INFO - 'NO_EM_RESTART': '1', 11:44:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:20 INFO - 'PWD': '/builds/slave/test', 11:44:20 INFO - 'SHELL': '/bin/bash', 11:44:20 INFO - 'SHLVL': '1', 11:44:20 INFO - 'TERM': 'linux', 11:44:20 INFO - 'TMOUT': '86400', 11:44:20 INFO - 'USER': 'cltbld', 11:44:20 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1449861998.969139-1555663588', 11:44:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:20 INFO - '_': '/tools/buildbot/bin/python'} 11:44:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:20 INFO - Downloading/unpacking flake8 11:44:20 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 11:44:20 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 11:44:20 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 11:44:20 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 11:44:20 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 11:44:20 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 11:44:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:44:22 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 11:44:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:44:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:44:22 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 11:44:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:44:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:22 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 11:44:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:44:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 11:44:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:44:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:44:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:44:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:44:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:44:22 INFO - no previously-included directories found matching 'docs/_build' 11:44:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:44:22 INFO - Running setup.py install for pep8 11:44:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:44:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:44:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:44:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:44:23 INFO - no previously-included directories found matching 'docs/_build' 11:44:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:44:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:44:23 INFO - Cleaning up... 11:44:23 INFO - Return code: 0 11:44:23 INFO - Running post-action listener: _resource_record_post_action 11:44:23 INFO - Running post-action listener: _start_resource_monitoring 11:44:23 INFO - Starting resource monitoring. 11:44:23 INFO - ##### 11:44:23 INFO - ##### Running install step. 11:44:23 INFO - ##### 11:44:23 INFO - Running pre-action listener: _resource_record_pre_action 11:44:23 INFO - Running main action method: install 11:44:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:44:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:44:23 INFO - Reading from file tmpfile_stdout 11:44:23 INFO - Detecting whether we're running mozinstall >=1.0... 11:44:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:44:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:44:23 INFO - Reading from file tmpfile_stdout 11:44:23 INFO - Output received: 11:44:23 INFO - Usage: mozinstall [options] installer 11:44:23 INFO - Options: 11:44:23 INFO - -h, --help show this help message and exit 11:44:23 INFO - -d DEST, --destination=DEST 11:44:23 INFO - Directory to install application into. [default: 11:44:23 INFO - "/builds/slave/test"] 11:44:23 INFO - --app=APP Application being installed. [default: firefox] 11:44:23 INFO - mkdir: /builds/slave/test/build/application 11:44:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:44:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:44:38 INFO - Reading from file tmpfile_stdout 11:44:38 INFO - Output received: 11:44:38 INFO - /builds/slave/test/build/application/firefox/firefox 11:44:38 INFO - Running post-action listener: _resource_record_post_action 11:44:38 INFO - ##### 11:44:38 INFO - ##### Running run-tests step. 11:44:38 INFO - ##### 11:44:38 INFO - Running pre-action listener: _resource_record_pre_action 11:44:38 INFO - Running main action method: run_tests 11:44:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:44:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:44:38 INFO - Python 2.7.3 11:44:38 INFO - Return code: 0 11:44:38 INFO - grabbing minidump binary from tooltool 11:44: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')]} 11:44:38 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 0x1c320b0>, '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 0x1c32fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c33440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:44:38 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 11:44:38 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 11:44:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:44:38 INFO - Return code: 0 11:44:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:44:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:44:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:44:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:44:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:44:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:44:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:44:39 INFO - Return code: 0 11:44:39 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/wcLmEt5RQje3HufTPJI1nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost'] in /builds/slave/test/build 11:44:39 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/wcLmEt5RQje3HufTPJI1nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost 11:44:39 INFO - Using env: {'DISPLAY': ':0', 11:44:39 INFO - 'HOME': '/home/cltbld', 11:44:39 INFO - 'LANG': 'en_US.UTF-8', 11:44:39 INFO - 'LANGUAGE': 'en_US:en', 11:44:39 INFO - 'LOGNAME': 'cltbld', 11:44:39 INFO - 'MAIL': '/var/mail/cltbld', 11:44:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:44:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:44:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:39 INFO - 'MOZ_NO_REMOTE': '1', 11:44:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:44:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:39 INFO - 'NO_EM_RESTART': '1', 11:44:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:39 INFO - 'PWD': '/builds/slave/test', 11:44:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:44:39 INFO - 'SHELL': '/bin/bash', 11:44:39 INFO - 'SHLVL': '1', 11:44:39 INFO - 'TERM': 'linux', 11:44:39 INFO - 'TMOUT': '86400', 11:44:39 INFO - 'USER': 'cltbld', 11:44:39 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1449861998.969139-1555663588', 11:44:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:39 INFO - '_': '/tools/buildbot/bin/python'} 11:44:39 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/wcLmEt5RQje3HufTPJI1nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost'] with output_timeout 3600 11:44:39 INFO - mozversion INFO | application_buildid: 20151211110732 11:44:39 INFO - mozversion INFO | application_changeset: 146f5531e7bd31d92215aaa6b489f62a14994503 11:44:39 INFO - mozversion INFO | application_display_name: Nightly 11:44:39 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:44:39 INFO - mozversion INFO | application_name: Firefox 11:44:39 INFO - mozversion INFO | application_remotingname: firefox 11:44:39 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 11:44:39 INFO - mozversion INFO | application_vendor: Mozilla 11:44:39 INFO - mozversion INFO | application_version: 45.0a1 11:44:39 INFO - mozversion INFO | platform_buildid: 20151211110732 11:44:39 INFO - mozversion INFO | platform_changeset: 146f5531e7bd31d92215aaa6b489f62a14994503 11:44:39 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 11:44:39 INFO - mozversion INFO | platform_version: 45.0a1 11:44:39 INFO - 2015-12-11 11:44:39,226 DEBUG : using testdate: 1449863079 11:44:39 INFO - 2015-12-11 11:44:39,226 DEBUG : actual date: 1449863079 11:44:39 INFO - 2015-12-11 11:44:39,235 INFO : starting webserver on 'localhost:55968' 11:44:39 INFO - 2015-12-11 11:44:39,236 INFO : Starting test suite talos-linux64-ix-029.e 11:44:39 INFO - 2015-12-11 11:44:39,236 INFO : Starting test dromaeo_css 11:44:39 INFO - 2015-12-11 11:44:39,236 DEBUG : operating with platform_type : linux_ 11:44:39 INFO - 2015-12-11 11:44:39,237 INFO : Initialising browser for dromaeo_css test... 11:44:39 INFO - 2015-12-11 11:44:39,251 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCXC5QO/profile http://localhost:55968/getInfo.html 11:44:44 INFO - 2015-12-11 11:44:44,484 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:44:44 INFO - 2015-12-11 11:44:44,484 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:44:44 INFO - 2015-12-11 11:44:44,484 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:44:44 INFO - 2015-12-11 11:44:44,484 DEBUG : BROWSER_OUTPUT: __metrics 11:44:44 INFO - 2015-12-11 11:44:44,613 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] 11:44:45 INFO - 2015-12-11 11:44:45,574 INFO : Browser initialized. 11:44:45 INFO - 2015-12-11 11:44:45,574 INFO : Running cycle 1/1 for dromaeo_css test... 11:44:45 INFO - 2015-12-11 11:44:45,575 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCXC5QO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:44:57 INFO - 2015-12-11 11:44:57,540 DEBUG : BROWSER_OUTPUT: RSS: Main: 142958592 11:44:57 INFO - 2015-12-11 11:44:57,540 DEBUG : BROWSER_OUTPUT: 11:45:47 INFO - 2015-12-11 11:45:47,180 DEBUG : BROWSER_OUTPUT: 1449863147178 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] 11:47:59 INFO - 2015-12-11 11:47:59,019 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55968/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55968/tests/dromaeo/cssquery-ext.html) 11:48:00 INFO - 2015-12-11 11:48:00,132 DEBUG : BROWSER_OUTPUT: RSS: Main: 146042880 11:48:00 INFO - 2015-12-11 11:48:00,132 DEBUG : BROWSER_OUTPUT: 11:51:02 INFO - 2015-12-11 11:51:02,193 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55968/tests/dromaeo/cssquery-ext.html (next: http://localhost:55968/tests/dromaeo/cssquery-jquery.html) 11:51:02 INFO - 2015-12-11 11:51:02,780 DEBUG : BROWSER_OUTPUT: RSS: Main: 145100800 11:51:02 INFO - 2015-12-11 11:51:02,780 DEBUG : BROWSER_OUTPUT: 11:54:04 INFO - 2015-12-11 11:54:04,675 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55968/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55968/tests/dromaeo/cssquery-mootools.html) 11:54:05 INFO - 2015-12-11 11:54:05,282 DEBUG : BROWSER_OUTPUT: RSS: Main: 144994304 11:54:05 INFO - 2015-12-11 11:54:05,282 DEBUG : BROWSER_OUTPUT: 11:57:07 INFO - 2015-12-11 11:57:07,026 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55968/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55968/tests/dromaeo/cssquery-prototype.html) 11:57:07 INFO - 2015-12-11 11:57:07,632 DEBUG : BROWSER_OUTPUT: RSS: Main: 144658432 11:57:07 INFO - 2015-12-11 11:57:07,632 DEBUG : BROWSER_OUTPUT: 12:00:10 INFO - 2015-12-11 12:00:10,288 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55968/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55968/tests/dromaeo/cssquery-yui.html) 12:00:10 INFO - 2015-12-11 12:00:10,917 DEBUG : BROWSER_OUTPUT: RSS: Main: 145154048 12:00:10 INFO - 2015-12-11 12:00:10,918 DEBUG : BROWSER_OUTPUT: 12:03:13 INFO - 2015-12-11 12:03:13,594 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55968/tests/dromaeo/cssquery-yui.html (next: http://localhost:55968/tests/dromaeo/cssquery-dojo.html) 12:03:13 INFO - 2015-12-11 12:03:13,852 DEBUG : BROWSER_OUTPUT: RSS: Main: 147398656 12:03:13 INFO - 2015-12-11 12:03:13,853 DEBUG : BROWSER_OUTPUT: 12:03:13 INFO - 2015-12-11 12:03:13,853 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:03:13 INFO - 2015-12-11 12:03:13,853 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:03:13 INFO - 2015-12-11 12:03:13,853 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:03:13 INFO - 2015-12-11 12:03:13,854 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:03:13 INFO - 2015-12-11 12:03:13,854 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2669.919902402928;2733.5079685656574;2764.447110577885;2777.2501424615352;2781.304673831542;4401.60385565299;4673.158831410349;4750.16872047392;4782.7847746851385;4806.615470762339;4663.183942810003;4683.414573178353;4692.6949748266425;4707.858764237069;4818.301346304784;4341.283688191453;4423.159599676067;4456.353828694837;4481.529439408864;4519.299508576176;4320.935185972213;4368.170047690945;4373.825046998117;4408.228560002003;4475.485319188286;4181.121964387482;4293.22721910056;4314.525402205755;4405.80173892174;4451.354553589744;4429.601335879786;4430.911381772346;4454.175977444183;4464.441944756905;4468.262736648449;4408.184485870124;4420.734755914656;4433.800478978454;4444.555544445562;4476.955230447719;4361.193179261847;4454.688171827974;4471.5081341052455;4505.954940450619;4715.245560710304;4987.750612469362;5041.798328066873;5080.974595127001;5107.565856902168;5171.017506673757;5126.538611524943;5132.0505706444055;5152.175651895679;5165.66423182492;5194.71429071401;4579.290210017452;4686.179918514246;4747.216709242936;4761.666683332168;4765.142274390573;5206.479352064764;5252.369715634072;5277.683338999673;5279.762410691528;5318.547923426552;4980.9252861207115;5049.343585333883;5049.798008079709;5054.873628159252;5095.770690318945;4921.680090794159;4995.125852975715;5033.6224783141415;5112.565431938327;5150.48495150482;5130.51260130287;5146.639735218499;5150.1502252127975;5161.045206636784;5171.379434467888;5113.71874546896;5115.8721031973755;5126.53861152498;5136.640435169577;5191.013707395583;4065.97967010169;4161.126163505637;4187.225363307737;4293.5706429356815;4332.891677708019;3744.2137151198554;3766.8681596144;3768.2275133597545;3799.506064211635;3806.3719486284454;4396.758178300161;4417.668674849399;4419.779011049499;4421.049474362963;4454.910901782011;4868.196747536687;4984.700917944862;5109.693418394834;5209.583233341324;5244.527992480619;4400.823967041282;4411.09572537629;4412.624926881187;4416.889577760518;4464.2633965396;4334.393184954109;4543.795529201194;4556.11155824611;4571.81712731487;4618.214903466419;4735.810567577259;4758.5241475852135;4769.666123371469;4781.043791241696;4783.976080119577;5122.948770512397;5175.197844334134;5190.299309593308;5192.350956130484;5204.9739751301;4845.830395936126;4865.367502224688;4868.95131048685;4869.561739443467;4941.827036053721;4804.95195048045;4862.95137048625;4911.557959783494;5103.234514822806;5116.462771408948;5169.560587349967;5191.792328306826;5211.426743058337;5217.139172036572;5223.52988231061;5026;5027.170516864822;5027.899442011212;5034.0686972910125;5074.67014644047;4761.9047619048115;4850.46644869057;4895.681780684244;4991.276264941635;5009.849704508871;4831.685940413862;4841.2496063110275;4849.393825771778;4861.854144375674;4944.826931057396;4978.601711863114;4985.6260780442335;4999.450060493416;5001.599872010158;5002.874928126826;4708.81164753406;4767.118083154627;4792.113459010095;4914.238293064581;4931.679440836334 12:03:13 INFO - 2015-12-11 12:03:13,854 DEBUG : BROWSER_OUTPUT: |1;ext.html;554.8834744703612;579.6695883346491;581.6568224747398;585.5579037826443;585.6749504025264;34734.65265347346;35209.2958140837;35263;35274.29451410974;35328.64671353286;39302.80348598253;39727.60272397275;39733.20533589327;39904.800475997654;39978.40032399509;7925.326347260476;8100.392470564701;8105.918940810576;8180.6318715657935;8182.18178182183;7925.801854953615;7927.643256053462;8007.719729809458;8008.27925486706;8021.759347219593;7996.560189189592;8061.556614386206;8062;8081.4747041442415;8087.514749115043;7992.880106798402;8056.476329038623;8065.233802788725;8090.878636820453;8095.311898488636;7835.451518393715;8045.758627241192;8050.838983220303;8052.677892884278;8066.314363279128;35574.82212588946;35928.820355898315;35946;35981.46027809585;36173.81913090418;2859.642544681915;2891.5951766752673;2904.7095290470993;2919.8832046718107;2955.7044295570486;27581.448371032668;27745.167644970683;27881.442371152665;27928.720712792816;27979.86010069957;3426.880059197916;3493.371193185226;3530.858765649371;3567.4470457079196;3582.6954708849516;210824;211204;211256;211311;211990.94004530032;38717.419238711445;38804.6119538801;38826.417603735965;53098.69013098659;53353;35129.64870351264;35319.64680353215;35434.82282588622;35463.11342216465;35471.645283547354;11019.559217631206;11034.779304414027;11052.336859788438;11074.667759967213;11075.889241107647;9572.856407153899;9620.037996200324;9628.855567166498;9632.373895696757;9658.806823863484;12905.483780648668;13069.215847049207;13417.597472075853;13490.865091349157;13515.52695655667;5469.15228139631;5507.779688812483;5521.116621340566;5521.503064724114;5577.8047768327915;796.8207153390441;824.2952275804221;876.3339861705023;877.3989816975393;880.506916126971;25953.480930381666;25964.22107336783;25971.610425843628;26017.089401870842;26266.73733262681;886.1802832380023;905.6422713028317;916.7852595311106;930.0606387548625;1005.994005994006;13846.169229846242;13969.161850288812;15134.848651513565;15906.68186636284;16538.25577849;317144;323646;327951;327958;330326;47522.52477475181;48018;48181.759091204316;48297.27554086621;48588.5141148584;1155.1278784517804;1224.13086708438;1233.8396008519014;1238.8451443569554;1245.7197130645532;27332.316692082855;27388.178354649393;27447.588286176124;27769.72230277752;27926.3018424541;38698.80650596729;39539.209215816096;39735.403968939914;39850.40224396694;39892;248661;248864;249057;250493;251116;29055;29624.111276661733;39067.804660976515;39433.21133577255;39587.80206098951;34680.826595866856;35280;35322.47016294809;35422.822885885405;35934.10164745902;32288.67711322857;32657.836710816293;33776;33794.32411351809;34304.485432719026;32999.50500742443;33085.007449776545;33550.161245969044;37675;39369.60630393774;32241.35517289688;32609.836950815094;33025.50461743124;33340.666593334725;33423.66576334303;28494.287642809097;30101.39797204;30724.846375768873;30764.116304456224;30801.861721943744;23967.28098157058;23972.160974365812;24006.27981160568;24035;24334.391640209138 12:03:13 INFO - 2015-12-11 12:03:13,855 DEBUG : BROWSER_OUTPUT: |2;jquery.html;334.44816053511704;336.89219449776067;339.03713453791227;341.16584949797743;342.04739799657955;12767.106302558814;15297.082175069503;15438.69122617547;16387.508374748748;16939.83060169398;9536.76158096048;9792.559334829932;9868.901310986888;10590.576376944913;10749.677509674702;4507.1887060329045;4627;4632.559906808865;4635.351050852883;4642.164410406125;5014.974925125388;5035.723035233061;5042.294078828967;5043.722595257259;5050.090983622947;4946.925796113062;5001.949590585963;5009.398872135331;5114.769835357418;5115.718635475047;4841.273808928689;5047.0915235257635;5082.898342033157;5087.338645976018;5120.283160357553;4859.441164266119;4879.6096312295285;4885.218365061609;4886.560209581155;4895.290182923456;11777.470013849397;14169.079009864428;16363.263653135638;18971.43085707431;19001.239950401967;1779.5551112221945;1845.5386153461634;1867.1037901807208;1872.7378167056622;1933.2170470959284;9044.41211321262;9294.488803115826;10233.437160956144;12697;13297.268650224234;1712.4520153550868;1774.4676597020841;1906.237504997998;1947.9707804382945;2038.062491254025;46341.53658463406;46508.767456162845;46642.76678616619;47291.29063064057;48589;9736.95131524338;9748.512574371252;9753.9024609753;9753.9024609753;9776.266779991529;11962.521499139937;12011.939940300243;12037.458314375874;12052.578159764542;12114.273143611412;6584.341565843473;6683.933160668428;6896.827579310558;6945.40964018054;6998.650067496605;6501;6587.703553340111;6627.734890604418;6675.098861653614;6693.631850248185;4201.579842015835;4230.873073807791;4265;4277.850275240414;4280.186764514732;1641.7947756530434;1698.422536337651;1779.1104447776113;1786.455131184975;1787.3386846866483;364.83035388544454;367.90802299425144;377.1325950314266;377.7487970499587;797.704849205786;9773.169280611086;10001.49992500372;15476.690466190614;16732.665346692997;16841.32634694623;811.3306522119275;820.3478234803346;831.2394159344133;881.6781874615847;928.6842473559022;9047.68333108338;9107.681231156877;9255.537223138816;9314.115159059878;9395.62417503306;480238;482693;483749;485744;486899;69953.65023174851;73066;74619.62690186514;75284;77636.2236377629;1005.3465247588979;1027.5427434791595;1032;1034.6275340877428;1035.4667346316653;14133.787993179905;14139.363728632443;14159.787603185754;14163.150210987375;14216.928915355356;33284.50073248952;33703.15742106467;34000.65999339975;34215.486767699;35248.647513524535;42862.56719758593;43544.56455435405;45338.319925200485;47806.5219347816;48580;8867.73396798097;8969.820603588023;8974.14745599167;9037.50293733851;9315.301352398461;16481.67036659284;16764.58088547796;16994.895331803393;17088.829111708725;17178.570535736708;12933.805992909925;13081.738365232832;13165.144265622705;13567.253801041037;13686.931565342109;12447.813282800946;12594.055445841415;12946.676333091747;12991.28547929873;13519.459221631025;13297.335133243105;13565.660858478223;13752.862471375558;13805.516806912112;13939.790903136258;8741.475511469333;8773.956130219309;9008.864867026869;9077.364584479023;9077.409968352036;12948.741025179632;13087.541936032194;13128.409221585243;13151.73696526045;13379.197248165141 12:03:13 INFO - 2015-12-11 12:03:13,858 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1406.1071219775442;1469.8750606198469;1569.270289315468;1586.095925322565;1721.9397321093757;5966.642001479914;6078.908816367758;6986.580805151694;7054.871220604698;7121.07426034616;6757;6968.756093536727;7025.508214424993;7027.156741191052;7027.824304392393;1992.561636439981;2011.1553147677937;2021.7068525063858;2021.848361372903;2022.3629556689668;2068.731064961553;2069.8344132469365;2071.6685330347145;2134.295682424804;2147.742270927483;2047.252752745252;2064.6283668939586;2071.6996035574834;2097.423208617635;2103.1587365054024;2035.2571311471281;2051.5178932950744;2067.58648270345;2067.9586408271903;2068;2026.6149431607948;2030.715699802029;2075.833933285349;2079.646460101771;2083.5728675621613;6740;6779.830504237384;6840.384365407088;6840.760573379957;6862.4853136015;4004.659603933669;4022.3765316376007;4077.3068578341754;4083.571225021389;4091.0386059276047;2673.2514895829004;2673.585594232897;2700.7704345130687;2745.4646343962936;2747.230775382896;847.4830353484369;862.9913700862974;866.9696560620348;879.9428037177563;891.6032365597312;9054.909450905472;9059.456432614064;9093.408928419698;9098.363114581982;9127.17855393011;3797.6771974381936;3833.4824798651825;3884.0484081400236;3891.785951772623;3893.922121557553;7866.056073271244;7870.173631768696;7872.763817085496;7886.526808391515;7914.683412663544;4124.340105583093;4134.37984302357;4139.234241665302;4155.667546596325;4158.708890377645;3202.59967504062;3273.3126043531124;3775.1505911170316;3777.3956167013694;3784.962150378516;3415.077928959167;3427.0404286799735;3427.108951672583;3458.0490365149785;3470.1151206442196;1057.143713591993;1060.5121644043672;1066.7866426714534;1074.9032587067202;1096.353151640536;752.5108679358461;874.9343799215085;996.8554559588964;1011.2011510906301;1018.3024628129607;6650.600963942082;6675.833104172338;6676.899846502306;6678.7662431815625;6713.2279787824045;411.13866449787645;417.04704749646913;419.1805021183579;420.87584162672084;422.34958164427053;5075.1625981712605;5077.213031980049;5128.3076784633595;5130.384353877558;5150.021495915764;8252.174782521699;8271.131531189138;8390.580470976427;8436.114208008194;8489.787755306043;8363.330933525303;8366.623501942306;8392.706255281037;8402.537860417735;8404.285635721033;6477.514186436036;6536.869262614721;6606.768763093365;6612.86774264512;6628.171478565179;6109.694515274307;6111.724972376165;6147.200863887666;6151.6924153793025;6154.599951003171;7346.963265183854;7419.96290018568;7585.16563178061;7663.923360766321;7760.417968652487;7660.425468089804;7734.845303093794;7766.534007959541;7830.843383132419;7850.293473587176;5212.895742085213;5299.125644268653;5686.402927692533;6095.116208149882;6250.937490625218;6420.2616699078335;6435.581687190318;6459.418652321314;6474.5791523550815;6498.415142637185;6000.129981152796;6151.569390142647;6178.845528861814;6247.937520624918;6291.056341548804;6118.235220597426;6200.844978875564;6205.65868877198;6276.403741644536;6290.2451705793765;6216.44052035319;6278.6546739929745;6293.433590976834;6306.211723534559;6326.335734747785;5728.054870946247;5805.274340707411;5815.912761308499;5822.7670893163795;5847.473727364558;5876.882462350814;5927.703614819328;5950.880982380415;5957.463828255478;5960.940390596212 12:03:13 INFO - 2015-12-11 12:03:13,858 DEBUG : BROWSER_OUTPUT: |4;prototype.html;305.07866243943295;309.7104207565926;311.9204602826282;312.64670921858306;315.84558438905793;5547;5570.220169176318;5585.636933599313;5628.915566266499;5771.365149833515;5580.972095139528;5618.690971996539;5633.0987042073275;5641.52047075998;5651.745671444784;4169.103642716816;4315.71947823392;4320.179165958473;4322.200392927302;4329.631981281595;4293.205756934962;4297.312430011199;4307.741535507864;4309.224339618867;4309.892252693677;4247.8088486018205;4251.4898212214575;4252.340887162495;4260.956065763892;4265.31754919213;4252.829886804524;4258.084511829956;4265.466816647919;4269.615734583902;4279.079997800488;3613.6205698401814;3688.967089215024;3694.3350196964534;3702.555693316819;3706.4440333949856;5201.193814958688;5313.495217954288;5332.200169974496;5337.11937530307;5344.278522399465;4874.195757699975;4875.658703890729;4882.170031094723;4885.340479035356;4889.217725163957;5883.911741323884;5897.14491398749;5907.232059832194;5916.792912248051;5932.466078052953;3876.3022655921923;3964.187341594995;3995.4206640037323;4013.257547353749;4016.6987475939422;6163.660998645073;6219.968900155515;6228.159198508234;6230.59501132425;6235.064740288947;4115.403266526337;4131.690123240769;4136.855210067633;4138.0689344897155;4138.6482149017675;4188.85339013133;4192.203481338536;4198.160367926366;4209.810558524812;4215.3044747616295;4754;4823.2282834746975;4830.130576496194;4840.152973229741;4848.75756212195;5862.970685146547;5864.970675146682;5869.4717475427415;5884.499817515473;5895.469407753237;1466.340146933884;1469.7354476194173;1482.85171482853;1487.137460273039;1488.3823213366547;984.7685793838442;987.5062468765617;992.6707970446627;999.2805180270194;1004.5178314409125;5098.4646612105935;5120.8222108914415;5122.385313762298;5126.410462796752;5130.9230361544605;6096.237970253718;6109.572329936862;6111.236095488064;6113.663748493876;6136.048912418582;5105.566026887756;5109.948900511022;5111.974440127776;5124.92312615311;5128.461511541309;3214.5981752280964;3295.2256219788333;3306.5866766654167;3306.9503957440656;3326.185084654275;5576.498115169573;5705.22979397776;5743.4256574342235;5823.213866128103;5829.271341082364;6228.56400051992;6356.523260755462;6373.490120790419;6378;6379.043143528508;5779.653220806681;5780.450857168562;5783.566232532493;5784.074548072288;5790.10253410722;5904.763809447574;6121.081837724377;6121.989871671302;6136.263648362046;6149.508039356751;5971.164037034731;6028.788992385245;6035.668038257938;6037.45662890342;6043.516518678407;5774.538036956949;5790.10253410722;5798.304203495608;5806.622569532967;5806.68063256525;4103.528094269078;4156.750594964312;4159.417681524528;4160.126373461486;4183.790810459525;6035.430787995065;6104.4505994460715;6161.291451483136;6170.969145154246;6174.876502470015;5908.3205431375945;5920.555958303058;5921.5558833086825;5925.05199168131;5936.37668044849;5902.439268269508;5927.911081333869;5933.703314834327;5945.167676525376;5955.553333499918;5649.661020338793;5741.569382296428;5765.654060756368;5773.566982476415;5813.09896965971;5951;5963.52291816645;5974.312954010345;5978.641281523122;5987.0121429963565;5769.134629805395;5807.651540907559;5808.186853840551;5812.099124635688;5816.76732930678 12:03:13 INFO - 2015-12-11 12:03:13,859 DEBUG : BROWSER_OUTPUT: |5;yui.html;755.4744705992872;769.8960640313558;773.5397438524078;788.0228516639369;808.2200676347323;10774.569017239312;11003.834942475869;11025.61410350638;11026.834597481044;11030.338179709222;11448.656540303784;11510.194286399956;11553.768924621523;11570.595029173981;11582.942085289584;793.7698067560415;809.5830647216688;812.2892469089546;813.8860559521642;813.9104698483162;801.0627565748059;814.4054839966827;815.8001289684036;815.8205194857152;816.5876232502578;840.1430540848331;845.7547311279721;850.7873031742065;852.1308265569115;853.6926706385697;842.4103127810496;843.6203708331245;846.7713717296357;847.1570787066846;847.3221422861717;619.863630001399;621.8072397556726;622.3993845938691;624.3413199074975;628.2931701835436;10452.94773526135;10496.580136794519;10559.26085174038;10612.151027917747;10621.946890265499;9264.675736349263;9337.953310233474;9492.762680933032;9730.805383892353;9784.559694813679;8633.35249856257;8659.913400865973;8754.080821513713;8770.122987701243;8824.955875220583;3201.6958388953244;3221.742260619168;3230.16015835882;3232.2565809863627;3298.4392653249006;40720.38919416211;41446.37830432546;43172.56827431717;43173.35239971403;43209.35185972245;8082.797930051795;8261.545614991233;8280.420370574002;9164.450132992042;9396;15224.314905829264;15381.615459613598;15398.692026159413;15543.300551475211;15546.300416481285;6268.905966410507;6335.4931605472375;6382.808515744535;6401.295857455676;6409.359064093554;3600.9459858101627;3613.602503724588;3638.9636103638622;3697.445383192489;3753.2868754936476;2517.0309430868883;2531.316544532966;2534.4550921551954;2539.0351666367033;2542.4025354041787;462.8935344870631;469.64541770962705;474.1986043586328;475.19928919770297;475.50547430672407;433.98915027124576;471.6886854675897;511.8387707872008;528.3923487988767;578.6672663218666;6873.931260687429;6965.79102626922;7089.964550177217;7472.962635186789;7557.771091251133;524.1011664994553;525.7949399734107;536.6243629459394;538.8437353167537;553.1177771454524;3260.49462333334;3505.772124811879;3517.9472307915403;3524.3303772283184;3551.3074950384425;50641.49358506442;51732.482675173516;55307.44692553103;55369.72315138479;55537;44296;44907.101857962654;44911;45517.77241113773;45965;36540;38579.6142038576;39035.219295613926;39488;39914.600853991666;7676.654550545127;7821.413393995587;8460.619272132646;8519.616617252363;8591.355648326275;32741;33040.83479582683;33127.33745325128;33522.66477335196;33654.66345336515;36385;40495.1900961985;41246;41568.792156039024;41755.7912210437;9141.131592498701;9203.171714545722;9294.163525282756;9474.810503789748;9611.279154063333;11088.944555277494;11404.258723182966;11445.885541144482;11485.942570287096;11903.821442678194;10269.589216431259;10681.51933163025;10692.572297108029;10806.081483074027;11116;10306.278560500992;10332.948335258276;10795.40625265618;11104.777904442028;11106.278091924;10224.23318251149;10369.9481502592;10635.255532112988;10947.069499092666;10999.725006874893;9033.50315732641;9209.447433154031;9249.76875578089;9386.953065234904;9430.57562409707;8461.619227134917;9105.726828195166;9109.908900910907;9121.133492318218;9201.401908875901 12:03:13 INFO - 2015-12-11 12:03:13,859 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:03:13 INFO - 2015-12-11 12:03:13,860 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:03:13 INFO - 2015-12-11 12:03:13,860 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,319 12:03:13 INFO - 2015-12-11 12:03:13,860 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:03:13 INFO - 2015-12-11 12:03:13,860 DEBUG : BROWSER_OUTPUT: __startTimestamp1449864193847__endTimestamp 12:03:13 INFO - 2015-12-11 12:03:13,860 DEBUG : BROWSER_OUTPUT: 12:03:13 INFO - 2015-12-11 12:03:13,860 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:03:13 INFO - 2015-12-11 12:03:13,860 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:03:13 INFO - 2015-12-11 12:03:13,860 DEBUG : BROWSER_OUTPUT: 12:03:13 INFO - 2015-12-11 12:03:13,861 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4706.64 Median:4804.95 stddev:495.10 (10.3%) stddev-sans-first:470.13 12:03:13 INFO - 2015-12-11 12:03:13,861 DEBUG : BROWSER_OUTPUT: Values: 2669.9 2733.5 2764.4 2777.3 2781.3 4401.6 4673.2 4750.2 4782.8 4806.6 4663.2 4683.4 4692.7 4707.9 4818.3 4341.3 4423.2 4456.4 4481.5 4519.3 4320.9 4368.2 4373.8 4408.2 4475.5 4181.1 4293.2 4314.5 4405.8 4451.4 4429.6 4430.9 4454.2 4464.4 4468.3 4408.2 4420.7 4433.8 4444.6 4477.0 4361.2 4454.7 4471.5 4506.0 4715.2 4987.8 5041.8 5081.0 5107.6 5171.0 5126.5 5132.1 5152.2 5165.7 5194.7 4579.3 4686.2 4747.2 4761.7 4765.1 5206.5 5252.4 5277.7 5279.8 5318.5 4980.9 5049.3 5049.8 5054.9 5095.8 4921.7 4995.1 5033.6 5112.6 5150.5 5130.5 5146.6 5150.2 5161.0 5171.4 5113.7 5115.9 5126.5 5136.6 5191.0 4066.0 4161.1 4187.2 4293.6 4332.9 3744.2 3766.9 3768.2 3799.5 3806.4 4396.8 4417.7 4419.8 4421.0 4454.9 4868.2 4984.7 5109.7 5209.6 5244.5 4400.8 4411.1 4412.6 4416.9 4464.3 4334.4 4543.8 4556.1 4571.8 4618.2 4735.8 4758.5 4769.7 4781.0 4784.0 5122.9 5175.2 5190.3 5192.4 5205.0 4845.8 4865.4 4869.0 4869.6 4941.8 4805.0 4863.0 4911.6 5103.2 5116.5 5169.6 5191.8 5211.4 5217.1 5223.5 5026.0 5027.2 5027.9 5034.1 5074.7 4761.9 4850.5 4895.7 4991.3 5009.8 4831.7 4841.2 4849.4 4861.9 4944.8 4978.6 4985.6 4999.5 5001.6 5002.9 4708.8 4767.1 4792.1 4914.2 4931.7 12:03:13 INFO - 2015-12-11 12:03:13,861 DEBUG : BROWSER_OUTPUT: 12:03:13 INFO - 2015-12-11 12:03:13,861 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41041.76 Median:19425.25 stddev:69754.94 (359.1%) stddev-sans-first:69884.39 12:03:13 INFO - 2015-12-11 12:03:13,862 DEBUG : BROWSER_OUTPUT: Values: 554.9 579.7 581.7 585.6 585.7 34734.7 35209.3 35263.0 35274.3 35328.6 39302.8 39727.6 39733.2 39904.8 39978.4 7925.3 8100.4 8105.9 8180.6 8182.2 7925.8 7927.6 8007.7 8008.3 8021.8 7996.6 8061.6 8062.0 8081.5 8087.5 7992.9 8056.5 8065.2 8090.9 8095.3 7835.5 8045.8 8050.8 8052.7 8066.3 35574.8 35928.8 35946.0 35981.5 36173.8 2859.6 2891.6 2904.7 2919.9 2955.7 27581.4 27745.2 27881.4 27928.7 27979.9 3426.9 3493.4 3530.9 3567.4 3582.7 210824.0 211204.0 211256.0 211311.0 211990.9 38717.4 38804.6 38826.4 53098.7 53353.0 35129.6 35319.6 35434.8 35463.1 35471.6 11019.6 11034.8 11052.3 11074.7 11075.9 9572.9 9620.0 9628.9 9632.4 9658.8 12905.5 13069.2 13417.6 13490.9 13515.5 5469.2 5507.8 5521.1 5521.5 5577.8 796.8 824.3 876.3 877.4 880.5 25953.5 25964.2 25971.6 26017.1 26266.7 886.2 905.6 916.8 930.1 1006.0 13846.2 13969.2 15134.8 15906.7 16538.3 317144.0 323646.0 327951.0 327958.0 330326.0 47522.5 48018.0 48181.8 48297.3 48588.5 1155.1 1224.1 1233.8 1238.8 1245.7 27332.3 27388.2 27447.6 27769.7 27926.3 38698.8 39539.2 39735.4 39850.4 39892.0 248661.0 248864.0 249057.0 250493.0 251116.0 29055.0 29624.1 39067.8 39433.2 39587.8 34680.8 35280.0 35322.5 35422.8 35934.1 32288.7 32657.8 33776.0 33794.3 34304.5 32999.5 33085.0 33550.2 37675.0 39369.6 32241.4 32609.8 33025.5 33340.7 33423.7 28494.3 30101.4 30724.8 30764.1 30801.9 23967.3 23972.2 24006.3 24035.0 24334.4 12:03:13 INFO - 2015-12-11 12:03:13,862 DEBUG : BROWSER_OUTPUT: 12:03:13 INFO - 2015-12-11 12:03:13,862 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25957.34 Median:4271.43 stddev:79045.47 (1850.6%) stddev-sans-first:79243.80 12:03:13 INFO - 2015-12-11 12:03:13,862 DEBUG : BROWSER_OUTPUT: Values: 334.4 336.9 339.0 341.2 342.0 12767.1 15297.1 15438.7 16387.5 16939.8 9536.8 9792.6 9868.9 10590.6 10749.7 4507.2 4627.0 4632.6 4635.4 4642.2 5015.0 5035.7 5042.3 5043.7 5050.1 4946.9 5001.9 5009.4 5114.8 5115.7 4841.3 5047.1 5082.9 5087.3 5120.3 4859.4 4879.6 4885.2 4886.6 4895.3 11777.5 14169.1 16363.3 18971.4 19001.2 1779.6 1845.5 1867.1 1872.7 1933.2 9044.4 9294.5 10233.4 12697.0 13297.3 1712.5 1774.5 1906.2 1948.0 2038.1 46341.5 46508.8 46642.8 47291.3 48589.0 9737.0 9748.5 9753.9 9753.9 9776.3 11962.5 12011.9 12037.5 12052.6 12114.3 6584.3 6683.9 6896.8 6945.4 6998.7 6501.0 6587.7 6627.7 6675.1 6693.6 4201.6 4230.9 4265.0 4277.9 4280.2 1641.8 1698.4 1779.1 1786.5 1787.3 364.8 367.9 377.1 377.7 797.7 9773.2 10001.5 15476.7 16732.7 16841.3 811.3 820.3 831.2 881.7 928.7 9047.7 9107.7 9255.5 9314.1 9395.6 480238.0 482693.0 483749.0 485744.0 486899.0 69953.7 73066.0 74619.6 75284.0 77636.2 1005.3 1027.5 1032.0 1034.6 1035.5 14133.8 14139.4 14159.8 14163.2 14216.9 33284.5 33703.2 34000.7 34215.5 35248.6 42862.6 43544.6 45338.3 47806.5 48580.0 8867.7 8969.8 8974.1 9037.5 9315.3 16481.7 16764.6 16994.9 17088.8 17178.6 12933.8 13081.7 13165.1 13567.3 13686.9 12447.8 12594.1 12946.7 12991.3 13519.5 13297.3 13565.7 13752.9 13805.5 13939.8 8741.5 8774.0 9008.9 9077.4 9077.4 12948.7 13087.5 13128.4 13151.7 13379.2 12:03:13 INFO - 2015-12-11 12:03:13,863 DEBUG : BROWSER_OUTPUT: 12:03:13 INFO - 2015-12-11 12:03:13,863 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4818.28 Median:5983.39 stddev:2503.14 (41.8%) stddev-sans-first:2497.02 12:03:13 INFO - 2015-12-11 12:03:13,863 DEBUG : BROWSER_OUTPUT: Values: 1406.1 1469.9 1569.3 1586.1 1721.9 5966.6 6078.9 6986.6 7054.9 7121.1 6757.0 6968.8 7025.5 7027.2 7027.8 1992.6 2011.2 2021.7 2021.8 2022.4 2068.7 2069.8 2071.7 2134.3 2147.7 2047.3 2064.6 2071.7 2097.4 2103.2 2035.3 2051.5 2067.6 2068.0 2068.0 2026.6 2030.7 2075.8 2079.6 2083.6 6740.0 6779.8 6840.4 6840.8 6862.5 4004.7 4022.4 4077.3 4083.6 4091.0 2673.3 2673.6 2700.8 2745.5 2747.2 847.5 863.0 867.0 879.9 891.6 9054.9 9059.5 9093.4 9098.4 9127.2 3797.7 3833.5 3884.0 3891.8 3893.9 7866.1 7870.2 7872.8 7886.5 7914.7 4124.3 4134.4 4139.2 4155.7 4158.7 3202.6 3273.3 3775.2 3777.4 3785.0 3415.1 3427.0 3427.1 3458.0 3470.1 1057.1 1060.5 1066.8 1074.9 1096.4 752.5 874.9 996.9 1011.2 1018.3 6650.6 6675.8 6676.9 6678.8 6713.2 411.1 417.0 419.2 420.9 422.3 5075.2 5077.2 5128.3 5130.4 5150.0 8252.2 8271.1 8390.6 8436.1 8489.8 8363.3 8366.6 8392.7 8402.5 8404.3 6477.5 6536.9 6606.8 6612.9 6628.2 6109.7 6111.7 6147.2 6151.7 6154.6 7347.0 7420.0 7585.2 7663.9 7760.4 7660.4 7734.8 7766.5 7830.8 7850.3 5212.9 5299.1 5686.4 6095.1 6250.9 6420.3 6435.6 6459.4 6474.6 6498.4 6000.1 6151.6 6178.8 6247.9 6291.1 6118.2 6200.8 6205.7 6276.4 6290.2 6216.4 6278.7 6293.4 6306.2 6326.3 5728.1 5805.3 5815.9 5822.8 5847.5 5876.9 5927.7 5950.9 5957.5 5960.9 12:03:13 INFO - 2015-12-11 12:03:13,863 DEBUG : BROWSER_OUTPUT: 12:03:13 INFO - 2015-12-11 12:03:13,863 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4866.77 Median:5602.16 stddev:1456.74 (26.0%) stddev-sans-first:1420.02 12:03:13 INFO - 2015-12-11 12:03:13,864 DEBUG : BROWSER_OUTPUT: Values: 305.1 309.7 311.9 312.6 315.8 5547.0 5570.2 5585.6 5628.9 5771.4 5581.0 5618.7 5633.1 5641.5 5651.7 4169.1 4315.7 4320.2 4322.2 4329.6 4293.2 4297.3 4307.7 4309.2 4309.9 4247.8 4251.5 4252.3 4261.0 4265.3 4252.8 4258.1 4265.5 4269.6 4279.1 3613.6 3689.0 3694.3 3702.6 3706.4 5201.2 5313.5 5332.2 5337.1 5344.3 4874.2 4875.7 4882.2 4885.3 4889.2 5883.9 5897.1 5907.2 5916.8 5932.5 3876.3 3964.2 3995.4 4013.3 4016.7 6163.7 6220.0 6228.2 6230.6 6235.1 4115.4 4131.7 4136.9 4138.1 4138.6 4188.9 4192.2 4198.2 4209.8 4215.3 4754.0 4823.2 4830.1 4840.2 4848.8 5863.0 5865.0 5869.5 5884.5 5895.5 1466.3 1469.7 1482.9 1487.1 1488.4 984.8 987.5 992.7 999.3 1004.5 5098.5 5120.8 5122.4 5126.4 5130.9 6096.2 6109.6 6111.2 6113.7 6136.0 5105.6 5109.9 5112.0 5124.9 5128.5 3214.6 3295.2 3306.6 3307.0 3326.2 5576.5 5705.2 5743.4 5823.2 5829.3 6228.6 6356.5 6373.5 6378.0 6379.0 5779.7 5780.5 5783.6 5784.1 5790.1 5904.8 6121.1 6122.0 6136.3 6149.5 5971.2 6028.8 6035.7 6037.5 6043.5 5774.5 5790.1 5798.3 5806.6 5806.7 4103.5 4156.8 4159.4 4160.1 4183.8 6035.4 6104.5 6161.3 6171.0 6174.9 5908.3 5920.6 5921.6 5925.1 5936.4 5902.4 5927.9 5933.7 5945.2 5955.6 5649.7 5741.6 5765.7 5773.6 5813.1 5951.0 5963.5 5974.3 5978.6 5987.0 5769.1 5807.7 5808.2 5812.1 5816.8 12:03:13 INFO - 2015-12-11 12:03:13,864 DEBUG : BROWSER_OUTPUT: 12:03:13 INFO - 2015-12-11 12:03:13,864 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12244.70 Median:475.35 stddev:14312.39 (3010.9%) stddev-sans-first:14326.54 12:03:13 INFO - 2015-12-11 12:03:13,864 DEBUG : BROWSER_OUTPUT: Values: 755.5 769.9 773.5 788.0 808.2 10774.6 11003.8 11025.6 11026.8 11030.3 11448.7 11510.2 11553.8 11570.6 11582.9 793.8 809.6 812.3 813.9 813.9 801.1 814.4 815.8 815.8 816.6 840.1 845.8 850.8 852.1 853.7 842.4 843.6 846.8 847.2 847.3 619.9 621.8 622.4 624.3 628.3 10452.9 10496.6 10559.3 10612.2 10621.9 9264.7 9338.0 9492.8 9730.8 9784.6 8633.4 8659.9 8754.1 8770.1 8825.0 3201.7 3221.7 3230.2 3232.3 3298.4 40720.4 41446.4 43172.6 43173.4 43209.4 8082.8 8261.5 8280.4 9164.5 9396.0 15224.3 15381.6 15398.7 15543.3 15546.3 6268.9 6335.5 6382.8 6401.3 6409.4 3600.9 3613.6 3639.0 3697.4 3753.3 2517.0 2531.3 2534.5 2539.0 2542.4 462.9 469.6 474.2 475.2 475.5 434.0 471.7 511.8 528.4 578.7 6873.9 6965.8 7090.0 7473.0 7557.8 524.1 525.8 536.6 538.8 553.1 3260.5 3505.8 3517.9 3524.3 3551.3 50641.5 51732.5 55307.4 55369.7 55537.0 44296.0 44907.1 44911.0 45517.8 45965.0 36540.0 38579.6 39035.2 39488.0 39914.6 7676.7 7821.4 8460.6 8519.6 8591.4 32741.0 33040.8 33127.3 33522.7 33654.7 36385.0 40495.2 41246.0 41568.8 41755.8 9141.1 9203.2 9294.2 9474.8 9611.3 11088.9 11404.3 11445.9 11485.9 11903.8 10269.6 10681.5 10692.6 10806.1 11116.0 10306.3 10332.9 10795.4 11104.8 11106.3 10224.2 10369.9 10635.3 10947.1 10999.7 9033.5 9209.4 9249.8 9387.0 9430.6 8461.6 9105.7 9109.9 9121.1 9201.4 12:03:13 INFO - 2015-12-11 12:03:13,865 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:03:13 INFO - 2015-12-11 12:03:13,865 DEBUG : BROWSER_OUTPUT: 12:03:14 INFO - 2015-12-11 12:03:14,638 INFO : Browser exited with error code: 0 12:03:14 INFO - 2015-12-11 12:03:14,657 INFO : Completed test dromaeo_css (00:18:35) 12:03:14 INFO - 2015-12-11 12:03:14,657 INFO : Starting test kraken 12:03:14 INFO - 2015-12-11 12:03:14,657 DEBUG : operating with platform_type : linux_ 12:03:14 INFO - 2015-12-11 12:03:14,657 INFO : Initialising browser for kraken test... 12:03:14 INFO - 2015-12-11 12:03:14,663 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ7z8a8/profile http://localhost:55968/getInfo.html 12:03:19 INFO - 2015-12-11 12:03:19,530 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:03:19 INFO - 2015-12-11 12:03:19,530 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:03:19 INFO - 2015-12-11 12:03:19,530 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:03:19 INFO - 2015-12-11 12:03:19,530 DEBUG : BROWSER_OUTPUT: __metrics 12:03:19 INFO - 2015-12-11 12:03:19,654 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] 12:03:20 INFO - 2015-12-11 12:03:20,598 INFO : Browser initialized. 12:03:20 INFO - 2015-12-11 12:03:20,599 INFO : Running cycle 1/1 for kraken test... 12:03:20 INFO - 2015-12-11 12:03:20,599 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ7z8a8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:03:32 INFO - 2015-12-11 12:03:32,673 DEBUG : BROWSER_OUTPUT: RSS: Main: 143360000 12:03:32 INFO - 2015-12-11 12:03:32,673 DEBUG : BROWSER_OUTPUT: 12:03:35 INFO - 2015-12-11 12:03:35,296 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55968/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55968/tests/kraken/driver.html?testName=audio-beat-detection) 12:03:35 INFO - 2015-12-11 12:03:35,917 DEBUG : BROWSER_OUTPUT: RSS: Main: 142204928 12:03:35 INFO - 2015-12-11 12:03:35,917 DEBUG : BROWSER_OUTPUT: 12:03:38 INFO - 2015-12-11 12:03:38,663 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55968/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55968/tests/kraken/driver.html?testName=audio-dft) 12:03:39 INFO - 2015-12-11 12:03:39,268 DEBUG : BROWSER_OUTPUT: RSS: Main: 143077376 12:03:39 INFO - 2015-12-11 12:03:39,268 DEBUG : BROWSER_OUTPUT: 12:03:42 INFO - 2015-12-11 12:03:42,187 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55968/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55968/tests/kraken/driver.html?testName=audio-fft) 12:03:42 INFO - 2015-12-11 12:03:42,773 DEBUG : BROWSER_OUTPUT: RSS: Main: 138461184 12:03:42 INFO - 2015-12-11 12:03:42,773 DEBUG : BROWSER_OUTPUT: 12:03:44 INFO - 2015-12-11 12:03:44,886 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55968/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55968/tests/kraken/driver.html?testName=audio-oscillator) 12:03:45 INFO - 2015-12-11 12:03:45,472 DEBUG : BROWSER_OUTPUT: RSS: Main: 138641408 12:03:45 INFO - 2015-12-11 12:03:45,473 DEBUG : BROWSER_OUTPUT: 12:03:47 INFO - 2015-12-11 12:03:47,719 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55968/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55968/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:03:48 INFO - 2015-12-11 12:03:48,300 DEBUG : BROWSER_OUTPUT: RSS: Main: 140005376 12:03:48 INFO - 2015-12-11 12:03:48,300 DEBUG : BROWSER_OUTPUT: 12:03:51 INFO - 2015-12-11 12:03:51,305 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55968/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55968/tests/kraken/driver.html?testName=imaging-darkroom) 12:03:51 INFO - 2015-12-11 12:03:51,898 DEBUG : BROWSER_OUTPUT: RSS: Main: 141230080 12:03:51 INFO - 2015-12-11 12:03:51,898 DEBUG : BROWSER_OUTPUT: 12:03:55 INFO - 2015-12-11 12:03:55,372 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55968/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55968/tests/kraken/driver.html?testName=imaging-desaturate) 12:03:55 INFO - 2015-12-11 12:03:55,965 DEBUG : BROWSER_OUTPUT: RSS: Main: 138731520 12:03:55 INFO - 2015-12-11 12:03:55,965 DEBUG : BROWSER_OUTPUT: 12:03:58 INFO - 2015-12-11 12:03:58,872 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55968/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55968/tests/kraken/driver.html?testName=json-parse-financial) 12:03:59 INFO - 2015-12-11 12:03:59,473 DEBUG : BROWSER_OUTPUT: RSS: Main: 139481088 12:03:59 INFO - 2015-12-11 12:03:59,473 DEBUG : BROWSER_OUTPUT: 12:04:01 INFO - 2015-12-11 12:04:01,255 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55968/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55968/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:04:01 INFO - 2015-12-11 12:04:01,837 DEBUG : BROWSER_OUTPUT: RSS: Main: 141139968 12:04:01 INFO - 2015-12-11 12:04:01,837 DEBUG : BROWSER_OUTPUT: 12:04:03 INFO - 2015-12-11 12:04:03,749 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55968/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55968/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:04:04 INFO - 2015-12-11 12:04:04,363 DEBUG : BROWSER_OUTPUT: RSS: Main: 140054528 12:04:04 INFO - 2015-12-11 12:04:04,363 DEBUG : BROWSER_OUTPUT: 12:04:06 INFO - 2015-12-11 12:04:06,539 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55968/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55968/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:04:07 INFO - 2015-12-11 12:04:07,140 DEBUG : BROWSER_OUTPUT: RSS: Main: 139337728 12:04:07 INFO - 2015-12-11 12:04:07,140 DEBUG : BROWSER_OUTPUT: 12:04:09 INFO - 2015-12-11 12:04:09,680 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55968/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55968/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:04:10 INFO - 2015-12-11 12:04:10,285 DEBUG : BROWSER_OUTPUT: RSS: Main: 140898304 12:04:10 INFO - 2015-12-11 12:04:10,286 DEBUG : BROWSER_OUTPUT: 12:04:12 INFO - 2015-12-11 12:04:12,933 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55968/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55968/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:04:13 INFO - 2015-12-11 12:04:13,536 DEBUG : BROWSER_OUTPUT: RSS: Main: 140038144 12:04:13 INFO - 2015-12-11 12:04:13,536 DEBUG : BROWSER_OUTPUT: 12:04:15 INFO - 2015-12-11 12:04:15,290 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55968/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55968/tests/kraken/driver.html?testName=ai-astar) 12:04:15 INFO - 2015-12-11 12:04:15,540 DEBUG : BROWSER_OUTPUT: RSS: Main: 141266944 12:04:15 INFO - 2015-12-11 12:04:15,540 DEBUG : BROWSER_OUTPUT: 12:04:15 INFO - 2015-12-11 12:04:15,544 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:04:15 INFO - 2015-12-11 12:04:15,544 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:04:15 INFO - 2015-12-11 12:04:15,544 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:04:15 INFO - 2015-12-11 12:04:15,544 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:04:15 INFO - 2015-12-11 12:04:15,544 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;108;115;112;112;123;112;112;115;113 12:04:15 INFO - 2015-12-11 12:04:15,544 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;132;151;169;131;159;154;146;169;139 12:04:15 INFO - 2015-12-11 12:04:15,544 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;163;165;164;165;172;165;167;166;163 12:04:15 INFO - 2015-12-11 12:04:15,545 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;74;75;144;75;80;72;74;157 12:04:15 INFO - 2015-12-11 12:04:15,545 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;95;131;94;95;94;133;95;95;133 12:04:15 INFO - 2015-12-11 12:04:15,545 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;111;109;111;114;110;110;111;110;110 12:04:15 INFO - 2015-12-11 12:04:15,545 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;149;147;150;148;148;148;148;147;149 12:04:15 INFO - 2015-12-11 12:04:15,545 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;98;98;96;95;95;96;97;97;96 12:04:15 INFO - 2015-12-11 12:04:15,545 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;75;74;73;72;73;76;74;72;73;73 12:04:15 INFO - 2015-12-11 12:04:15,545 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;69;69;68;68;68;69;68;68 12:04:15 INFO - 2015-12-11 12:04:15,546 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;83;84;85;86;84;85;83;102;95 12:04:15 INFO - 2015-12-11 12:04:15,546 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;127;120;128;131;123;126;132;122;127 12:04:15 INFO - 2015-12-11 12:04:15,546 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;148;151;150;153;149;158;150;151;149;151 12:04:15 INFO - 2015-12-11 12:04:15,546 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;70;69;71;71;71;70;70;71;68 12:04:15 INFO - 2015-12-11 12:04:15,546 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:04:15 INFO - 2015-12-11 12:04:15,546 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:04:15 INFO - 2015-12-11 12:04:15,546 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,793 12:04:15 INFO - 2015-12-11 12:04:15,547 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:04:15 INFO - 2015-12-11 12:04:15,547 DEBUG : BROWSER_OUTPUT: __startTimestamp1449864255542__endTimestamp 12:04:15 INFO - 2015-12-11 12:04:15,547 DEBUG : BROWSER_OUTPUT: 12:04:15 INFO - 2015-12-11 12:04:15,554 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:04:15 INFO - 2015-12-11 12:04:15,554 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:04:15 INFO - 2015-12-11 12:04:15,555 DEBUG : BROWSER_OUTPUT: 12:04:15 INFO - 2015-12-11 12:04:15,555 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.50 Median:113.00 stddev:3.87 (3.4%) stddev-sans-first:4.10 12:04:15 INFO - 2015-12-11 12:04:15,555 DEBUG : BROWSER_OUTPUT: Values: 113.0 108.0 115.0 112.0 112.0 123.0 112.0 112.0 115.0 113.0 12:04:15 INFO - 2015-12-11 12:04:15,555 DEBUG : BROWSER_OUTPUT: 12:04:15 INFO - 2015-12-11 12:04:15,555 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.40 Median:154.00 stddev:13.57 (8.8%) stddev-sans-first:14.33 12:04:15 INFO - 2015-12-11 12:04:15,555 DEBUG : BROWSER_OUTPUT: Values: 154.0 132.0 151.0 169.0 131.0 159.0 154.0 146.0 169.0 139.0 12:04:15 INFO - 2015-12-11 12:04:15,555 DEBUG : BROWSER_OUTPUT: 12:04:15 INFO - 2015-12-11 12:04:15,555 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:165.40 Median:165.00 stddev:2.63 (1.6%) stddev-sans-first:2.74 12:04:15 INFO - 2015-12-11 12:04:15,556 DEBUG : BROWSER_OUTPUT: Values: 164.0 163.0 165.0 164.0 165.0 172.0 165.0 167.0 166.0 163.0 12:04:15 INFO - 2015-12-11 12:04:15,556 DEBUG : BROWSER_OUTPUT: 12:04:15 INFO - 2015-12-11 12:04:15,556 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:89.50 Median:74.00 stddev:32.38 (43.8%) stddev-sans-first:33.72 12:04:15 INFO - 2015-12-11 12:04:15,556 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 74.0 75.0 144.0 75.0 80.0 72.0 74.0 157.0 12:04:15 INFO - 2015-12-11 12:04:15,556 DEBUG : BROWSER_OUTPUT: 12:04:15 INFO - 2015-12-11 12:04:15,556 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.90 Median:94.50 stddev:18.25 (19.3%) stddev-sans-first:18.85 12:04:15 INFO - 2015-12-11 12:04:15,556 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 131.0 94.0 95.0 94.0 133.0 95.0 95.0 133.0 12:04:15 INFO - 2015-12-11 12:04:15,556 DEBUG : BROWSER_OUTPUT: 12:04:15 INFO - 2015-12-11 12:04:15,556 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.60 Median:110.50 stddev:1.35 (1.2%) stddev-sans-first:1.41 12:04:15 INFO - 2015-12-11 12:04:15,556 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 109.0 111.0 114.0 110.0 110.0 111.0 110.0 110.0 12:04:15 INFO - 2015-12-11 12:04:15,556 DEBUG : BROWSER_OUTPUT: 12:04:15 INFO - 2015-12-11 12:04:15,557 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 12:04:15 INFO - 2015-12-11 12:04:15,557 DEBUG : BROWSER_OUTPUT: Values: 148.0 149.0 147.0 150.0 148.0 148.0 148.0 148.0 147.0 149.0 12:04:15 INFO - 2015-12-11 12:04:15,557 DEBUG : BROWSER_OUTPUT: 12:04:15 INFO - 2015-12-11 12:04:15,557 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:1.07 (1.1%) stddev-sans-first:1.13 12:04:15 INFO - 2015-12-11 12:04:15,557 DEBUG : BROWSER_OUTPUT: Values: 96.0 98.0 98.0 96.0 95.0 95.0 96.0 97.0 97.0 96.0 12:04:15 INFO - 2015-12-11 12:04:15,557 DEBUG : BROWSER_OUTPUT: 12:04:15 INFO - 2015-12-11 12:04:15,557 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.50 Median:73.50 stddev:1.27 (1.7%) stddev-sans-first:1.22 12:04:15 INFO - 2015-12-11 12:04:15,557 DEBUG : BROWSER_OUTPUT: Values: 75.0 74.0 73.0 72.0 73.0 76.0 74.0 72.0 73.0 73.0 12:04:15 INFO - 2015-12-11 12:04:15,557 DEBUG : BROWSER_OUTPUT: 12:04:15 INFO - 2015-12-11 12:04:15,557 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.50 12:04:15 INFO - 2015-12-11 12:04:15,557 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 69.0 69.0 68.0 68.0 68.0 69.0 68.0 68.0 12:04:15 INFO - 2015-12-11 12:04:15,557 DEBUG : BROWSER_OUTPUT: 12:04:15 INFO - 2015-12-11 12:04:15,558 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:85.00 stddev:6.25 (7.4%) stddev-sans-first:6.58 12:04:15 INFO - 2015-12-11 12:04:15,558 DEBUG : BROWSER_OUTPUT: Values: 85.0 83.0 84.0 85.0 86.0 84.0 85.0 83.0 102.0 95.0 12:04:15 INFO - 2015-12-11 12:04:15,558 DEBUG : BROWSER_OUTPUT: 12:04:15 INFO - 2015-12-11 12:04:15,558 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.90 Median:127.00 stddev:3.90 (3.1%) stddev-sans-first:3.99 12:04:15 INFO - 2015-12-11 12:04:15,558 DEBUG : BROWSER_OUTPUT: Values: 123.0 127.0 120.0 128.0 131.0 123.0 126.0 132.0 122.0 127.0 12:04:15 INFO - 2015-12-11 12:04:15,558 DEBUG : BROWSER_OUTPUT: 12:04:15 INFO - 2015-12-11 12:04:15,558 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.00 Median:151.00 stddev:2.83 (1.9%) stddev-sans-first:2.78 12:04:15 INFO - 2015-12-11 12:04:15,558 DEBUG : BROWSER_OUTPUT: Values: 148.0 151.0 150.0 153.0 149.0 158.0 150.0 151.0 149.0 151.0 12:04:15 INFO - 2015-12-11 12:04:15,558 DEBUG : BROWSER_OUTPUT: 12:04:15 INFO - 2015-12-11 12:04:15,558 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:71.00 stddev:1.03 (1.5%) stddev-sans-first:1.05 12:04:15 INFO - 2015-12-11 12:04:15,558 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 69.0 71.0 71.0 71.0 70.0 70.0 71.0 68.0 12:04:15 INFO - 2015-12-11 12:04:15,558 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:04:15 INFO - 2015-12-11 12:04:15,558 DEBUG : BROWSER_OUTPUT: 12:04:16 INFO - 2015-12-11 12:04:16,478 INFO : Browser exited with error code: 0 12:04:16 INFO - 2015-12-11 12:04:16,535 INFO : Completed test kraken (00:01:01) 12:04:16 INFO - 2015-12-11 12:04:16,535 INFO : Starting test v8_7 12:04:16 INFO - 2015-12-11 12:04:16,535 DEBUG : operating with platform_type : linux_ 12:04:16 INFO - 2015-12-11 12:04:16,535 INFO : Initialising browser for v8_7 test... 12:04:16 INFO - 2015-12-11 12:04:16,541 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaB_uGX/profile http://localhost:55968/getInfo.html 12:04:21 INFO - 2015-12-11 12:04:21,593 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:04:21 INFO - 2015-12-11 12:04:21,594 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:04:21 INFO - 2015-12-11 12:04:21,594 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:04:21 INFO - 2015-12-11 12:04:21,594 DEBUG : BROWSER_OUTPUT: __metrics 12:04:21 INFO - 2015-12-11 12:04:21,735 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] 12:04:22 INFO - 2015-12-11 12:04:22,686 INFO : Browser initialized. 12:04:22 INFO - 2015-12-11 12:04:22,686 INFO : Running cycle 1/1 for v8_7 test... 12:04:22 INFO - 2015-12-11 12:04:22,687 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaB_uGX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:04:34 INFO - 2015-12-11 12:04:34,705 DEBUG : BROWSER_OUTPUT: RSS: Main: 142622720 12:04:34 INFO - 2015-12-11 12:04:34,705 DEBUG : BROWSER_OUTPUT: 12:04:56 INFO - 2015-12-11 12:04:56,111 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55968/tests/v8_7/run.html (next: http://localhost:55968/tests/v8_7/run.html) 12:04:56 INFO - 2015-12-11 12:04:56,361 DEBUG : BROWSER_OUTPUT: RSS: Main: 137224192 12:04:56 INFO - 2015-12-11 12:04:56,362 DEBUG : BROWSER_OUTPUT: 12:04:56 INFO - 2015-12-11 12:04:56,363 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:04:56 INFO - 2015-12-11 12:04:56,363 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:04:56 INFO - 2015-12-11 12:04:56,363 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:04:56 INFO - 2015-12-11 12:04:56,363 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:04:56 INFO - 2015-12-11 12:04:56,364 DEBUG : BROWSER_OUTPUT: |0;Richards;165.80998176090202 12:04:56 INFO - 2015-12-11 12:04:56,364 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.90174630589138 12:04:56 INFO - 2015-12-11 12:04:56,364 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.0850651149903 12:04:56 INFO - 2015-12-11 12:04:56,364 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5229.166666666667 12:04:56 INFO - 2015-12-11 12:04:56,364 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1085.7763300760043 12:04:56 INFO - 2015-12-11 12:04:56,364 DEBUG : BROWSER_OUTPUT: |5;Earley;702.7406886858749 12:04:56 INFO - 2015-12-11 12:04:56,364 DEBUG : BROWSER_OUTPUT: |6;Boyer;12292.682926829268 12:04:56 INFO - 2015-12-11 12:04:56,364 DEBUG : BROWSER_OUTPUT: |7;RegExp;26153.846153846152 12:04:56 INFO - 2015-12-11 12:04:56,365 DEBUG : BROWSER_OUTPUT: |8;Splay;595.2380952380952 12:04:56 INFO - 2015-12-11 12:04:56,365 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 12:04:56 INFO - 2015-12-11 12:04:56,365 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:04:56 INFO - 2015-12-11 12:04:56,365 DEBUG : BROWSER_OUTPUT: __startTimestamp1449864296362__endTimestamp 12:04:56 INFO - 2015-12-11 12:04:56,365 DEBUG : BROWSER_OUTPUT: 12:04:56 INFO - 2015-12-11 12:04:56,366 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:04:56 INFO - 2015-12-11 12:04:56,367 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:04:56 INFO - 2015-12-11 12:04:56,367 DEBUG : BROWSER_OUTPUT: 12:04:56 INFO - 2015-12-11 12:04:56,367 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.81 Median:165.81 stddev:0.00 (0.0%) 12:04:56 INFO - 2015-12-11 12:04:56,367 DEBUG : BROWSER_OUTPUT: Values: 165.8 12:04:56 INFO - 2015-12-11 12:04:56,368 DEBUG : BROWSER_OUTPUT: 12:04:56 INFO - 2015-12-11 12:04:56,368 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.90 Median:191.90 stddev:0.00 (0.0%) 12:04:56 INFO - 2015-12-11 12:04:56,368 DEBUG : BROWSER_OUTPUT: Values: 191.9 12:04:56 INFO - 2015-12-11 12:04:56,368 DEBUG : BROWSER_OUTPUT: 12:04:56 INFO - 2015-12-11 12:04:56,368 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.09 Median:277.09 stddev:0.00 (0.0%) 12:04:56 INFO - 2015-12-11 12:04:56,368 DEBUG : BROWSER_OUTPUT: Values: 277.1 12:04:56 INFO - 2015-12-11 12:04:56,368 DEBUG : BROWSER_OUTPUT: 12:04:56 INFO - 2015-12-11 12:04:56,369 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5229.17 Median:5229.17 stddev:0.00 (0.0%) 12:04:56 INFO - 2015-12-11 12:04:56,369 DEBUG : BROWSER_OUTPUT: Values: 5229.2 12:04:56 INFO - 2015-12-11 12:04:56,369 DEBUG : BROWSER_OUTPUT: 12:04:56 INFO - 2015-12-11 12:04:56,369 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1085.78 Median:1085.78 stddev:0.00 (0.0%) 12:04:56 INFO - 2015-12-11 12:04:56,369 DEBUG : BROWSER_OUTPUT: Values: 1085.8 12:04:56 INFO - 2015-12-11 12:04:56,369 DEBUG : BROWSER_OUTPUT: 12:04:56 INFO - 2015-12-11 12:04:56,369 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:702.74 Median:702.74 stddev:0.00 (0.0%) 12:04:56 INFO - 2015-12-11 12:04:56,370 DEBUG : BROWSER_OUTPUT: Values: 702.7 12:04:56 INFO - 2015-12-11 12:04:56,370 DEBUG : BROWSER_OUTPUT: 12:04:56 INFO - 2015-12-11 12:04:56,370 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12292.68 Median:12292.68 stddev:0.00 (0.0%) 12:04:56 INFO - 2015-12-11 12:04:56,370 DEBUG : BROWSER_OUTPUT: Values: 12292.7 12:04:56 INFO - 2015-12-11 12:04:56,370 DEBUG : BROWSER_OUTPUT: 12:04:56 INFO - 2015-12-11 12:04:56,370 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26153.85 Median:26153.85 stddev:0.00 (0.0%) 12:04:56 INFO - 2015-12-11 12:04:56,370 DEBUG : BROWSER_OUTPUT: Values: 26153.8 12:04:56 INFO - 2015-12-11 12:04:56,370 DEBUG : BROWSER_OUTPUT: 12:04:56 INFO - 2015-12-11 12:04:56,371 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:595.24 Median:595.24 stddev:0.00 (0.0%) 12:04:56 INFO - 2015-12-11 12:04:56,371 DEBUG : BROWSER_OUTPUT: Values: 595.2 12:04:56 INFO - 2015-12-11 12:04:56,371 DEBUG : BROWSER_OUTPUT: 12:04:56 INFO - 2015-12-11 12:04:56,371 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 12:04:56 INFO - 2015-12-11 12:04:56,371 DEBUG : BROWSER_OUTPUT: Values: 4840.6 12:04:56 INFO - 2015-12-11 12:04:56,371 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:04:56 INFO - 2015-12-11 12:04:56,371 DEBUG : BROWSER_OUTPUT: 12:04:57 INFO - 2015-12-11 12:04:57,294 INFO : Browser exited with error code: 0 12:04:57 INFO - 2015-12-11 12:04:57,311 INFO : Completed test v8_7 (00:00:40) 12:04:57 INFO - 2015-12-11 12:04:57,393 INFO : Completed test suite (00:20:18) 12:04:57 INFO - 2015-12-11 12:04:57,393 DEBUG : Working with test: dromaeo_css 12:04:57 INFO - 2015-12-11 12:04:57,394 DEBUG : Generating results file: dromaeo_css 12:04:57 INFO - 2015-12-11 12:04:57,395 DEBUG : Working with test: kraken 12:04:57 INFO - 2015-12-11 12:04:57,395 DEBUG : Generating results file: kraken 12:04:57 INFO - 2015-12-11 12:04:57,395 INFO : javascript benchmark 12:04:57 INFO - 2015-12-11 12:04:57,395 DEBUG : Working with test: v8_7 12:04:57 INFO - 2015-12-11 12:04:57,395 DEBUG : Generating results file: v8_7 12:04:57 INFO - 2015-12-11 12:04:57,396 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:04:57 INFO - 2015-12-11 12:04:57,460 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 12:04:57 INFO - 2015-12-11 12:04:57,460 DEBUG : process_Request line: dromaeo_css 6228.19 graph.html#tests=[[72,132,43]] 12:04:57 INFO - 2015-12-11 12:04:57,460 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:04:57 INFO - 2015-12-11 12:04:57,488 DEBUG : process_Request line: kraken 1555.90 graph.html#tests=[[232,132,43]] 12:04:57 INFO - 2015-12-11 12:04:57,488 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:04:57 INFO - 2015-12-11 12:04:57,516 DEBUG : process_Request line: v8_7 21291.23 graph.html#tests=[[230,132,43]] 12:04:57 INFO - 2015-12-11 12:04:57,518 INFO : javascript benchmark 12:04:57 INFO - 2015-12-11 12:04:57,521 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2669.919902402928, 2733.5079685656574, 2764.447110577885, 2777.2501424615352, 2781.304673831542, 4401.60385565299, 4673.158831410349, 4750.16872047392, 4782.7847746851385, 4806.615470762339, 4663.183942810003, 4683.414573178353, 4692.6949748266425, 4707.858764237069, 4818.301346304784, 4341.283688191453, 4423.159599676067, 4456.353828694837, 4481.529439408864, 4519.299508576176, 4320.935185972213, 4368.170047690945, 4373.825046998117, 4408.228560002003, 4475.485319188286, 4181.121964387482, 4293.22721910056, 4314.525402205755, 4405.80173892174, 4451.354553589744, 4429.601335879786, 4430.911381772346, 4454.175977444183, 4464.441944756905, 4468.262736648449, 4408.184485870124, 4420.734755914656, 4433.800478978454, 4444.555544445562, 4476.955230447719, 4361.193179261847, 4454.688171827974, 4471.5081341052455, 4505.954940450619, 4715.245560710304, 4987.750612469362, 5041.798328066873, 5080.974595127001, 5107.565856902168, 5171.017506673757, 5126.538611524943, 5132.0505706444055, 5152.175651895679, 5165.66423182492, 5194.71429071401, 4579.290210017452, 4686.179918514246, 4747.216709242936, 4761.666683332168, 4765.142274390573, 5206.479352064764, 5252.369715634072, 5277.683338999673, 5279.762410691528, 5318.547923426552, 4980.9252861207115, 5049.343585333883, 5049.798008079709, 5054.873628159252, 5095.770690318945, 4921.680090794159, 4995.125852975715, 5033.6224783141415, 5112.565431938327, 5150.48495150482, 5130.51260130287, 5146.639735218499, 5150.1502252127975, 5161.045206636784, 5171.379434467888, 5113.71874546896, 5115.8721031973755, 5126.53861152498, 5136.640435169577, 5191.013707395583, 4065.97967010169, 4161.126163505637, 4187.225363307737, 4293.5706429356815, 4332.891677708019, 3744.2137151198554, 3766.8681596144, 3768.2275133597545, 3799.506064211635, 3806.3719486284454, 4396.758178300161, 4417.668674849399, 4419.779011049499, 4421.049474362963, 4454.910901782011, 4868.196747536687, 4984.700917944862, 5109.693418394834, 5209.583233341324, 5244.527992480619, 4400.823967041282, 4411.09572537629, 4412.624926881187, 4416.889577760518, 4464.2633965396, 4334.393184954109, 4543.795529201194, 4556.11155824611, 4571.81712731487, 4618.214903466419, 4735.810567577259, 4758.5241475852135, 4769.666123371469, 4781.043791241696, 4783.976080119577, 5122.948770512397, 5175.197844334134, 5190.299309593308, 5192.350956130484, 5204.9739751301, 4845.830395936126, 4865.367502224688, 4868.95131048685, 4869.561739443467, 4941.827036053721, 4804.95195048045, 4862.95137048625, 4911.557959783494, 5103.234514822806, 5116.462771408948, 5169.560587349967, 5191.792328306826, 5211.426743058337, 5217.139172036572, 5223.52988231061, 5026.0, 5027.170516864822, 5027.899442011212, 5034.0686972910125, 5074.67014644047, 4761.9047619048115, 4850.46644869057, 4895.681780684244, 4991.276264941635, 5009.849704508871, 4831.685940413862, 4841.2496063110275, 4849.393825771778, 4861.854144375674, 4944.826931057396, 4978.601711863114, 4985.6260780442335, 4999.450060493416, 5001.599872010158, 5002.874928126826, 4708.81164753406, 4767.118083154627, 4792.113459010095, 4914.238293064581, 4931.679440836334], "unit": "ms", "name": "dojo.html", "value": 4676.0932644498835}, {"lowerIsBetter": false, "replicates": [554.8834744703612, 579.6695883346491, 581.6568224747398, 585.5579037826443, 585.6749504025264, 34734.65265347346, 35209.2958140837, 35263.0, 35274.29451410974, 35328.64671353286, 39302.80348598253, 39727.60272397275, 39733.20533589327, 39904.800475997654, 39978.40032399509, 7925.326347260476, 8100.392470564701, 8105.918940810576, 8180.6318715657935, 8182.18178182183, 7925.801854953615, 7927.643256053462, 8007.719729809458, 8008.27925486706, 8021.759347219593, 7996.560189189592, 8061.556614386206, 8062.0, 8081.4747041442415, 8087.514749115043, 7992.880106798402, 8056.476329038623, 8065.233802788725, 8090.878636820453, 8095.311898488636, 7835.451518393715, 8045.758627241192, 8050.838983220303, 8052.677892884278, 8066.314363279128, 35574.82212588946, 35928.820355898315, 35946.0, 35981.46027809585, 36173.81913090418, 2859.642544681915, 2891.5951766752673, 2904.7095290470993, 2919.8832046718107, 2955.7044295570486, 27581.448371032668, 27745.167644970683, 27881.442371152665, 27928.720712792816, 27979.86010069957, 3426.880059197916, 3493.371193185226, 3530.858765649371, 3567.4470457079196, 3582.6954708849516, 210824.0, 211204.0, 211256.0, 211311.0, 211990.94004530032, 38717.419238711445, 38804.6119538801, 38826.417603735965, 53098.69013098659, 53353.0, 35129.64870351264, 35319.64680353215, 35434.82282588622, 35463.11342216465, 35471.645283547354, 11019.559217631206, 11034.779304414027, 11052.336859788438, 11074.667759967213, 11075.889241107647, 9572.856407153899, 9620.037996200324, 9628.855567166498, 9632.373895696757, 9658.806823863484, 12905.483780648668, 13069.215847049207, 13417.597472075853, 13490.865091349157, 13515.52695655667, 5469.15228139631, 5507.779688812483, 5521.116621340566, 5521.503064724114, 5577.8047768327915, 796.8207153390441, 824.2952275804221, 876.3339861705023, 877.3989816975393, 880.506916126971, 25953.480930381666, 25964.22107336783, 25971.610425843628, 26017.089401870842, 26266.73733262681, 886.1802832380023, 905.6422713028317, 916.7852595311106, 930.0606387548625, 1005.994005994006, 13846.169229846242, 13969.161850288812, 15134.848651513565, 15906.68186636284, 16538.25577849, 317144.0, 323646.0, 327951.0, 327958.0, 330326.0, 47522.52477475181, 48018.0, 48181.759091204316, 48297.27554086621, 48588.5141148584, 1155.1278784517804, 1224.13086708438, 1233.8396008519014, 1238.8451443569554, 1245.7197130645532, 27332.316692082855, 27388.178354649393, 27447.588286176124, 27769.72230277752, 27926.3018424541, 38698.80650596729, 39539.209215816096, 39735.403968939914, 39850.40224396694, 39892.0, 248661.0, 248864.0, 249057.0, 250493.0, 251116.0, 29055.0, 29624.111276661733, 39067.804660976515, 39433.21133577255, 39587.80206098951, 34680.826595866856, 35280.0, 35322.47016294809, 35422.822885885405, 35934.10164745902, 32288.67711322857, 32657.836710816293, 33776.0, 33794.32411351809, 34304.485432719026, 32999.50500742443, 33085.007449776545, 33550.161245969044, 37675.0, 39369.60630393774, 32241.35517289688, 32609.836950815094, 33025.50461743124, 33340.666593334725, 33423.66576334303, 28494.287642809097, 30101.39797204, 30724.846375768873, 30764.116304456224, 30801.861721943744, 23967.28098157058, 23972.160974365812, 24006.27981160568, 24035.0, 24334.391640209138], "unit": "ms", "name": "ext.html", "value": 16273.8357622894}, {"lowerIsBetter": false, "replicates": [334.44816053511704, 336.89219449776067, 339.03713453791227, 341.16584949797743, 342.04739799657955, 12767.106302558814, 15297.082175069503, 15438.69122617547, 16387.508374748748, 16939.83060169398, 9536.76158096048, 9792.559334829932, 9868.901310986888, 10590.576376944913, 10749.677509674702, 4507.1887060329045, 4627.0, 4632.559906808865, 4635.351050852883, 4642.164410406125, 5014.974925125388, 5035.723035233061, 5042.294078828967, 5043.722595257259, 5050.090983622947, 4946.925796113062, 5001.949590585963, 5009.398872135331, 5114.769835357418, 5115.718635475047, 4841.273808928689, 5047.0915235257635, 5082.898342033157, 5087.338645976018, 5120.283160357553, 4859.441164266119, 4879.6096312295285, 4885.218365061609, 4886.560209581155, 4895.290182923456, 11777.470013849397, 14169.079009864428, 16363.263653135638, 18971.43085707431, 19001.239950401967, 1779.5551112221945, 1845.5386153461634, 1867.1037901807208, 1872.7378167056622, 1933.2170470959284, 9044.41211321262, 9294.488803115826, 10233.437160956144, 12697.0, 13297.268650224234, 1712.4520153550868, 1774.4676597020841, 1906.237504997998, 1947.9707804382945, 2038.062491254025, 46341.53658463406, 46508.767456162845, 46642.76678616619, 47291.29063064057, 48589.0, 9736.95131524338, 9748.512574371252, 9753.9024609753, 9753.9024609753, 9776.266779991529, 11962.521499139937, 12011.939940300243, 12037.458314375874, 12052.578159764542, 12114.273143611412, 6584.341565843473, 6683.933160668428, 6896.827579310558, 6945.40964018054, 6998.650067496605, 6501.0, 6587.703553340111, 6627.734890604418, 6675.098861653614, 6693.631850248185, 4201.579842015835, 4230.873073807791, 4265.0, 4277.850275240414, 4280.186764514732, 1641.7947756530434, 1698.422536337651, 1779.1104447776113, 1786.455131184975, 1787.3386846866483, 364.83035388544454, 367.90802299425144, 377.1325950314266, 377.7487970499587, 797.704849205786, 9773.169280611086, 10001.49992500372, 15476.690466190614, 16732.665346692997, 16841.32634694623, 811.3306522119275, 820.3478234803346, 831.2394159344133, 881.6781874615847, 928.6842473559022, 9047.68333108338, 9107.681231156877, 9255.537223138816, 9314.115159059878, 9395.62417503306, 480238.0, 482693.0, 483749.0, 485744.0, 486899.0, 69953.65023174851, 73066.0, 74619.62690186514, 75284.0, 77636.2236377629, 1005.3465247588979, 1027.5427434791595, 1032.0, 1034.6275340877428, 1035.4667346316653, 14133.787993179905, 14139.363728632443, 14159.787603185754, 14163.150210987375, 14216.928915355356, 33284.50073248952, 33703.15742106467, 34000.65999339975, 34215.486767699, 35248.647513524535, 42862.56719758593, 43544.56455435405, 45338.319925200485, 47806.5219347816, 48580.0, 8867.73396798097, 8969.820603588023, 8974.14745599167, 9037.50293733851, 9315.301352398461, 16481.67036659284, 16764.58088547796, 16994.895331803393, 17088.829111708725, 17178.570535736708, 12933.805992909925, 13081.738365232832, 13165.144265622705, 13567.253801041037, 13686.931565342109, 12447.813282800946, 12594.055445841415, 12946.676333091747, 12991.28547929873, 13519.459221631025, 13297.335133243105, 13565.660858478223, 13752.862471375558, 13805.516806912112, 13939.790903136258, 8741.475511469333, 8773.956130219309, 9008.864867026869, 9077.364584479023, 9077.409968352036, 12948.741025179632, 13087.541936032194, 13128.409221585243, 13151.73696526045, 13379.197248165141], "unit": "ms", "name": "jquery.html", "value": 7975.244176386632}, {"lowerIsBetter": false, "replicates": [1406.1071219775442, 1469.8750606198469, 1569.270289315468, 1586.095925322565, 1721.9397321093757, 5966.642001479914, 6078.908816367758, 6986.580805151694, 7054.871220604698, 7121.07426034616, 6757.0, 6968.756093536727, 7025.508214424993, 7027.156741191052, 7027.824304392393, 1992.561636439981, 2011.1553147677937, 2021.7068525063858, 2021.848361372903, 2022.3629556689668, 2068.731064961553, 2069.8344132469365, 2071.6685330347145, 2134.295682424804, 2147.742270927483, 2047.252752745252, 2064.6283668939586, 2071.6996035574834, 2097.423208617635, 2103.1587365054024, 2035.2571311471281, 2051.5178932950744, 2067.58648270345, 2067.9586408271903, 2068.0, 2026.6149431607948, 2030.715699802029, 2075.833933285349, 2079.646460101771, 2083.5728675621613, 6740.0, 6779.830504237384, 6840.384365407088, 6840.760573379957, 6862.4853136015, 4004.659603933669, 4022.3765316376007, 4077.3068578341754, 4083.571225021389, 4091.0386059276047, 2673.2514895829004, 2673.585594232897, 2700.7704345130687, 2745.4646343962936, 2747.230775382896, 847.4830353484369, 862.9913700862974, 866.9696560620348, 879.9428037177563, 891.6032365597312, 9054.909450905472, 9059.456432614064, 9093.408928419698, 9098.363114581982, 9127.17855393011, 3797.6771974381936, 3833.4824798651825, 3884.0484081400236, 3891.785951772623, 3893.922121557553, 7866.056073271244, 7870.173631768696, 7872.763817085496, 7886.526808391515, 7914.683412663544, 4124.340105583093, 4134.37984302357, 4139.234241665302, 4155.667546596325, 4158.708890377645, 3202.59967504062, 3273.3126043531124, 3775.1505911170316, 3777.3956167013694, 3784.962150378516, 3415.077928959167, 3427.0404286799735, 3427.108951672583, 3458.0490365149785, 3470.1151206442196, 1057.143713591993, 1060.5121644043672, 1066.7866426714534, 1074.9032587067202, 1096.353151640536, 752.5108679358461, 874.9343799215085, 996.8554559588964, 1011.2011510906301, 1018.3024628129607, 6650.600963942082, 6675.833104172338, 6676.899846502306, 6678.7662431815625, 6713.2279787824045, 411.13866449787645, 417.04704749646913, 419.1805021183579, 420.87584162672084, 422.34958164427053, 5075.1625981712605, 5077.213031980049, 5128.3076784633595, 5130.384353877558, 5150.021495915764, 8252.174782521699, 8271.131531189138, 8390.580470976427, 8436.114208008194, 8489.787755306043, 8363.330933525303, 8366.623501942306, 8392.706255281037, 8402.537860417735, 8404.285635721033, 6477.514186436036, 6536.869262614721, 6606.768763093365, 6612.86774264512, 6628.171478565179, 6109.694515274307, 6111.724972376165, 6147.200863887666, 6151.6924153793025, 6154.599951003171, 7346.963265183854, 7419.96290018568, 7585.16563178061, 7663.923360766321, 7760.417968652487, 7660.425468089804, 7734.845303093794, 7766.534007959541, 7830.843383132419, 7850.293473587176, 5212.895742085213, 5299.125644268653, 5686.402927692533, 6095.116208149882, 6250.937490625218, 6420.2616699078335, 6435.581687190318, 6459.418652321314, 6474.5791523550815, 6498.415142637185, 6000.129981152796, 6151.569390142647, 6178.845528861814, 6247.937520624918, 6291.056341548804, 6118.235220597426, 6200.844978875564, 6205.65868877198, 6276.403741644536, 6290.2451705793765, 6216.44052035319, 6278.6546739929745, 6293.433590976834, 6306.211723534559, 6326.335734747785, 5728.054870946247, 5805.274340707411, 5815.912761308499, 5822.7670893163795, 5847.473727364558, 5876.882462350814, 5927.703614819328, 5950.880982380415, 5957.463828255478, 5960.940390596212], "unit": "ms", "name": "mootools.html", "value": 3892.50376609202}, {"lowerIsBetter": false, "replicates": [305.07866243943295, 309.7104207565926, 311.9204602826282, 312.64670921858306, 315.84558438905793, 5547.0, 5570.220169176318, 5585.636933599313, 5628.915566266499, 5771.365149833515, 5580.972095139528, 5618.690971996539, 5633.0987042073275, 5641.52047075998, 5651.745671444784, 4169.103642716816, 4315.71947823392, 4320.179165958473, 4322.200392927302, 4329.631981281595, 4293.205756934962, 4297.312430011199, 4307.741535507864, 4309.224339618867, 4309.892252693677, 4247.8088486018205, 4251.4898212214575, 4252.340887162495, 4260.956065763892, 4265.31754919213, 4252.829886804524, 4258.084511829956, 4265.466816647919, 4269.615734583902, 4279.079997800488, 3613.6205698401814, 3688.967089215024, 3694.3350196964534, 3702.555693316819, 3706.4440333949856, 5201.193814958688, 5313.495217954288, 5332.200169974496, 5337.11937530307, 5344.278522399465, 4874.195757699975, 4875.658703890729, 4882.170031094723, 4885.340479035356, 4889.217725163957, 5883.911741323884, 5897.14491398749, 5907.232059832194, 5916.792912248051, 5932.466078052953, 3876.3022655921923, 3964.187341594995, 3995.4206640037323, 4013.257547353749, 4016.6987475939422, 6163.660998645073, 6219.968900155515, 6228.159198508234, 6230.59501132425, 6235.064740288947, 4115.403266526337, 4131.690123240769, 4136.855210067633, 4138.0689344897155, 4138.6482149017675, 4188.85339013133, 4192.203481338536, 4198.160367926366, 4209.810558524812, 4215.3044747616295, 4754.0, 4823.2282834746975, 4830.130576496194, 4840.152973229741, 4848.75756212195, 5862.970685146547, 5864.970675146682, 5869.4717475427415, 5884.499817515473, 5895.469407753237, 1466.340146933884, 1469.7354476194173, 1482.85171482853, 1487.137460273039, 1488.3823213366547, 984.7685793838442, 987.5062468765617, 992.6707970446627, 999.2805180270194, 1004.5178314409125, 5098.4646612105935, 5120.8222108914415, 5122.385313762298, 5126.410462796752, 5130.9230361544605, 6096.237970253718, 6109.572329936862, 6111.236095488064, 6113.663748493876, 6136.048912418582, 5105.566026887756, 5109.948900511022, 5111.974440127776, 5124.92312615311, 5128.461511541309, 3214.5981752280964, 3295.2256219788333, 3306.5866766654167, 3306.9503957440656, 3326.185084654275, 5576.498115169573, 5705.22979397776, 5743.4256574342235, 5823.213866128103, 5829.271341082364, 6228.56400051992, 6356.523260755462, 6373.490120790419, 6378.0, 6379.043143528508, 5779.653220806681, 5780.450857168562, 5783.566232532493, 5784.074548072288, 5790.10253410722, 5904.763809447574, 6121.081837724377, 6121.989871671302, 6136.263648362046, 6149.508039356751, 5971.164037034731, 6028.788992385245, 6035.668038257938, 6037.45662890342, 6043.516518678407, 5774.538036956949, 5790.10253410722, 5798.304203495608, 5806.622569532967, 5806.68063256525, 4103.528094269078, 4156.750594964312, 4159.417681524528, 4160.126373461486, 4183.790810459525, 6035.430787995065, 6104.4505994460715, 6161.291451483136, 6170.969145154246, 6174.876502470015, 5908.3205431375945, 5920.555958303058, 5921.5558833086825, 5925.05199168131, 5936.37668044849, 5902.439268269508, 5927.911081333869, 5933.703314834327, 5945.167676525376, 5955.553333499918, 5649.661020338793, 5741.569382296428, 5765.654060756368, 5773.566982476415, 5813.09896965971, 5951.0, 5963.52291816645, 5974.312954010345, 5978.641281523122, 5987.0121429963565, 5769.134629805395, 5807.651540907559, 5808.186853840551, 5812.099124635688, 5816.76732930678], "unit": "ms", "name": "prototype.html", "value": 4394.36190212127}, {"lowerIsBetter": false, "replicates": [755.4744705992872, 769.8960640313558, 773.5397438524078, 788.0228516639369, 808.2200676347323, 10774.569017239312, 11003.834942475869, 11025.61410350638, 11026.834597481044, 11030.338179709222, 11448.656540303784, 11510.194286399956, 11553.768924621523, 11570.595029173981, 11582.942085289584, 793.7698067560415, 809.5830647216688, 812.2892469089546, 813.8860559521642, 813.9104698483162, 801.0627565748059, 814.4054839966827, 815.8001289684036, 815.8205194857152, 816.5876232502578, 840.1430540848331, 845.7547311279721, 850.7873031742065, 852.1308265569115, 853.6926706385697, 842.4103127810496, 843.6203708331245, 846.7713717296357, 847.1570787066846, 847.3221422861717, 619.863630001399, 621.8072397556726, 622.3993845938691, 624.3413199074975, 628.2931701835436, 10452.94773526135, 10496.580136794519, 10559.26085174038, 10612.151027917747, 10621.946890265499, 9264.675736349263, 9337.953310233474, 9492.762680933032, 9730.805383892353, 9784.559694813679, 8633.35249856257, 8659.913400865973, 8754.080821513713, 8770.122987701243, 8824.955875220583, 3201.6958388953244, 3221.742260619168, 3230.16015835882, 3232.2565809863627, 3298.4392653249006, 40720.38919416211, 41446.37830432546, 43172.56827431717, 43173.35239971403, 43209.35185972245, 8082.797930051795, 8261.545614991233, 8280.420370574002, 9164.450132992042, 9396.0, 15224.314905829264, 15381.615459613598, 15398.692026159413, 15543.300551475211, 15546.300416481285, 6268.905966410507, 6335.4931605472375, 6382.808515744535, 6401.295857455676, 6409.359064093554, 3600.9459858101627, 3613.602503724588, 3638.9636103638622, 3697.445383192489, 3753.2868754936476, 2517.0309430868883, 2531.316544532966, 2534.4550921551954, 2539.0351666367033, 2542.4025354041787, 462.8935344870631, 469.64541770962705, 474.1986043586328, 475.19928919770297, 475.50547430672407, 433.98915027124576, 471.6886854675897, 511.8387707872008, 528.3923487988767, 578.6672663218666, 6873.931260687429, 6965.79102626922, 7089.964550177217, 7472.962635186789, 7557.771091251133, 524.1011664994553, 525.7949399734107, 536.6243629459394, 538.8437353167537, 553.1177771454524, 3260.49462333334, 3505.772124811879, 3517.9472307915403, 3524.3303772283184, 3551.3074950384425, 50641.49358506442, 51732.482675173516, 55307.44692553103, 55369.72315138479, 55537.0, 44296.0, 44907.101857962654, 44911.0, 45517.77241113773, 45965.0, 36540.0, 38579.6142038576, 39035.219295613926, 39488.0, 39914.600853991666, 7676.654550545127, 7821.413393995587, 8460.619272132646, 8519.616617252363, 8591.355648326275, 32741.0, 33040.83479582683, 33127.33745325128, 33522.66477335196, 33654.66345336515, 36385.0, 40495.1900961985, 41246.0, 41568.792156039024, 41755.7912210437, 9141.131592498701, 9203.171714545722, 9294.163525282756, 9474.810503789748, 9611.279154063333, 11088.944555277494, 11404.258723182966, 11445.885541144482, 11485.942570287096, 11903.821442678194, 10269.589216431259, 10681.51933163025, 10692.572297108029, 10806.081483074027, 11116.0, 10306.278560500992, 10332.948335258276, 10795.40625265618, 11104.777904442028, 11106.278091924, 10224.23318251149, 10369.9481502592, 10635.255532112988, 10947.069499092666, 10999.725006874893, 9033.50315732641, 9209.447433154031, 9249.76875578089, 9386.953065234904, 9430.57562409707, 8461.619227134917, 9105.726828195166, 9109.908900910907, 9121.133492318218, 9201.401908875901], "unit": "ms", "name": "yui.html", "value": 5621.973834841761}], "name": "dromaeo_css", "value": 6228.196980585728}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 108.0, 115.0, 112.0, 112.0, 123.0, 112.0, 112.0, 115.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 113.5}, {"lowerIsBetter": true, "replicates": [154.0, 132.0, 151.0, 169.0, 131.0, 159.0, 154.0, 146.0, 169.0, 139.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.4}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 165.0, 164.0, 165.0, 172.0, 165.0, 167.0, 166.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 165.4}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 74.0, 75.0, 144.0, 75.0, 80.0, 72.0, 74.0, 157.0], "unit": "ms", "name": "audio-fft", "value": 89.5}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 131.0, 94.0, 95.0, 94.0, 133.0, 95.0, 95.0, 133.0], "unit": "ms", "name": "audio-oscillator", "value": 105.9}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 109.0, 111.0, 114.0, 110.0, 110.0, 111.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.6}, {"lowerIsBetter": true, "replicates": [148.0, 149.0, 147.0, 150.0, 148.0, 148.0, 148.0, 148.0, 147.0, 149.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.2}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 98.0, 96.0, 95.0, 95.0, 96.0, 97.0, 97.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [75.0, 74.0, 73.0, 72.0, 73.0, 76.0, 74.0, 72.0, 73.0, 73.0], "unit": "ms", "name": "json-parse-financial", "value": 73.5}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 69.0, 69.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [85.0, 83.0, 84.0, 85.0, 86.0, 84.0, 85.0, 83.0, 102.0, 95.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 87.2}, {"lowerIsBetter": true, "replicates": [123.0, 127.0, 120.0, 128.0, 131.0, 123.0, 126.0, 132.0, 122.0, 127.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.9}, {"lowerIsBetter": true, "replicates": [148.0, 151.0, 150.0, 153.0, 149.0, 158.0, 150.0, 151.0, 149.0, 151.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 151.0}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 69.0, 71.0, 71.0, 71.0, 70.0, 70.0, 71.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.2}], "name": "kraken", "value": 1555.9000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.80998176090202], "unit": "score", "name": "Richards", "value": 212.90636200000006}, {"lowerIsBetter": false, "replicates": [191.90174630589138], "unit": "score", "name": "DeltaBlue", "value": 344.54089799999997}, {"lowerIsBetter": false, "replicates": [277.0850651149903], "unit": "score", "name": "Encrypt", "value": 960.647229}, {"lowerIsBetter": false, "replicates": [5229.166666666667], "unit": "score", "name": "Decrypt", "value": 50.90313944223106}, {"lowerIsBetter": false, "replicates": [1085.7763300760043], "unit": "score", "name": "RayTrace", "value": 681.5298690000002}, {"lowerIsBetter": false, "replicates": [702.7406886858749], "unit": "score", "name": "Earley", "value": 948.3768489999995}, {"lowerIsBetter": false, "replicates": [12292.682926829268], "unit": "score", "name": "Boyer", "value": 54.21623611111113}, {"lowerIsBetter": false, "replicates": [26153.846153846152], "unit": "score", "name": "RegExp", "value": 34.8317794117647}, {"lowerIsBetter": false, "replicates": [595.2380952380952], "unit": "score", "name": "Splay", "value": 136.90488}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21291.23457030865}]} 12:04:57 INFO - RETURN: dromaeo_css: 6228.19 12:04:57 INFO - RETURN: kraken: 1555.90 12:04:57 INFO - RETURN: v8_7: 21291.23 12:04:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21291.23"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1555.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6228.19"}}} 12:04:57 INFO - Return code: 0 12:04:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:04:57 INFO - # TBPL SUCCESS # 12:04:57 INFO - Running post-action listener: _resource_record_post_action 12:04:57 INFO - Running post-run listener: _resource_record_post_run 12:04:58 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 504553472; Read time: 8; Write time: 597968 12:04:58 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 231415808; Read time: 0; Write time: 408584 12:04:58 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 4096; Write bytes: 272306176; Read time: 8; Write time: 189340 12:04:58 INFO - Running post-run listener: _upload_blobber_files 12:04:58 INFO - Blob upload gear active. 12:04:58 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:04:58 INFO - Copying logs to upload dir... 12:04:58 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1277.813309 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-11 12:04:56.514479) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-11 12:04:56.518449) ========= 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=1d09c2d9237d126f9c84bbb400000198-1449861998.969139-1555663588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/wcLmEt5RQje3HufTPJI1nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010060 build_url: 'https://queue.taskcluster.net/v1/task/wcLmEt5RQje3HufTPJI1nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-11 12:04:56.569940) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 12:04:56.570286) ========= 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=1d09c2d9237d126f9c84bbb400000198-1449861998.969139-1555663588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004610 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 12:04:56.619506) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-11 12:04:56.619794) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-11 12:04:56.620090) ========= ========= Total master_lag: 0.28 =========