builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-042 starttime: 1449863017.61 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.606197) ========= 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.606596) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-11 11:43:37.606882) ========= 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=c402a24d74c70935940d60dd000001de-1449861795.390981-1322611118 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006334 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-11 11:43:37.642400) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-11 11:43:37.642700) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-11 11:43:37.714117) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 11:43:37.714409) ========= 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=c402a24d74c70935940d60dd000001de-1449861795.390981-1322611118 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004701 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 11:43:37.785798) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-11 11:43:37.786113) ========= 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:37.786491) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 11:43:37.786761) ========= 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=c402a24d74c70935940d60dd000001de-1449861795.390981-1322611118 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-11 11:43:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 46.9M=0s 2015-12-11 11:43:38 (46.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105884 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 11:43:37.916793) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 11:43:37.917165) ========= 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=c402a24d74c70935940d60dd000001de-1449861795.390981-1322611118 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022290 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 11:43:37.968443) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-11 11:43:37.968805) ========= 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=c402a24d74c70935940d60dd000001de-1449861795.390981-1322611118 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-11 11:43:38,208 truncating revision to first 12 chars 2015-12-11 11:43:38,208 Setting DEBUG logging. 2015-12-11 11:43:38,208 attempt 1/10 2015-12-11 11:43:38,208 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:39,409 unpacking tar archive at: fx-team-146f5531e7bd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.475769 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-11 11:43:39.458194) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-11 11:43:39.458614) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-11 11:43:39.469386) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-11 11:43:39.469790) ========= 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:39.470296) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 7 secs) (at 2015-12-11 11:43:39.470606) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=c402a24d74c70935940d60dd000001de-1449861795.390981-1322611118 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:43:39 INFO - MultiFileLogger online at 20151211 11:43:39 in /builds/slave/test 11:43:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:43:39 INFO - {'append_to_log': False, 11:43:39 INFO - 'base_work_dir': '/builds/slave/test', 11:43:39 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:43:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:43:39 INFO - 'branch': 'Fx-Team-Non-PGO', 11:43:39 INFO - 'buildbot_json_path': 'buildprops.json', 11:43:39 INFO - 'config_files': ('talos/linux_config.py',), 11:43:39 INFO - 'default_actions': ('clobber', 11:43:39 INFO - 'read-buildbot-config', 11:43:39 INFO - 'download-and-extract', 11:43:39 INFO - 'populate-webroot', 11:43:39 INFO - 'create-virtualenv', 11:43:39 INFO - 'install', 11:43:39 INFO - 'run-tests'), 11:43:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:43:39 INFO - 'download_minidump_stackwalk': True, 11:43:39 INFO - 'download_symbols': 'ondemand', 11:43:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:43:39 INFO - 'tooltool.py': '/tools/tooltool.py', 11:43:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:43:39 INFO - '/tools/misc-python/virtualenv.py')}, 11:43:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:43:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:43:39 INFO - 'installer_path': 'installer.exe', 11:43:39 INFO - 'log_level': 'info', 11:43:39 INFO - 'log_name': 'talos', 11:43:39 INFO - 'log_to_console': True, 11:43:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:43:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:43:39 INFO - 'opt_config_files': (), 11:43:39 INFO - 'pip_index': False, 11:43:39 INFO - 'sps_profile': False, 11:43:39 INFO - 'sps_profile_interval': 0, 11:43:39 INFO - 'suite': 'dromaeojs', 11:43:39 INFO - 'system_bits': '64', 11:43:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:43:39 INFO - 'title': 'talos-linux64-ix-042', 11:43:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:43:39 INFO - 'use_talos_json': True, 11:43:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:43:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:43:39 INFO - 'work_dir': 'build'} 11:43:39 INFO - ##### 11:43:39 INFO - ##### Running clobber step. 11:43:39 INFO - ##### 11:43:39 INFO - Running pre-action listener: _resource_record_pre_action 11:43:39 INFO - Running main action method: clobber 11:43:39 INFO - rmtree: /builds/slave/test/build 11:43:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:43:40 INFO - Running post-action listener: _resource_record_post_action 11:43:40 INFO - ##### 11:43:40 INFO - ##### Running read-buildbot-config step. 11:43:40 INFO - ##### 11:43:40 INFO - Running pre-action listener: _resource_record_pre_action 11:43:40 INFO - Running main action method: read_buildbot_config 11:43:40 INFO - Using buildbot properties: 11:43:40 INFO - { 11:43:40 INFO - "properties": { 11:43:40 INFO - "buildnumber": 2205, 11:43:40 INFO - "product": "firefox", 11:43:40 INFO - "script_repo_revision": "production", 11:43:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:43:40 INFO - "repository": "", 11:43:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 11:43:40 INFO - "buildid": "20151211110732", 11:43:40 INFO - "slavename": "talos-linux64-ix-042", 11:43:40 INFO - "pgo_build": "False", 11:43:40 INFO - "basedir": "/builds/slave/test", 11:43:40 INFO - "project": "", 11:43:40 INFO - "platform": "ubuntu64_hw", 11:43:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:43:40 INFO - "slavebuilddir": "test", 11:43:40 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:43:40 INFO - "branch": "fx-team", 11:43:40 INFO - "repo_path": "integration/fx-team", 11:43:40 INFO - "stage_platform": "linux64", 11:43:40 INFO - "builduid": "f1a7bb67fd304fdaa9079fa65b9b8aea", 11:43:40 INFO - "revision": "146f5531e7bd31d92215aaa6b489f62a14994503" 11:43:40 INFO - }, 11:43:40 INFO - "sourcestamp": { 11:43:40 INFO - "repository": "", 11:43:40 INFO - "hasPatch": false, 11:43:40 INFO - "project": "", 11:43:40 INFO - "branch": "fx-team-linux64-talos", 11:43:40 INFO - "changes": [ 11:43:40 INFO - { 11:43:40 INFO - "category": null, 11:43:40 INFO - "files": [ 11:43:40 INFO - { 11:43:40 INFO - "url": null, 11:43:40 INFO - "name": "https://queue.taskcluster.net/v1/task/wcLmEt5RQje3HufTPJI1nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 11:43:40 INFO - } 11:43:40 INFO - ], 11:43:40 INFO - "repository": "", 11:43:40 INFO - "rev": "146f5531e7bd31d92215aaa6b489f62a14994503", 11:43:40 INFO - "who": "ryanvm@gmail.com", 11:43:40 INFO - "when": 1449862979, 11:43:40 INFO - "number": 7354029, 11:43:40 INFO - "comments": "Bug 1232015 - Update pdf.js to version 1.3.72. r=bdahl", 11:43:40 INFO - "project": "", 11:43:40 INFO - "at": "Fri 11 Dec 2015 11:42:59", 11:43:40 INFO - "branch": "fx-team-linux64-talos", 11:43:40 INFO - "revlink": "", 11:43:40 INFO - "properties": [ 11:43:40 INFO - [ 11:43:40 INFO - "buildid", 11:43:40 INFO - "20151211110732", 11:43:40 INFO - "Change" 11:43:40 INFO - ], 11:43:40 INFO - [ 11:43:40 INFO - "builduid", 11:43:40 INFO - "f1a7bb67fd304fdaa9079fa65b9b8aea", 11:43:40 INFO - "Change" 11:43:40 INFO - ], 11:43:40 INFO - [ 11:43:40 INFO - "pgo_build", 11:43:40 INFO - "False", 11:43:40 INFO - "Change" 11:43:40 INFO - ] 11:43:40 INFO - ], 11:43:40 INFO - "revision": "146f5531e7bd31d92215aaa6b489f62a14994503" 11:43:40 INFO - } 11:43:40 INFO - ], 11:43:40 INFO - "revision": "146f5531e7bd31d92215aaa6b489f62a14994503" 11:43:40 INFO - } 11:43:40 INFO - } 11:43:40 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:40 INFO - Running post-action listener: _resource_record_post_action 11:43:40 INFO - ##### 11:43:40 INFO - ##### Running download-and-extract step. 11:43:40 INFO - ##### 11:43:40 INFO - Running pre-action listener: _resource_record_pre_action 11:43:40 INFO - Running main action method: download_and_extract 11:43:40 INFO - mkdir: /builds/slave/test/build/tests 11:43:40 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:40 INFO - https://queue.taskcluster.net/v1/task/wcLmEt5RQje3HufTPJI1nw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:43:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wcLmEt5RQje3HufTPJI1nw/artifacts/public/build/test_packages.json 11:43:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wcLmEt5RQje3HufTPJI1nw/artifacts/public/build/test_packages.json 11:43:40 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:40 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:49 INFO - Downloaded 1302 bytes. 11:43:49 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:43:49 INFO - Using the following test package requirements: 11:43:49 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:43:49 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:43:49 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:43:49 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:43:49 INFO - u'jsshell-linux-x86_64.zip'], 11:43:49 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:43:49 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:43:49 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:43:49 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:43:49 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:43:49 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:43:49 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:43:49 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:43:49 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:43:49 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:43:49 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:43:49 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:43:49 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:43:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:49 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:49 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:49 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:49 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:49 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:58 INFO - Downloaded 21874385 bytes. 11:43:58 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:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:43:58 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:59 INFO - Return code: 0 11:43:59 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:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:59 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:59 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:59 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:59 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:59 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:44:00 INFO - Downloaded 21874385 bytes. 11:44:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 11:44:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:44:00 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:44:01 INFO - Return code: 0 11:44:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:01 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:44:01 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:44:01 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:44:01 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:44:01 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:44:02 INFO - Downloaded 11132038 bytes. 11:44:02 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:44:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:44:02 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:44:03 INFO - Return code: 0 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 - 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:44:03 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:44:03 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:44:03 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:44:03 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:04 INFO - Downloaded 57731594 bytes. 11:44:04 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:04 INFO - mkdir: /builds/slave/test/properties 11:44:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:44:04 INFO - Writing to file /builds/slave/test/properties/build_url 11:44:04 INFO - Contents: 11:44:04 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:04 INFO - Running post-action listener: _resource_record_post_action 11:44:04 INFO - Running post-action listener: set_extra_try_arguments 11:44:04 INFO - ##### 11:44:04 INFO - ##### Running populate-webroot step. 11:44:04 INFO - ##### 11:44:04 INFO - Running pre-action listener: _resource_record_pre_action 11:44:04 INFO - Running main action method: populate_webroot 11:44:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:44:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:44:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:44:04 INFO - '--tppagecycles', 11:44:04 INFO - '7'], 11:44:04 INFO - 'tests': ['tsvgm']}}, 11:44:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:44:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:44:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:44:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:44:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:44:04 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:44:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:44:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:44:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:44:04 INFO - 'talos_options': ['--e10s'], 11:44:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:44:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:44:04 INFO - 'tests': ['damp', 'tps']}, 11:44:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:44:04 INFO - 'talos_options': ['--e10s'], 11:44:04 INFO - 'tests': ['damp', 'tps']}, 11:44:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:44:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:44:04 INFO - 'other': {'tests': ['a11yr', 11:44:04 INFO - 'ts_paint', 11:44:04 INFO - 'tpaint', 11:44:04 INFO - 'sessionrestore', 11:44:04 INFO - 'sessionrestore_no_auto_restore']}, 11:44:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:44:04 INFO - 'tests': ['a11yr', 11:44:04 INFO - 'ts_paint', 11:44:04 INFO - 'tpaint', 11:44:04 INFO - 'sessionrestore', 11:44:04 INFO - 'sessionrestore_no_auto_restore']}, 11:44:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:44:04 INFO - 'tests': ['a11yr', 11:44:04 INFO - 'ts_paint', 11:44:04 INFO - 'tpaint', 11:44:04 INFO - 'sessionrestore', 11:44:04 INFO - 'sessionrestore_no_auto_restore']}, 11:44:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:44:04 INFO - 'tests': ['a11yr', 11:44:04 INFO - 'ts_paint', 11:44:04 INFO - 'tpaint', 11:44:04 INFO - 'sessionrestore', 11:44:04 INFO - 'sessionrestore_no_auto_restore']}, 11:44:04 INFO - 'other_l64': {'tests': ['a11yr', 11:44:04 INFO - 'ts_paint', 11:44:04 INFO - 'tpaint', 11:44:04 INFO - 'sessionrestore', 11:44:04 INFO - 'sessionrestore_no_auto_restore']}, 11:44:04 INFO - 'other_nol64': {'tests': ['a11yr', 11:44:04 INFO - 'ts_paint', 11:44:04 INFO - 'tpaint', 11:44:04 INFO - 'sessionrestore', 11:44:04 INFO - 'sessionrestore_no_auto_restore']}, 11:44:04 INFO - 'svgr': {'tests': ['tsvgx', 11:44:04 INFO - 'tsvgr_opacity', 11:44:04 INFO - 'tart', 11:44:04 INFO - 'tscrollx', 11:44:04 INFO - 'cart']}, 11:44:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:44:04 INFO - 'tests': ['tsvgx', 11:44:04 INFO - 'tsvgr_opacity', 11:44:04 INFO - 'tart', 11:44:04 INFO - 'tscrollx', 11:44:04 INFO - 'cart']}, 11:44:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:44:04 INFO - 'tests': ['tp5o']}, 11:44:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:44:04 INFO - 'talos_options': ['--e10s'], 11:44:04 INFO - 'tests': ['tp5o']}, 11:44:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:44:04 INFO - 'talos_options': ['--xperf_path', 11:44:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:44:04 INFO - 'tests': ['tp5n']}, 11:44:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:44:04 INFO - 'talos_options': ['--e10s', 11:44:04 INFO - '--xperf_path', 11:44:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:44:04 INFO - 'tests': ['tp5n']}}, 11:44:04 INFO - 'talos.zip': {'path': '', 11:44:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:44:04 INFO - Running post-action listener: _resource_record_post_action 11:44:04 INFO - ##### 11:44:04 INFO - ##### Running create-virtualenv step. 11:44:04 INFO - ##### 11:44:04 INFO - Running pre-action listener: _resource_record_pre_action 11:44:04 INFO - Running main action method: create_virtualenv 11:44:04 INFO - Creating virtualenv /builds/slave/test/build/venv 11:44:04 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:44:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:44:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:44:04 INFO - Using real prefix '/usr' 11:44:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:44:05 INFO - Installing distribute.............................................................................................................................................................................................done. 11:44:07 INFO - Installing pip.................done. 11:44:07 INFO - Return code: 0 11:44:07 INFO - Installing pip>=1.5 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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f138afe4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1855240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e40b0>, '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 0x18e4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5440>, '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': 'c402a24d74c70935940d60dd000001de-1449861795.390981-1322611118', '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', 'pip>=1.5'] 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 pip>=1.5 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': 'c402a24d74c70935940d60dd000001de-1449861795.390981-1322611118', 11:44:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:07 INFO - '_': '/tools/buildbot/bin/python'} 11:44:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:07 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:44:07 INFO - Cleaning up... 11:44:07 INFO - Return code: 0 11:44:07 INFO - Installing psutil>=0.7.1 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', '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 0x7f138afe4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1855240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e40b0>, '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 0x18e4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5440>, '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': 'c402a24d74c70935940d60dd000001de-1449861795.390981-1322611118', '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', 'psutil>=0.7.1'] 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 psutil>=0.7.1 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': 'c402a24d74c70935940d60dd000001de-1449861795.390981-1322611118', 11:44:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:07 INFO - '_': '/tools/buildbot/bin/python'} 11:44:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:07 INFO - Downloading/unpacking psutil>=0.7.1 11:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:09 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 11:44:09 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:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:44:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:44:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:44:09 INFO - Installing collected packages: psutil 11:44:09 INFO - Running setup.py install for psutil 11:44:09 INFO - building 'psutil._psutil_linux' extension 11:44:09 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:09 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:09 INFO - building 'psutil._psutil_posix' extension 11:44:09 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:09 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:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:44:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:44:10 INFO - Successfully installed psutil 11:44:10 INFO - Cleaning up... 11:44:10 INFO - Return code: 0 11:44:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:44:10 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:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:10 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:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:10 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 0x7f138afe4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1855240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e40b0>, '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 0x18e4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5440>, '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': 'c402a24d74c70935940d60dd000001de-1449861795.390981-1322611118', '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:10 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:10 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:10 INFO - Using env: {'DISPLAY': ':0', 11:44:10 INFO - 'HOME': '/home/cltbld', 11:44:10 INFO - 'LANG': 'en_US.UTF-8', 11:44:10 INFO - 'LANGUAGE': 'en_US:en', 11:44:10 INFO - 'LOGNAME': 'cltbld', 11:44:10 INFO - 'MAIL': '/var/mail/cltbld', 11:44:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:10 INFO - 'MOZ_NO_REMOTE': '1', 11:44:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:10 INFO - 'NO_EM_RESTART': '1', 11:44:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:10 INFO - 'PWD': '/builds/slave/test', 11:44:10 INFO - 'SHELL': '/bin/bash', 11:44:10 INFO - 'SHLVL': '1', 11:44:10 INFO - 'TERM': 'linux', 11:44:10 INFO - 'TMOUT': '86400', 11:44:10 INFO - 'USER': 'cltbld', 11:44:10 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1449861795.390981-1322611118', 11:44:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:10 INFO - '_': '/tools/buildbot/bin/python'} 11:44:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 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:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:44:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:44:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:44:12 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:12 INFO - Installing collected packages: mozsystemmonitor 11:44:12 INFO - Running setup.py install for mozsystemmonitor 11:44:12 INFO - Successfully installed mozsystemmonitor 11:44:12 INFO - Cleaning up... 11:44:12 INFO - Return code: 0 11:44:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:44:12 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:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:12 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:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:12 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 0x7f138afe4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1855240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e40b0>, '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 0x18e4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5440>, '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': 'c402a24d74c70935940d60dd000001de-1449861795.390981-1322611118', '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:12 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:12 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:12 INFO - Using env: {'DISPLAY': ':0', 11:44:12 INFO - 'HOME': '/home/cltbld', 11:44:12 INFO - 'LANG': 'en_US.UTF-8', 11:44:12 INFO - 'LANGUAGE': 'en_US:en', 11:44:12 INFO - 'LOGNAME': 'cltbld', 11:44:12 INFO - 'MAIL': '/var/mail/cltbld', 11:44:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:12 INFO - 'MOZ_NO_REMOTE': '1', 11:44:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:12 INFO - 'NO_EM_RESTART': '1', 11:44:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:12 INFO - 'PWD': '/builds/slave/test', 11:44:12 INFO - 'SHELL': '/bin/bash', 11:44:12 INFO - 'SHLVL': '1', 11:44:12 INFO - 'TERM': 'linux', 11:44:12 INFO - 'TMOUT': '86400', 11:44:12 INFO - 'USER': 'cltbld', 11:44:12 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1449861795.390981-1322611118', 11:44:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:12 INFO - '_': '/tools/buildbot/bin/python'} 11:44:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:12 INFO - Downloading/unpacking blobuploader==1.2.4 11:44:12 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:12 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:12 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:12 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:12 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:12 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:14 INFO - Downloading blobuploader-1.2.4.tar.gz 11:44:14 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:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:44:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:14 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:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:44:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:14 INFO - Downloading docopt-0.6.1.tar.gz 11:44:14 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:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:44:14 INFO - Installing collected packages: blobuploader, requests, docopt 11:44:14 INFO - Running setup.py install for blobuploader 11:44:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:44:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:44:14 INFO - Running setup.py install for requests 11:44:15 INFO - Running setup.py install for docopt 11:44:15 INFO - Successfully installed blobuploader requests docopt 11:44:15 INFO - Cleaning up... 11:44:15 INFO - Return code: 0 11:44:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:44:15 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:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:15 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:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:15 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 0x7f138afe4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1855240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e40b0>, '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 0x18e4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5440>, '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': 'c402a24d74c70935940d60dd000001de-1449861795.390981-1322611118', '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:15 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:15 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:15 INFO - Using env: {'DISPLAY': ':0', 11:44:15 INFO - 'HOME': '/home/cltbld', 11:44:15 INFO - 'LANG': 'en_US.UTF-8', 11:44:15 INFO - 'LANGUAGE': 'en_US:en', 11:44:15 INFO - 'LOGNAME': 'cltbld', 11:44:15 INFO - 'MAIL': '/var/mail/cltbld', 11:44:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:15 INFO - 'MOZ_NO_REMOTE': '1', 11:44:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:15 INFO - 'NO_EM_RESTART': '1', 11:44:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:15 INFO - 'PWD': '/builds/slave/test', 11:44:15 INFO - 'SHELL': '/bin/bash', 11:44:15 INFO - 'SHLVL': '1', 11:44:15 INFO - 'TERM': 'linux', 11:44:15 INFO - 'TMOUT': '86400', 11:44:15 INFO - 'USER': 'cltbld', 11:44:15 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1449861795.390981-1322611118', 11:44:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:15 INFO - '_': '/tools/buildbot/bin/python'} 11:44:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:44:15 INFO - Running setup.py (path:/tmp/pip-yGw6ti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:44:15 INFO - Running setup.py (path:/tmp/pip-hVj6OY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:44:15 INFO - Running setup.py (path:/tmp/pip-reNYGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:44:15 INFO - Running setup.py (path:/tmp/pip-6O7FeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:44:15 INFO - Running setup.py (path:/tmp/pip-M0Hak1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:44:15 INFO - Running setup.py (path:/tmp/pip-nlIiWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:44:16 INFO - Running setup.py (path:/tmp/pip-6EzUpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:44:16 INFO - Running setup.py (path:/tmp/pip-5jPFHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:44:16 INFO - Running setup.py (path:/tmp/pip-FqT1PO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:44:16 INFO - Running setup.py (path:/tmp/pip-Phn0IT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:44:16 INFO - Running setup.py (path:/tmp/pip-S3KrWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:44:16 INFO - Running setup.py (path:/tmp/pip-ySuRYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:44:16 INFO - Running setup.py (path:/tmp/pip-aXCiFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:44:16 INFO - Running setup.py (path:/tmp/pip-3wotK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:44:16 INFO - Running setup.py (path:/tmp/pip-3_0xXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:44:16 INFO - Running setup.py (path:/tmp/pip-RjCeJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:44:16 INFO - Running setup.py (path:/tmp/pip-0vS9nc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:44:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:44:16 INFO - Running setup.py install for manifestparser 11:44:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:44:16 INFO - Running setup.py install for mozcrash 11:44:17 INFO - Running setup.py install for mozdebug 11:44:17 INFO - Running setup.py install for mozdevice 11:44:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:44:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:44:17 INFO - Running setup.py install for mozfile 11:44:17 INFO - Running setup.py install for mozhttpd 11:44:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:44:17 INFO - Running setup.py install for mozinfo 11:44:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:44:17 INFO - Running setup.py install for mozInstall 11:44:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:44:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:44:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:44:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:44:17 INFO - Running setup.py install for mozleak 11:44:17 INFO - Running setup.py install for mozlog 11:44:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:44:17 INFO - Running setup.py install for moznetwork 11:44:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:44:18 INFO - Running setup.py install for mozprocess 11:44:18 INFO - Running setup.py install for mozprofile 11:44:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:44:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:44:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:44:18 INFO - Running setup.py install for mozrunner 11:44:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:44:18 INFO - Running setup.py install for mozscreenshot 11:44:18 INFO - Running setup.py install for moztest 11:44:18 INFO - Running setup.py install for mozversion 11:44:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:44:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:44:18 INFO - Cleaning up... 11:44:18 INFO - Return code: 0 11:44:18 INFO - Installing None 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', '-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 0x7f138afe4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1855240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e40b0>, '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 0x18e4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5440>, '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': 'c402a24d74c70935940d60dd000001de-1449861795.390981-1322611118', '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', '-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:18 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: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': 'c402a24d74c70935940d60dd000001de-1449861795.390981-1322611118', 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 - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:44:18 INFO - Running setup.py (path:/tmp/pip-VoLQqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:44:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:44:18 INFO - Running setup.py (path:/tmp/pip-qgxeXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:44:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:44:19 INFO - Running setup.py (path:/tmp/pip-NbPasT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:44:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:44:19 INFO - Running setup.py (path:/tmp/pip-FngAoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:44:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:44:19 INFO - Running setup.py (path:/tmp/pip-S31LMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:44:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:44:19 INFO - Running setup.py (path:/tmp/pip-5FsaIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:44:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:44:19 INFO - Running setup.py (path:/tmp/pip-jXpPD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:44:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:44:19 INFO - Running setup.py (path:/tmp/pip-fTt6x1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:44:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:44:19 INFO - Running setup.py (path:/tmp/pip-GutZdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:44:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:44:19 INFO - Running setup.py (path:/tmp/pip-rANxb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:44:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:44:19 INFO - Running setup.py (path:/tmp/pip-dI1gYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:44:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:44:19 INFO - Running setup.py (path:/tmp/pip-hMPu1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:44:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:44:19 INFO - Running setup.py (path:/tmp/pip-xLeWQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:44:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:44:19 INFO - Running setup.py (path:/tmp/pip-Gd6xjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:44:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:44:19 INFO - Running setup.py (path:/tmp/pip-8DuzDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:44:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:44:19 INFO - Running setup.py (path:/tmp/pip-jDrOpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:44:20 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:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:44:20 INFO - Running setup.py (path:/tmp/pip-qgqqti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:44:20 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:20 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:20 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:20 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:20 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:20 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:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 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:21 INFO - Downloading blessings-1.5.1.tar.gz 11:44:21 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:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:44:21 INFO - Installing collected packages: blessings 11:44:21 INFO - Running setup.py install for blessings 11:44:21 INFO - Successfully installed blessings 11:44:21 INFO - Cleaning up... 11:44:22 INFO - Return code: 0 11:44:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:44:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:44:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:44:22 INFO - Reading from file tmpfile_stdout 11:44:22 INFO - Current package versions: 11:44:22 INFO - argparse == 1.2.1 11:44:22 INFO - blessings == 1.5.1 11:44:22 INFO - blobuploader == 1.2.4 11:44:22 INFO - docopt == 0.6.1 11:44:22 INFO - manifestparser == 1.1 11:44:22 INFO - mozInstall == 1.12 11:44:22 INFO - mozcrash == 0.16 11:44:22 INFO - mozdebug == 0.1 11:44:22 INFO - mozdevice == 0.47 11:44:22 INFO - mozfile == 1.2 11:44:22 INFO - mozhttpd == 0.7 11:44:22 INFO - mozinfo == 0.9 11:44:22 INFO - mozleak == 0.1 11:44:22 INFO - mozlog == 3.1 11:44:22 INFO - moznetwork == 0.27 11:44:22 INFO - mozprocess == 0.22 11:44:22 INFO - mozprofile == 0.27 11:44:22 INFO - mozrunner == 6.11 11:44:22 INFO - mozscreenshot == 0.1 11:44:22 INFO - mozsystemmonitor == 0.0 11:44:22 INFO - moztest == 0.7 11:44:22 INFO - mozversion == 1.4 11:44:22 INFO - psutil == 3.1.1 11:44:22 INFO - requests == 1.2.3 11:44:22 INFO - wsgiref == 0.1.2 11:44:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:44:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:22 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 0x7f138afe4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1855240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e40b0>, '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 0x18e4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5440>, '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': 'c402a24d74c70935940d60dd000001de-1449861795.390981-1322611118', '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:22 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:22 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:22 INFO - Using env: {'DISPLAY': ':0', 11:44:22 INFO - 'HOME': '/home/cltbld', 11:44:22 INFO - 'LANG': 'en_US.UTF-8', 11:44:22 INFO - 'LANGUAGE': 'en_US:en', 11:44:22 INFO - 'LOGNAME': 'cltbld', 11:44:22 INFO - 'MAIL': '/var/mail/cltbld', 11:44:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:22 INFO - 'MOZ_NO_REMOTE': '1', 11:44:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:22 INFO - 'NO_EM_RESTART': '1', 11:44:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:22 INFO - 'PWD': '/builds/slave/test', 11:44:22 INFO - 'SHELL': '/bin/bash', 11:44:22 INFO - 'SHLVL': '1', 11:44:22 INFO - 'TERM': 'linux', 11:44:22 INFO - 'TMOUT': '86400', 11:44:22 INFO - 'USER': 'cltbld', 11:44:22 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1449861795.390981-1322611118', 11:44:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:22 INFO - '_': '/tools/buildbot/bin/python'} 11:44:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:22 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:22 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:22 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:22 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:22 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:22 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:22 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:22 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:22 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:22 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:22 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:22 INFO - Cleaning up... 11:44:22 INFO - Return code: 0 11:44:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:44:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:22 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 0x7f138afe4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1855240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e40b0>, '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 0x18e4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5440>, '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': 'c402a24d74c70935940d60dd000001de-1449861795.390981-1322611118', '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:22 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:22 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:22 INFO - Using env: {'DISPLAY': ':0', 11:44:22 INFO - 'HOME': '/home/cltbld', 11:44:22 INFO - 'LANG': 'en_US.UTF-8', 11:44:22 INFO - 'LANGUAGE': 'en_US:en', 11:44:22 INFO - 'LOGNAME': 'cltbld', 11:44:22 INFO - 'MAIL': '/var/mail/cltbld', 11:44:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:22 INFO - 'MOZ_NO_REMOTE': '1', 11:44:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:22 INFO - 'NO_EM_RESTART': '1', 11:44:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:22 INFO - 'PWD': '/builds/slave/test', 11:44:22 INFO - 'SHELL': '/bin/bash', 11:44:22 INFO - 'SHLVL': '1', 11:44:22 INFO - 'TERM': 'linux', 11:44:22 INFO - 'TMOUT': '86400', 11:44:22 INFO - 'USER': 'cltbld', 11:44:22 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1449861795.390981-1322611118', 11:44:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:22 INFO - '_': '/tools/buildbot/bin/python'} 11:44:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:22 INFO - Downloading/unpacking jsonschema 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:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:44:24 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:24 INFO - Downloading/unpacking functools32 (from jsonschema) 11:44:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:24 INFO - Downloading functools32-3.2.3-2.tar.gz 11:44:24 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:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:44:24 INFO - warning: no files found matching '*.txt' 11:44:24 INFO - no previously-included directories found matching 'build' 11:44:24 INFO - no previously-included directories found matching 'dist' 11:44:24 INFO - no previously-included directories found matching '.git*' 11:44:24 INFO - Installing collected packages: jsonschema, functools32 11:44:24 INFO - Running setup.py install for functools32 11:44:24 INFO - warning: no files found matching '*.txt' 11:44:24 INFO - no previously-included directories found matching 'build' 11:44:24 INFO - no previously-included directories found matching 'dist' 11:44:24 INFO - no previously-included directories found matching '.git*' 11:44:24 INFO - Successfully installed jsonschema functools32 11:44:24 INFO - Cleaning up... 11:44:24 INFO - Return code: 0 11:44:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:44:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f138afe4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1855240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e40b0>, '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 0x18e4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5440>, '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': 'c402a24d74c70935940d60dd000001de-1449861795.390981-1322611118', '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:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:44:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:44:24 INFO - Using env: {'DISPLAY': ':0', 11:44:24 INFO - 'HOME': '/home/cltbld', 11:44:24 INFO - 'LANG': 'en_US.UTF-8', 11:44:24 INFO - 'LANGUAGE': 'en_US:en', 11:44:24 INFO - 'LOGNAME': 'cltbld', 11:44:24 INFO - 'MAIL': '/var/mail/cltbld', 11:44:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:24 INFO - 'MOZ_NO_REMOTE': '1', 11:44:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:24 INFO - 'NO_EM_RESTART': '1', 11:44:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:24 INFO - 'PWD': '/builds/slave/test', 11:44:24 INFO - 'SHELL': '/bin/bash', 11:44:24 INFO - 'SHLVL': '1', 11:44:24 INFO - 'TERM': 'linux', 11:44:24 INFO - 'TMOUT': '86400', 11:44:24 INFO - 'USER': 'cltbld', 11:44:24 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1449861795.390981-1322611118', 11:44:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:24 INFO - '_': '/tools/buildbot/bin/python'} 11:44:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:25 INFO - Downloading/unpacking flake8 11:44:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:44:26 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:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:44:26 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:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:27 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:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:44:27 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:27 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:27 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:27 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:27 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:27 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:27 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:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:44:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:44:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:44:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:44:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:44:27 INFO - no previously-included directories found matching 'docs/_build' 11:44:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:44:27 INFO - Running setup.py install for pep8 11:44:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:44:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:44:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:44:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:44:27 INFO - no previously-included directories found matching 'docs/_build' 11:44:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:44:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:44:27 INFO - Cleaning up... 11:44:27 INFO - Return code: 0 11:44:27 INFO - Running post-action listener: _resource_record_post_action 11:44:27 INFO - Running post-action listener: _start_resource_monitoring 11:44:27 INFO - Starting resource monitoring. 11:44:27 INFO - ##### 11:44:27 INFO - ##### Running install step. 11:44:27 INFO - ##### 11:44:27 INFO - Running pre-action listener: _resource_record_pre_action 11:44:27 INFO - Running main action method: install 11:44:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:44:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:44:27 INFO - Reading from file tmpfile_stdout 11:44:27 INFO - Detecting whether we're running mozinstall >=1.0... 11:44:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:44:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:44:27 INFO - Reading from file tmpfile_stdout 11:44:27 INFO - Output received: 11:44:27 INFO - Usage: mozinstall [options] installer 11:44:27 INFO - Options: 11:44:27 INFO - -h, --help show this help message and exit 11:44:27 INFO - -d DEST, --destination=DEST 11:44:27 INFO - Directory to install application into. [default: 11:44:27 INFO - "/builds/slave/test"] 11:44:27 INFO - --app=APP Application being installed. [default: firefox] 11:44:27 INFO - mkdir: /builds/slave/test/build/application 11:44:27 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:27 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:42 INFO - Reading from file tmpfile_stdout 11:44:42 INFO - Output received: 11:44:42 INFO - /builds/slave/test/build/application/firefox/firefox 11:44:42 INFO - Running post-action listener: _resource_record_post_action 11:44:42 INFO - ##### 11:44:42 INFO - ##### Running run-tests step. 11:44:42 INFO - ##### 11:44:42 INFO - Running pre-action listener: _resource_record_pre_action 11:44:42 INFO - Running main action method: run_tests 11:44:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:44:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:44:42 INFO - Python 2.7.3 11:44:42 INFO - Return code: 0 11:44:42 INFO - grabbing minidump binary from tooltool 11:44: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:44:42 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 0x18e40b0>, '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 0x18e4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:44:42 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:42 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:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:44:42 INFO - Return code: 0 11:44:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:44:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:44:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:44:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:44:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:44:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:44:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:44:43 INFO - Return code: 0 11:44:43 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', '--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-042', '--webServer', 'localhost'] in /builds/slave/test/build 11:44:43 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 --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-042 --webServer localhost 11:44:43 INFO - Using env: {'DISPLAY': ':0', 11:44:43 INFO - 'HOME': '/home/cltbld', 11:44:43 INFO - 'LANG': 'en_US.UTF-8', 11:44:43 INFO - 'LANGUAGE': 'en_US:en', 11:44:43 INFO - 'LOGNAME': 'cltbld', 11:44:43 INFO - 'MAIL': '/var/mail/cltbld', 11:44:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:44:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:44:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:43 INFO - 'MOZ_NO_REMOTE': '1', 11:44:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:44:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:43 INFO - 'NO_EM_RESTART': '1', 11:44:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:43 INFO - 'PWD': '/builds/slave/test', 11:44:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:44:43 INFO - 'SHELL': '/bin/bash', 11:44:43 INFO - 'SHLVL': '1', 11:44:43 INFO - 'TERM': 'linux', 11:44:43 INFO - 'TMOUT': '86400', 11:44:43 INFO - 'USER': 'cltbld', 11:44:43 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1449861795.390981-1322611118', 11:44:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:43 INFO - '_': '/tools/buildbot/bin/python'} 11:44:43 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', '--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-042', '--webServer', 'localhost'] with output_timeout 3600 11:44:43 INFO - mozversion INFO | application_buildid: 20151211110732 11:44:43 INFO - mozversion INFO | application_changeset: 146f5531e7bd31d92215aaa6b489f62a14994503 11:44:43 INFO - mozversion INFO | application_display_name: Nightly 11:44:43 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:44:43 INFO - mozversion INFO | application_name: Firefox 11:44:43 INFO - mozversion INFO | application_remotingname: firefox 11:44:43 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 11:44:43 INFO - mozversion INFO | application_vendor: Mozilla 11:44:43 INFO - mozversion INFO | application_version: 45.0a1 11:44:43 INFO - mozversion INFO | platform_buildid: 20151211110732 11:44:43 INFO - mozversion INFO | platform_changeset: 146f5531e7bd31d92215aaa6b489f62a14994503 11:44:43 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 11:44:43 INFO - mozversion INFO | platform_version: 45.0a1 11:44:43 INFO - 2015-12-11 11:44:43,648 DEBUG : using testdate: 1449863083 11:44:43 INFO - 2015-12-11 11:44:43,648 DEBUG : actual date: 1449863083 11:44:43 INFO - 2015-12-11 11:44:43,657 INFO : starting webserver on 'localhost:43858' 11:44:43 INFO - 2015-12-11 11:44:43,658 INFO : Starting test suite talos-linux64-ix-042 11:44:43 INFO - 2015-12-11 11:44:43,658 INFO : Starting test dromaeo_css 11:44:43 INFO - 2015-12-11 11:44:43,659 DEBUG : operating with platform_type : linux_ 11:44:43 INFO - 2015-12-11 11:44:43,659 INFO : Initialising browser for dromaeo_css test... 11:44:43 INFO - 2015-12-11 11:44:43,673 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnNirsH/profile http://localhost:43858/getInfo.html 11:44:48 INFO - 2015-12-11 11:44:48,651 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:44:48 INFO - 2015-12-11 11:44:48,651 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:44:48 INFO - 2015-12-11 11:44:48,651 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:44:48 INFO - 2015-12-11 11:44:48,651 DEBUG : BROWSER_OUTPUT: __metrics 11:44:48 INFO - 2015-12-11 11:44:48,739 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:48 INFO - 2015-12-11 11:44:48,800 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:44:50 INFO - 2015-12-11 11:44:50,093 INFO : Browser initialized. 11:44:50 INFO - 2015-12-11 11:44:50,093 INFO : Running cycle 1/1 for dromaeo_css test... 11:44:50 INFO - 2015-12-11 11:44:50,094 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnNirsH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:45:02 INFO - 2015-12-11 11:45:02,078 DEBUG : BROWSER_OUTPUT: RSS: Main: 141533184 11:45:02 INFO - 2015-12-11 11:45:02,079 DEBUG : BROWSER_OUTPUT: 11:45:53 INFO - 2015-12-11 11:45:53,252 DEBUG : BROWSER_OUTPUT: 1449863153248 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:48:05 INFO - 2015-12-11 11:48:05,630 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43858/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43858/tests/dromaeo/cssquery-ext.html) 11:48:06 INFO - 2015-12-11 11:48:06,727 DEBUG : BROWSER_OUTPUT: RSS: Main: 254611456 11:48:06 INFO - 2015-12-11 11:48:06,727 DEBUG : BROWSER_OUTPUT: 11:51:09 INFO - 2015-12-11 11:51:09,269 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43858/tests/dromaeo/cssquery-ext.html (next: http://localhost:43858/tests/dromaeo/cssquery-jquery.html) 11:51:09 INFO - 2015-12-11 11:51:09,842 DEBUG : BROWSER_OUTPUT: RSS: Main: 229515264 11:51:09 INFO - 2015-12-11 11:51:09,843 DEBUG : BROWSER_OUTPUT: 11:54:11 INFO - 2015-12-11 11:54:11,920 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43858/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43858/tests/dromaeo/cssquery-mootools.html) 11:54:12 INFO - 2015-12-11 11:54:12,495 DEBUG : BROWSER_OUTPUT: RSS: Main: 224571392 11:54:12 INFO - 2015-12-11 11:54:12,495 DEBUG : BROWSER_OUTPUT: 11:57:14 INFO - 2015-12-11 11:57:14,526 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43858/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43858/tests/dromaeo/cssquery-prototype.html) 11:57:15 INFO - 2015-12-11 11:57:15,107 DEBUG : BROWSER_OUTPUT: RSS: Main: 208277504 11:57:15 INFO - 2015-12-11 11:57:15,108 DEBUG : BROWSER_OUTPUT: 12:00:17 INFO - 2015-12-11 12:00:17,977 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43858/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43858/tests/dromaeo/cssquery-yui.html) 12:00:18 INFO - 2015-12-11 12:00:18,578 DEBUG : BROWSER_OUTPUT: RSS: Main: 209334272 12:00:18 INFO - 2015-12-11 12:00:18,579 DEBUG : BROWSER_OUTPUT: 12:03:20 INFO - 2015-12-11 12:03:20,840 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43858/tests/dromaeo/cssquery-yui.html (next: http://localhost:43858/tests/dromaeo/cssquery-dojo.html) 12:03:21 INFO - 2015-12-11 12:03:21,090 DEBUG : BROWSER_OUTPUT: RSS: Main: 253665280 12:03:21 INFO - 2015-12-11 12:03:21,090 DEBUG : BROWSER_OUTPUT: 12:03:21 INFO - 2015-12-11 12:03:21,091 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:03:21 INFO - 2015-12-11 12:03:21,091 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:03:21 INFO - 2015-12-11 12:03:21,091 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:03:21 INFO - 2015-12-11 12:03:21,091 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:03:21 INFO - 2015-12-11 12:03:21,092 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2595.6755405574304;2728.277006593252;2728.9590656140163;2741.273562505935;2754.4904192724343;4475.731456112636;4651.9767401163035;4696.2955556666475;4709.128811169931;4720.976395118024;4563.452385713711;4615.215413379725;4652.162610730067;4671.065786842637;4675.976620116895;4319.978400107995;4323.308270676676;4386.078923426092;4417.447819022622;4446.488653804805;4166.270902592049;4347.000189956312;4383.649308055364;4449.354843547683;4466.397036400093;4227.154569086195;4286.61420472159;4307.978460107711;4323.243432399333;4354.499232588261;4313.633341165973;4313.784310784448;4314.352847072964;4324.13517296542;4352.151330490556;4295.205387003414;4299.398084268205;4302.505211900609;4331.7184383015;4341.02326976431;4328.11273688893;4401.075774087413;4433.556644335541;4467.084247729208;4617;5053.216751403502;5073.340465739467;5075.441701412841;5081.491850814926;5132.384113906318;5099.311592934943;5109.080365534202;5112.514311140436;5113.61647876407;5114.156164232897;4577.22187228172;4635.6986795858165;4685.320628508915;4688.296755486705;4713.95286047142;5095.592352611782;5131.820386286537;5134.666246693953;5140.537351638371;5176;4911.115999120121;4927.28554359623;4930.531599498042;4968.30443737877;4970.15507363749;4796.760161991887;4908.435529914034;4910.8281210157475;4922.483139270396;5045.142325804622;4990.625703072212;4998.02538504988;4998.800047998112;4999.250112483157;5042.722650254198;4968.677035992649;4973.47778483254;4976.278439626306;4989.875253118701;5012.1980483122525;4071.185762847442;4158.500979882373;4196.496420429568;4286.035641980592;4299.914001719948;3699.9075023124637;3700.389435743126;3705;3736.4768932349493;3737.8131093445763;4320.006398528356;4320.935185972213;4323.740575565476;4324.718893271927;4361.629261512743;4874.8537543873745;4941.407031156285;4992.051510213048;5006.424261209934;5125.589952803842;4292.871213863589;4304.461942257218;4307.052448461333;4308.246056940023;4324.545922678137;4466.642668586505;4469.5306992765945;4474.440694913136;4476.865694029119;4511.413516242867;4631.675782695246;4634.212183928673;4752.405949256412;4754.144254034169;4758.119747846659;5087.3132127163835;5095.159298715818;5118.488151185001;5122.974385128051;5162.845114646567;4799.832005879777;4803.783829727601;4804.0872234275375;4807.495213002584;4847.878803029953;4769.332293478985;4866.416030076413;4873.147199240189;4875.731834749123;4978.2034874419915;5000.224965130411;5066.898662026665;5074.543291103819;5081.034603425337;5081.593472522115;4915.43472500667;4917.0903382874285;4920.311156438173;4921.3356196912955;4951.10880041596;4708.3643708100335;4790.664653474223;4842.394700662418;4850.054239423279;4945.184044632595;4831.227003679394;4843.6367272454;4845.8061677533915;4845.903081938412;4870.90258194827;4920.6555541111775;4949.331840201527;4950.579200767831;4951.158303088411;4994.675346102492;4583.495815460364;4670.766461676971;4766.07061622994;4768.928466072943;4848.95151048485 12:03:21 INFO - 2015-12-11 12:03:21,092 DEBUG : BROWSER_OUTPUT: |1;ext.html;566.8214512428588;572.2617823008319;575.9948889188365;582.0657844160122;582.1500609110698;26492.470150597;34594.30811383774;35156.12109697259;35260.47109293363;35277.11807204818;39175.21649567007;39659.80170099153;39674.60325396745;39689.603103968955;39729;6960.269171736971;7112.324329188745;7874.094479134901;8055;8058.194180581953;10078.84881726771;10308.793824123513;10323.070923616873;10331.121854642364;10334.793304133913;10025.147862431702;10111.393316401003;10140.290179687425;10169.847452288222;10170.542325595328;7257;7435.925640743578;9948.701538953843;10041.497925103715;10086.798264034715;9907;10058.245631577662;10059.295849290553;10061.748456288578;10071.899281007169;35883;36332.455013174826;36356;36360;36362.27275454476;2860.4565132624734;2888.0613800514916;3190.872365105393;3504.842282097312;3592.8742494012845;27703.168904932885;27850.3037424064;27862.442751145067;28222.294442638893;28224.858875705697;3270.3949769292517;3349.380364632551;3357.4963755436634;3390.3727810355163;3407.2504049109157;211737;212929;213813;214030;214123;51426.228606570934;52516;56443;56806.43193568094;62135;54944.17583736247;55071;55530;55820;55826.72086639541;12693.365331733376;12924.353782310847;12930.159539629894;12938.870611293954;12949.54676586315;9534.904650953402;9674.854877176707;9691.370060946016;9692.22462203022;9700.417974921527;19035.428937131906;19240.4227873164;19243.230270789292;19299.903500482407;19309.710354344697;7613.83005843332;7828.334591559781;7918.722844700408;7978.840423191504;8001.079875814239;797.8882956386111;865.2688478235881;960.6349587156835;969.6170012845027;1025.733309339562;26172;26278.6058209127;26302.736972630413;28015.43969120647;31188.84405578003;899.7345782994032;914.346242436661;921.755734730297;922.5802259971697;977.5356705564942;12521.56174533887;13052.086353955321;13188.142770719873;13211.14127581704;13228.801567976489;318651;322331;324095;324723;326537;45209;45562.54437455583;45607;45644.54355456469;45692;1211.0614273937592;1211.9757604847853;1224.4428784903025;1225.5894275417656;1228.6928267933017;23594.410139746644;23725.458009381353;27761.44477110406;30230.395392091596;30829.383412332078;41973.370399443425;42673.57326426696;42761.786191068844;42784.57215427806;42868;222223;255419;256914;257552;258251;23288;27135.72864271332;27311.726882731713;27392.726072739813;27402;34551.65448345484;34990.30019399649;35305.64694353126;36001.81999089988;36165.09587260339;30382.54426183653;30477.847610761804;37497.4375384364;38798.41802373023;38842.805785970886;32469.675303246666;32973.34053318968;33053;33098.338033239685;33209.83395083009;32245;33027;33266;33330.333393331515;33451.330973380886;27859.547093150824;29855;30062.398752025274;30097.548536772403;30143.849280753457;23271.53456930818;23417.648735268645;23694;23776.16783412572;23783.762162378156 12:03:21 INFO - 2015-12-11 12:03:21,095 DEBUG : BROWSER_OUTPUT: |2;jquery.html;332.4514550990865;334.60349485859257;335.625777258357;337.1806510180262;338.56325340311;12739.745205095893;13096.148750331246;14664.12015279084;15196.31616577254;16186.190690465488;9816.509174541263;10022.749431264223;10029.197664186866;16032.198390080508;16253.83746162538;4614.976925115378;4740.525947405249;4742.312364707115;4744.786484608184;4760.928586071212;3188.3463889902514;3243.6431992480807;5104.489551044884;5266.762995665185;5276.604254680895;5215.322008138936;5221.347331583552;5222.086134926391;5223.399309079467;5250.579953603703;4967.850964471072;5102.183650615883;5112.41207261166;5112.872178195556;5200.973995130019;4931.334269873557;4931.58081563064;4932.506749325074;4933.531314525115;4934.925976110361;11348.319100853892;11730;11731.120165987584;11735.119866010084;11743.882561174365;1775.1922875091802;1791.3640657566636;1797.5416268851359;1805.124514610413;1874.8500119990367;8726.738197854074;9125.680601178994;10635.361878287327;12257.570985015482;12469.812952805625;1523.8019057522563;1733.54927718794;1796.9011704356255;1806.5664240582298;1808.620189760152;54795;57305.71347143279;57772.13341799876;57970.71014644942;58136.70931645315;10034.297599168134;10041.899581004243;10074.345167564084;10081.294309398272;10084.445355505371;12704.42830072649;12712.809307860389;12717.491300348067;12728;12739.745205095845;6777.152855893013;6793.728250870009;6801.591904485746;6838.829029274308;6876;6377.202849643794;6393.264774550893;6424.164858568356;6443.935560644333;6444.226692796894;4209.158168366339;4210.7473551587;4213.53651098385;4268.466441694788;4273.850415235452;1609.1712767924528;1659.3279721712727;1661.7673525706412;1699.7960244770707;1713.5373449168655;768.3161985832613;774.8217909880759;809.5426084262373;816.4978538198965;827.1769589258726;14897.329620167118;15089.24553772307;16242.918785406233;16523.256453459384;16658.08380539058;782.6791015683542;801.6913488307043;817.1664901800249;819.848328059299;821.6507984106851;6234.657093859791;8902.643894244287;8979;9065.274778017743;9187.402818816889;478448;485097;495686;495787;509047;70316;71567;71730;71751.28248717447;72120.63939680268;1008.2438171371472;1021.6832781837654;1021.7190272675074;1032.9018743219383;1079.0666073846066;13877.722445551235;13919.304034798422;14229.573112806218;14304.785428218376;14676.119432834064;30013.549796752628;30382.696173037988;30813;31875.36249275048;31940.36119277648;40132.59867401405;40831.38752918768;43364;43438.56561434345;44131.55868441275;8817.603207855534;8966.103389661243;8967.551622418723;8988.86516702237;9002.50486223264;13240.742129497683;15576.92211538935;16384.590385239986;16391.42630007944;16543.751843722595;13185.208887466782;13274.07081504324;13391.866081339062;13589.184648921097;13866.861331386557;13000.804987925;13036;13293.335333233494;13564;13678.110922790385;10996.835047474455;11200.551977920792;12659.113862029937;12718.745625087631;12963.870361296265;8272.131426200403;8291.295239904675;8310.168983101641;8342.749717508485;8786.341024423065;12608.810867837174;12637;12728.23630582168;12751.681207969876;12988.480460781462 12:03:21 INFO - 2015-12-11 12:03:21,097 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1417.603071140081;1647.884648074635;1673.7071012572796;1713.1263055841525;1731.169038861347;5952.851178720534;6669.699863506142;6787.7963661090125;6804.693788779505;6835.248122706498;6366.713497892594;6586.308437614053;6586.37429444202;6588.505862060352;6593.274739778621;1732.5668582854287;1770.7078332075191;2035.7557093148844;2056.557840064386;2097.129691178159;2038.8063134002246;2042.1831267492973;2044.090379780998;2044.867083639566;2046.9692954605694;2010.0954570443287;2028.5739994601151;2042.4485388944977;2044.5093177637334;2048.8770673759545;1996.3212507747292;2031.8171364577186;2049.5695903860205;2051.507638166837;2070.2960993262363;2077.6883467479847;2124.033564728045;2124.182189856916;2125.4048866317457;2125.883076430796;6899.827504312382;6972.267911869282;6972.546784458994;6977.406920411771;6981.79054628362;4055.047063939972;4131.8967025824295;4147.253494371012;4151.501819781615;4157.438745769343;2645.061003343824;2719.360950176707;2733.2916926920675;2741.6572928383953;2760.8205466644604;785.654312102673;791.2917938445117;815.1685281013392;820.1839170025803;853.9444936079135;9160.267178625694;9280.303977201736;9333.859992100124;9342.065793420672;9343.439393636336;3827.5789663137034;3901.395283731026;3938.8424463021734;3939.5863434339553;3940.960590394059;8170.060443049126;8172.264496195371;8179.4274400792565;8182.713605023796;8194.262516373556;4205.537390887;4207.116505533872;4214.557471465513;4217.304144816132;4217.768022758778;3723.9255214896093;3738.6448287412654;3746.138388170736;3759.4172903200047;3764.284785890672;3012.6384833819643;3051.92370190747;3275.950860737091;3353.6311005789344;3423.3495635829113;1039.8284283093205;1088.5482524752297;1089.6622047165404;1092.208149091902;1094.037247222455;864.6887120636566;886.9201771840566;909.1499448016126;1147.6384938744268;1149.93675347855;6481.384268494486;6483.7082331295205;6527.836804079841;6533.314002029719;6554.213494380705;550.2489102375309;551.1732401397903;561.6742289472096;578.6990764802364;715.8725008112244;5202.115640341151;5255.054090263713;5269.499397557226;5277.023750606073;5288.391834938954;8117.715879944291;8539.74380768578;8562.486250824846;8577.614007369682;8591.226789588967;8344.499330040095;8408.78978025542;8416.747497575083;8417.410781245377;8431.451955622864;6266.154069200691;6467.870642587216;6516.446102081281;6554.606723596599;6664.466842652576;6529.118568993315;6531.444827189742;6564.737410503526;6625.039369291522;6634.4029037384935;6913.619750913748;7350.77947661571;7355.264473552816;7378.815529611588;7427.702891884264;7431.628418579157;7567.31894129531;7660.387169026353;7683.231676832495;7776.572288524186;6152.969235153795;6192.659403732838;6226.906596400967;6230.563860529719;6271.027990661455;5636.1545768133465;5783.334916484489;6457.483401327789;6501.544891857525;6689.832754181184;6201;6258.906116408167;6285.057241413824;6351.809445716636;6438.710258038306;6018.608790428783;6142.416470435302;6168.35232300602;6288.402601752826;6300.968495157678;6299.716512756845;6359.618422894641;6382.042693595998;6408.295087540274;6412.743490260337;5940.584159108821;5948.702564871825;5987.820365389045;5993.910091348721;6003.849903752441;5888.440598143169;5953.6725480097275;5985.371535988658;6002.039673652194;6009.36901625323 12:03:21 INFO - 2015-12-11 12:03:21,097 DEBUG : BROWSER_OUTPUT: |4;prototype.html;301.73748838510494;307.09866541700114;309.5063373918599;313.4890129089585;315.3503782208649;5291.6824990500545;5320.866978325539;5329.600279978998;5351.919721204175;5361.946380536194;5283.788648454057;5291.497307755757;5292.841214763554;5294.947050529494;5307.973460132704;4149.6887733420035;4162.8959276018195;4166.958330416703;4168.874933751992;4173.749575025493;3904.2386734586767;4028.436018957348;4167.729097608646;4180.916381672365;4181.226473102471;3624.8912532624063;3891.3384724596744;3946.703997200207;3990.3216453203027;4005.3391190453685;3993.8602148924792;3995.8002099895034;4078.530968938551;4091.85678501251;4094.529129150126;3435.587729472454;3578.3380074686265;3608.0799396154075;3637.2543628556346;3643;4945.9258111128365;5020;5067.138586440277;5150.9742451287875;5152.716600586966;4709.693869898446;4720.409948756405;4721.693089949143;4732.574068333866;4734.810607575693;5583.190437386556;5616.466435688644;5617.494425501724;5622.409646987089;5624.831255062355;3890.5604926177493;3891.299566078105;3892.591277915835;3896.240233154536;3897.2984862724697;5773.162891380768;5822.650640961513;5909.054551271819;5922.437368449991;5932.495737862244;4024.0945787197647;4025.657819085352;4028.053407449247;4029.6373326400767;4032.7177097602885;3773.019015056105;4078.408630748525;4081.0817566047995;4085.9795701021303;4087.2234275487563;4459.974205932654;4519.231730605739;4648.9307459284555;4651.511591282867;4653.046125544255;5565.638233514808;5588.580856435784;5592.217089607459;5594.104943209067;5607.663540187602;1413.2156653057446;1428.8928330375263;1428.9857101428852;1430.2777097565663;1431.405966523881;958.1999030809213;961.927855410833;963.3978763272954;984.2077127911956;985.5614251657944;4922.261660750916;4924.72913989734;4938.728369939616;4942.357493525818;4942.481039490874;5805.042168042226;5838.2702162229725;5839.153322768175;5852.94147058524;5857.15071314657;4878.56092951636;4904.60763138948;4927.989762098761;4928.827491037797;4930.038642464757;3050.42042012017;3104.348086901776;3115.4236466253815;3133.3576616793503;3141.858616362269;5490.505854473116;5491.341039075257;5500.3949565547755;5500.944990550123;5505.03661859173;6001.5798894077;6007.699615019319;6013;6021.367756385516;6021.60859544137;5462.262594549685;5494.780208791603;5508.338999320107;5513.283273174462;5514.779408823602;5666;5785.392533783892;5835.854103647443;5840.853978650568;5850.912236316373;5663.093904975184;5670.432956704297;5680.630759000652;5685.403032681509;5686.061799802987;5473.917891231555;5491.395946445968;5493.148561972901;5494.972525137348;5496.80761173357;3895;4033.334499807499;4038.7172897896867;4040.6565441937764;4053.878383648377;5545.085060964896;5740.971295143498;5783.161441590862;5839.503642190291;5841.18223448709;5466.644668096561;5543.501084902378;5545.698535107885;5552.083906155439;5555;5611;5630.3525094613005;5640.210370548045;5650.29371328584;5652.039153343859;5399.568034557305;5500.449955004628;5506.889862202814;5510.228568000403;5518.365387980433;5666.490015898589;5671.319441667027;5684.516816070681;5687.090065589486;5689.951617417809;5533.557315414838;5537.446255374431;5544.7782088716;5550.833474995757;5554.222408862844 12:03:21 INFO - 2015-12-11 12:03:21,098 DEBUG : BROWSER_OUTPUT: |5;yui.html;658.9308122647122;662.3641304347826;688.6453476459624;751.1737089201882;759.6543572674434;11163.274387164829;11303.491342889569;11331.943340283296;11366.60216892409;12999.285039322856;13060.542880999166;13098.14862033967;13127.146735462213;13160.736785264313;13216.93391533041;637.1621317966859;641.1024565608162;808.2483290539795;808.4502538273971;808.6926967752246;788.3456730913357;795.1650766694976;795.8010497375656;796.0328201235498;814.722994181981;667.199360767079;829.4442723375323;829.85062688716;831.2394159344193;848.5629900601195;656.9441597464221;661.9702113404884;667.0494545272991;836.0302049622409;842.4397775479299;613.5827637206697;614.2659521871366;614.6865098799644;625.1810128731377;634.0077778276982;11733.4719937603;11813.940930295294;11821.408929553574;11822.113341499422;11908.940455297754;10630.946845265802;10842.349459032483;10878.456077196108;10940.343579385262;11403.657890263305;8759.2992560595;9408.43549387039;9504.667336643253;9654.131128198496;9695.70912872615;3105.0374383941053;3136.498160294342;3137.1529686984613;3139.372125574894;3180.0459862041525;39558.20883582312;39692.801535992425;39780.20439591221;39963.20073598541;40062.599374006175;8501;8663.176998185289;8756.8686469703;9014.323925705598;9133.49765762876;14699.412023519153;14706.33821478036;14708.779368309484;14725.337359818834;14730.55808325752;5955.67243801595;6213.720382582795;6223.097650840603;6256.874862502725;6416.903746443807;3543.8936831895085;3656.780593164419;3669.2478042001326;3675.6767563677054;3682.1346983458866;2621.685397752282;2638.934026649349;2640.828346157532;2643.2863126955613;2649.3509090273005;429.9054208074219;432.80740070668253;434.27476114888213;437.84190815294005;445.8172149418723;440.23399285244085;514.26460161968;514.4289838279507;515.5823782735996;521.0201235305823;7178.641067946582;7179.784606461814;7199.604021778748;7209.783706488814;7413.8146546336775;463.6522608043967;530.6921985248547;534.8208350202648;550.6090675620354;557.6542543622979;3472.8610855566;3481.89554313371;3580.7493475456467;3582.5880023797076;3685.0603096210293;48083.27875081877;49146.50853491491;49204.50795492071;49300;49759.751201243766;44447.33329000068;44540.77729611396;44971.77514112408;45435.77282113568;46577.30134047992;38605.806970964964;38958.415623765664;39918.60081399207;42552.78723606424;42682.57317426848;7958.562279074707;8031.237032481905;8138.633761480866;8311.625976831177;8423.4945903246;30785.230369240948;31082.689173108884;31498.370032598763;31539.21151971219;32002.19994500063;35032.64967350396;35245.82377088098;37456;39062.609373907035;39295.607043929194;10045.799084018132;10366.170706343324;10769.461526923778;10795.460226988462;11048.668539943814;10964.451777411257;11089.944550277198;11129;11215.271007384494;11310.717232069264;10160.898391016291;10261.640842570772;10343;10532.210084243865;10780.245382823126;9989.450580217866;10098.747531311776;10141.391516509033;10175.847362289423;10384.740381490523;9368.906310936803;9383.859242111237;9400.200982916529;9488.95255523718;9495.335326527076;8659.956700216459;8673.739787806377;9284.350095493252;9397.530123493934;9536.174785100331;8862.822743545223;9122.498262595622;9312.255019598551;9345.132390206949;9574.617015319309 12:03:21 INFO - 2015-12-11 12:03:21,098 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:03:21 INFO - 2015-12-11 12:03:21,098 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:03:21 INFO - 2015-12-11 12:03:21,099 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,925 12:03:21 INFO - 2015-12-11 12:03:21,099 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:03:21 INFO - 2015-12-11 12:03:21,099 DEBUG : BROWSER_OUTPUT: __startTimestamp1449864201087__endTimestamp 12:03:21 INFO - 2015-12-11 12:03:21,099 DEBUG : BROWSER_OUTPUT: 12:03:21 INFO - 2015-12-11 12:03:21,099 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:03:21 INFO - 2015-12-11 12:03:21,099 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:03:21 INFO - 2015-12-11 12:03:21,099 DEBUG : BROWSER_OUTPUT: 12:03:21 INFO - 2015-12-11 12:03:21,099 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4631.37 Median:4758.12 stddev:480.02 (10.1%) stddev-sans-first:454.15 12:03:21 INFO - 2015-12-11 12:03:21,100 DEBUG : BROWSER_OUTPUT: Values: 2595.7 2728.3 2729.0 2741.3 2754.5 4475.7 4652.0 4696.3 4709.1 4721.0 4563.5 4615.2 4652.2 4671.1 4676.0 4320.0 4323.3 4386.1 4417.4 4446.5 4166.3 4347.0 4383.6 4449.4 4466.4 4227.2 4286.6 4308.0 4323.2 4354.5 4313.6 4313.8 4314.4 4324.1 4352.2 4295.2 4299.4 4302.5 4331.7 4341.0 4328.1 4401.1 4433.6 4467.1 4617.0 5053.2 5073.3 5075.4 5081.5 5132.4 5099.3 5109.1 5112.5 5113.6 5114.2 4577.2 4635.7 4685.3 4688.3 4714.0 5095.6 5131.8 5134.7 5140.5 5176.0 4911.1 4927.3 4930.5 4968.3 4970.2 4796.8 4908.4 4910.8 4922.5 5045.1 4990.6 4998.0 4998.8 4999.3 5042.7 4968.7 4973.5 4976.3 4989.9 5012.2 4071.2 4158.5 4196.5 4286.0 4299.9 3699.9 3700.4 3705.0 3736.5 3737.8 4320.0 4320.9 4323.7 4324.7 4361.6 4874.9 4941.4 4992.1 5006.4 5125.6 4292.9 4304.5 4307.1 4308.2 4324.5 4466.6 4469.5 4474.4 4476.9 4511.4 4631.7 4634.2 4752.4 4754.1 4758.1 5087.3 5095.2 5118.5 5123.0 5162.8 4799.8 4803.8 4804.1 4807.5 4847.9 4769.3 4866.4 4873.1 4875.7 4978.2 5000.2 5066.9 5074.5 5081.0 5081.6 4915.4 4917.1 4920.3 4921.3 4951.1 4708.4 4790.7 4842.4 4850.1 4945.2 4831.2 4843.6 4845.8 4845.9 4870.9 4920.7 4949.3 4950.6 4951.2 4994.7 4583.5 4670.8 4766.1 4768.9 4849.0 12:03:21 INFO - 2015-12-11 12:03:21,100 DEBUG : BROWSER_OUTPUT: 12:03:21 INFO - 2015-12-11 12:03:21,100 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42064.71 Median:18121.87 stddev:69638.78 (384.3%) stddev-sans-first:69764.43 12:03:21 INFO - 2015-12-11 12:03:21,101 DEBUG : BROWSER_OUTPUT: Values: 566.8 572.3 576.0 582.1 582.2 26492.5 34594.3 35156.1 35260.5 35277.1 39175.2 39659.8 39674.6 39689.6 39729.0 6960.3 7112.3 7874.1 8055.0 8058.2 10078.8 10308.8 10323.1 10331.1 10334.8 10025.1 10111.4 10140.3 10169.8 10170.5 7257.0 7435.9 9948.7 10041.5 10086.8 9907.0 10058.2 10059.3 10061.7 10071.9 35883.0 36332.5 36356.0 36360.0 36362.3 2860.5 2888.1 3190.9 3504.8 3592.9 27703.2 27850.3 27862.4 28222.3 28224.9 3270.4 3349.4 3357.5 3390.4 3407.3 211737.0 212929.0 213813.0 214030.0 214123.0 51426.2 52516.0 56443.0 56806.4 62135.0 54944.2 55071.0 55530.0 55820.0 55826.7 12693.4 12924.4 12930.2 12938.9 12949.5 9534.9 9674.9 9691.4 9692.2 9700.4 19035.4 19240.4 19243.2 19299.9 19309.7 7613.8 7828.3 7918.7 7978.8 8001.1 797.9 865.3 960.6 969.6 1025.7 26172.0 26278.6 26302.7 28015.4 31188.8 899.7 914.3 921.8 922.6 977.5 12521.6 13052.1 13188.1 13211.1 13228.8 318651.0 322331.0 324095.0 324723.0 326537.0 45209.0 45562.5 45607.0 45644.5 45692.0 1211.1 1212.0 1224.4 1225.6 1228.7 23594.4 23725.5 27761.4 30230.4 30829.4 41973.4 42673.6 42761.8 42784.6 42868.0 222223.0 255419.0 256914.0 257552.0 258251.0 23288.0 27135.7 27311.7 27392.7 27402.0 34551.7 34990.3 35305.6 36001.8 36165.1 30382.5 30477.8 37497.4 38798.4 38842.8 32469.7 32973.3 33053.0 33098.3 33209.8 32245.0 33027.0 33266.0 33330.3 33451.3 27859.5 29855.0 30062.4 30097.5 30143.8 23271.5 23417.6 23694.0 23776.2 23783.8 12:03:21 INFO - 2015-12-11 12:03:21,101 DEBUG : BROWSER_OUTPUT: 12:03:21 INFO - 2015-12-11 12:03:21,101 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26110.98 Median:335.11 stddev:80551.87 (24037.1%) stddev-sans-first:80754.58 12:03:21 INFO - 2015-12-11 12:03:21,101 DEBUG : BROWSER_OUTPUT: Values: 332.5 334.6 335.6 337.2 338.6 12739.7 13096.1 14664.1 15196.3 16186.2 9816.5 10022.7 10029.2 16032.2 16253.8 4615.0 4740.5 4742.3 4744.8 4760.9 3188.3 3243.6 5104.5 5266.8 5276.6 5215.3 5221.3 5222.1 5223.4 5250.6 4967.9 5102.2 5112.4 5112.9 5201.0 4931.3 4931.6 4932.5 4933.5 4934.9 11348.3 11730.0 11731.1 11735.1 11743.9 1775.2 1791.4 1797.5 1805.1 1874.9 8726.7 9125.7 10635.4 12257.6 12469.8 1523.8 1733.5 1796.9 1806.6 1808.6 54795.0 57305.7 57772.1 57970.7 58136.7 10034.3 10041.9 10074.3 10081.3 10084.4 12704.4 12712.8 12717.5 12728.0 12739.7 6777.2 6793.7 6801.6 6838.8 6876.0 6377.2 6393.3 6424.2 6443.9 6444.2 4209.2 4210.7 4213.5 4268.5 4273.9 1609.2 1659.3 1661.8 1699.8 1713.5 768.3 774.8 809.5 816.5 827.2 14897.3 15089.2 16242.9 16523.3 16658.1 782.7 801.7 817.2 819.8 821.7 6234.7 8902.6 8979.0 9065.3 9187.4 478448.0 485097.0 495686.0 495787.0 509047.0 70316.0 71567.0 71730.0 71751.3 72120.6 1008.2 1021.7 1021.7 1032.9 1079.1 13877.7 13919.3 14229.6 14304.8 14676.1 30013.5 30382.7 30813.0 31875.4 31940.4 40132.6 40831.4 43364.0 43438.6 44131.6 8817.6 8966.1 8967.6 8988.9 9002.5 13240.7 15576.9 16384.6 16391.4 16543.8 13185.2 13274.1 13391.9 13589.2 13866.9 13000.8 13036.0 13293.3 13564.0 13678.1 10996.8 11200.6 12659.1 12718.7 12963.9 8272.1 8291.3 8310.2 8342.7 8786.3 12608.8 12637.0 12728.2 12751.7 12988.5 12:03:21 INFO - 2015-12-11 12:03:21,102 DEBUG : BROWSER_OUTPUT: 12:03:21 INFO - 2015-12-11 12:03:21,102 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4852.34 Median:6147.69 stddev:2512.39 (40.9%) stddev-sans-first:2506.18 12:03:21 INFO - 2015-12-11 12:03:21,102 DEBUG : BROWSER_OUTPUT: Values: 1417.6 1647.9 1673.7 1713.1 1731.2 5952.9 6669.7 6787.8 6804.7 6835.2 6366.7 6586.3 6586.4 6588.5 6593.3 1732.6 1770.7 2035.8 2056.6 2097.1 2038.8 2042.2 2044.1 2044.9 2047.0 2010.1 2028.6 2042.4 2044.5 2048.9 1996.3 2031.8 2049.6 2051.5 2070.3 2077.7 2124.0 2124.2 2125.4 2125.9 6899.8 6972.3 6972.5 6977.4 6981.8 4055.0 4131.9 4147.3 4151.5 4157.4 2645.1 2719.4 2733.3 2741.7 2760.8 785.7 791.3 815.2 820.2 853.9 9160.3 9280.3 9333.9 9342.1 9343.4 3827.6 3901.4 3938.8 3939.6 3941.0 8170.1 8172.3 8179.4 8182.7 8194.3 4205.5 4207.1 4214.6 4217.3 4217.8 3723.9 3738.6 3746.1 3759.4 3764.3 3012.6 3051.9 3276.0 3353.6 3423.3 1039.8 1088.5 1089.7 1092.2 1094.0 864.7 886.9 909.1 1147.6 1149.9 6481.4 6483.7 6527.8 6533.3 6554.2 550.2 551.2 561.7 578.7 715.9 5202.1 5255.1 5269.5 5277.0 5288.4 8117.7 8539.7 8562.5 8577.6 8591.2 8344.5 8408.8 8416.7 8417.4 8431.5 6266.2 6467.9 6516.4 6554.6 6664.5 6529.1 6531.4 6564.7 6625.0 6634.4 6913.6 7350.8 7355.3 7378.8 7427.7 7431.6 7567.3 7660.4 7683.2 7776.6 6153.0 6192.7 6226.9 6230.6 6271.0 5636.2 5783.3 6457.5 6501.5 6689.8 6201.0 6258.9 6285.1 6351.8 6438.7 6018.6 6142.4 6168.4 6288.4 6301.0 6299.7 6359.6 6382.0 6408.3 6412.7 5940.6 5948.7 5987.8 5993.9 6003.8 5888.4 5953.7 5985.4 6002.0 6009.4 12:03:21 INFO - 2015-12-11 12:03:21,102 DEBUG : BROWSER_OUTPUT: 12:03:21 INFO - 2015-12-11 12:03:21,102 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4636.61 Median:5314.42 stddev:1372.56 (25.8%) stddev-sans-first:1337.29 12:03:21 INFO - 2015-12-11 12:03:21,103 DEBUG : BROWSER_OUTPUT: Values: 301.7 307.1 309.5 313.5 315.4 5291.7 5320.9 5329.6 5351.9 5361.9 5283.8 5291.5 5292.8 5294.9 5308.0 4149.7 4162.9 4167.0 4168.9 4173.7 3904.2 4028.4 4167.7 4180.9 4181.2 3624.9 3891.3 3946.7 3990.3 4005.3 3993.9 3995.8 4078.5 4091.9 4094.5 3435.6 3578.3 3608.1 3637.3 3643.0 4945.9 5020.0 5067.1 5151.0 5152.7 4709.7 4720.4 4721.7 4732.6 4734.8 5583.2 5616.5 5617.5 5622.4 5624.8 3890.6 3891.3 3892.6 3896.2 3897.3 5773.2 5822.7 5909.1 5922.4 5932.5 4024.1 4025.7 4028.1 4029.6 4032.7 3773.0 4078.4 4081.1 4086.0 4087.2 4460.0 4519.2 4648.9 4651.5 4653.0 5565.6 5588.6 5592.2 5594.1 5607.7 1413.2 1428.9 1429.0 1430.3 1431.4 958.2 961.9 963.4 984.2 985.6 4922.3 4924.7 4938.7 4942.4 4942.5 5805.0 5838.3 5839.2 5852.9 5857.2 4878.6 4904.6 4928.0 4928.8 4930.0 3050.4 3104.3 3115.4 3133.4 3141.9 5490.5 5491.3 5500.4 5500.9 5505.0 6001.6 6007.7 6013.0 6021.4 6021.6 5462.3 5494.8 5508.3 5513.3 5514.8 5666.0 5785.4 5835.9 5840.9 5850.9 5663.1 5670.4 5680.6 5685.4 5686.1 5473.9 5491.4 5493.1 5495.0 5496.8 3895.0 4033.3 4038.7 4040.7 4053.9 5545.1 5741.0 5783.2 5839.5 5841.2 5466.6 5543.5 5545.7 5552.1 5555.0 5611.0 5630.4 5640.2 5650.3 5652.0 5399.6 5500.4 5506.9 5510.2 5518.4 5666.5 5671.3 5684.5 5687.1 5690.0 5533.6 5537.4 5544.8 5550.8 5554.2 12:03:21 INFO - 2015-12-11 12:03:21,104 DEBUG : BROWSER_OUTPUT: 12:03:21 INFO - 2015-12-11 12:03:21,104 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12063.24 Median:22493.30 stddev:13661.71 (60.7%) stddev-sans-first:13673.19 12:03:21 INFO - 2015-12-11 12:03:21,104 DEBUG : BROWSER_OUTPUT: Values: 658.9 662.4 688.6 751.2 759.7 11163.3 11303.5 11331.9 11366.6 12999.3 13060.5 13098.1 13127.1 13160.7 13216.9 637.2 641.1 808.2 808.5 808.7 788.3 795.2 795.8 796.0 814.7 667.2 829.4 829.9 831.2 848.6 656.9 662.0 667.0 836.0 842.4 613.6 614.3 614.7 625.2 634.0 11733.5 11813.9 11821.4 11822.1 11908.9 10630.9 10842.3 10878.5 10940.3 11403.7 8759.3 9408.4 9504.7 9654.1 9695.7 3105.0 3136.5 3137.2 3139.4 3180.0 39558.2 39692.8 39780.2 39963.2 40062.6 8501.0 8663.2 8756.9 9014.3 9133.5 14699.4 14706.3 14708.8 14725.3 14730.6 5955.7 6213.7 6223.1 6256.9 6416.9 3543.9 3656.8 3669.2 3675.7 3682.1 2621.7 2638.9 2640.8 2643.3 2649.4 429.9 432.8 434.3 437.8 445.8 440.2 514.3 514.4 515.6 521.0 7178.6 7179.8 7199.6 7209.8 7413.8 463.7 530.7 534.8 550.6 557.7 3472.9 3481.9 3580.7 3582.6 3685.1 48083.3 49146.5 49204.5 49300.0 49759.8 44447.3 44540.8 44971.8 45435.8 46577.3 38605.8 38958.4 39918.6 42552.8 42682.6 7958.6 8031.2 8138.6 8311.6 8423.5 30785.2 31082.7 31498.4 31539.2 32002.2 35032.6 35245.8 37456.0 39062.6 39295.6 10045.8 10366.2 10769.5 10795.5 11048.7 10964.5 11089.9 11129.0 11215.3 11310.7 10160.9 10261.6 10343.0 10532.2 10780.2 9989.5 10098.7 10141.4 10175.8 10384.7 9368.9 9383.9 9400.2 9489.0 9495.3 8660.0 8673.7 9284.4 9397.5 9536.2 8862.8 9122.5 9312.3 9345.1 9574.6 12:03:21 INFO - 2015-12-11 12:03:21,104 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:03:21 INFO - 2015-12-11 12:03:21,104 DEBUG : BROWSER_OUTPUT: 12:03:21 INFO - 2015-12-11 12:03:21,876 INFO : Browser exited with error code: 0 12:03:21 INFO - 2015-12-11 12:03:21,894 INFO : Completed test dromaeo_css (00:18:38) 12:03:21 INFO - 2015-12-11 12:03:21,895 INFO : Starting test kraken 12:03:21 INFO - 2015-12-11 12:03:21,895 DEBUG : operating with platform_type : linux_ 12:03:21 INFO - 2015-12-11 12:03:21,895 INFO : Initialising browser for kraken test... 12:03:21 INFO - 2015-12-11 12:03:21,901 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLX8L95/profile http://localhost:43858/getInfo.html 12:03:26 INFO - 2015-12-11 12:03:26,588 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:03:26 INFO - 2015-12-11 12:03:26,589 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:03:26 INFO - 2015-12-11 12:03:26,589 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:03:26 INFO - 2015-12-11 12:03:26,589 DEBUG : BROWSER_OUTPUT: __metrics 12:03:26 INFO - 2015-12-11 12:03:26,725 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:26 INFO - 2015-12-11 12:03:26,793 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:03:27 INFO - 2015-12-11 12:03:27,771 INFO : Browser initialized. 12:03:27 INFO - 2015-12-11 12:03:27,772 INFO : Running cycle 1/1 for kraken test... 12:03:27 INFO - 2015-12-11 12:03:27,772 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLX8L95/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:03:39 INFO - 2015-12-11 12:03:39,800 DEBUG : BROWSER_OUTPUT: RSS: Main: 142426112 12:03:39 INFO - 2015-12-11 12:03:39,800 DEBUG : BROWSER_OUTPUT: 12:03:42 INFO - 2015-12-11 12:03:42,387 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43858/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43858/tests/kraken/driver.html?testName=audio-beat-detection) 12:03:42 INFO - 2015-12-11 12:03:42,989 DEBUG : BROWSER_OUTPUT: RSS: Main: 179302400 12:03:42 INFO - 2015-12-11 12:03:42,989 DEBUG : BROWSER_OUTPUT: 12:03:45 INFO - 2015-12-11 12:03:45,717 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43858/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43858/tests/kraken/driver.html?testName=audio-dft) 12:03:46 INFO - 2015-12-11 12:03:46,291 DEBUG : BROWSER_OUTPUT: RSS: Main: 168148992 12:03:46 INFO - 2015-12-11 12:03:46,291 DEBUG : BROWSER_OUTPUT: 12:03:49 INFO - 2015-12-11 12:03:49,284 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43858/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43858/tests/kraken/driver.html?testName=audio-fft) 12:03:49 INFO - 2015-12-11 12:03:49,851 DEBUG : BROWSER_OUTPUT: RSS: Main: 154583040 12:03:49 INFO - 2015-12-11 12:03:49,851 DEBUG : BROWSER_OUTPUT: 12:03:51 INFO - 2015-12-11 12:03:51,903 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43858/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43858/tests/kraken/driver.html?testName=audio-oscillator) 12:03:52 INFO - 2015-12-11 12:03:52,476 DEBUG : BROWSER_OUTPUT: RSS: Main: 155664384 12:03:52 INFO - 2015-12-11 12:03:52,476 DEBUG : BROWSER_OUTPUT: 12:03:54 INFO - 2015-12-11 12:03:54,731 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43858/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43858/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:03:55 INFO - 2015-12-11 12:03:55,292 DEBUG : BROWSER_OUTPUT: RSS: Main: 156688384 12:03:55 INFO - 2015-12-11 12:03:55,292 DEBUG : BROWSER_OUTPUT: 12:03:58 INFO - 2015-12-11 12:03:58,299 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43858/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43858/tests/kraken/driver.html?testName=imaging-darkroom) 12:03:58 INFO - 2015-12-11 12:03:58,881 DEBUG : BROWSER_OUTPUT: RSS: Main: 158859264 12:03:58 INFO - 2015-12-11 12:03:58,881 DEBUG : BROWSER_OUTPUT: 12:04:02 INFO - 2015-12-11 12:04:02,328 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43858/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43858/tests/kraken/driver.html?testName=imaging-desaturate) 12:04:02 INFO - 2015-12-11 12:04:02,901 DEBUG : BROWSER_OUTPUT: RSS: Main: 159735808 12:04:02 INFO - 2015-12-11 12:04:02,901 DEBUG : BROWSER_OUTPUT: 12:04:05 INFO - 2015-12-11 12:04:05,723 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43858/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43858/tests/kraken/driver.html?testName=json-parse-financial) 12:04:06 INFO - 2015-12-11 12:04:06,305 DEBUG : BROWSER_OUTPUT: RSS: Main: 158789632 12:04:06 INFO - 2015-12-11 12:04:06,305 DEBUG : BROWSER_OUTPUT: 12:04:08 INFO - 2015-12-11 12:04:08,096 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43858/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43858/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:04:08 INFO - 2015-12-11 12:04:08,672 DEBUG : BROWSER_OUTPUT: RSS: Main: 165613568 12:04:08 INFO - 2015-12-11 12:04:08,672 DEBUG : BROWSER_OUTPUT: 12:04:10 INFO - 2015-12-11 12:04:10,549 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43858/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43858/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:04:11 INFO - 2015-12-11 12:04:11,143 DEBUG : BROWSER_OUTPUT: RSS: Main: 166588416 12:04:11 INFO - 2015-12-11 12:04:11,143 DEBUG : BROWSER_OUTPUT: 12:04:13 INFO - 2015-12-11 12:04:13,287 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43858/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43858/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:04:13 INFO - 2015-12-11 12:04:13,869 DEBUG : BROWSER_OUTPUT: RSS: Main: 179023872 12:04:13 INFO - 2015-12-11 12:04:13,869 DEBUG : BROWSER_OUTPUT: 12:04:16 INFO - 2015-12-11 12:04:16,409 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43858/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43858/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:04:16 INFO - 2015-12-11 12:04:16,995 DEBUG : BROWSER_OUTPUT: RSS: Main: 184659968 12:04:16 INFO - 2015-12-11 12:04:16,995 DEBUG : BROWSER_OUTPUT: 12:04:19 INFO - 2015-12-11 12:04:19,595 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43858/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43858/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:04:20 INFO - 2015-12-11 12:04:20,168 DEBUG : BROWSER_OUTPUT: RSS: Main: 182558720 12:04:20 INFO - 2015-12-11 12:04:20,168 DEBUG : BROWSER_OUTPUT: 12:04:21 INFO - 2015-12-11 12:04:21,942 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43858/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43858/tests/kraken/driver.html?testName=ai-astar) 12:04:22 INFO - 2015-12-11 12:04:22,192 DEBUG : BROWSER_OUTPUT: RSS: Main: 240041984 12:04:22 INFO - 2015-12-11 12:04:22,192 DEBUG : BROWSER_OUTPUT: 12:04:22 INFO - 2015-12-11 12:04:22,195 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:04:22 INFO - 2015-12-11 12:04:22,196 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:04:22 INFO - 2015-12-11 12:04:22,196 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:04:22 INFO - 2015-12-11 12:04:22,196 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:04:22 INFO - 2015-12-11 12:04:22,196 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;113;106;111;112;111;103;112;112;112 12:04:22 INFO - 2015-12-11 12:04:22,197 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;131;151;170;133;151;157;131;171;137 12:04:22 INFO - 2015-12-11 12:04:22,197 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;162;163;161;161;162;161;162;162 12:04:22 INFO - 2015-12-11 12:04:22,197 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;83;89;72;79;72;100;92;73 12:04:22 INFO - 2015-12-11 12:04:22,197 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;96;135;94;95;95;134;96;94;133 12:04:22 INFO - 2015-12-11 12:04:22,198 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;109;109;109;109;109;110;109 12:04:22 INFO - 2015-12-11 12:04:22,198 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;146;147;147;146;147;146;146;148 12:04:22 INFO - 2015-12-11 12:04:22,198 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;95;95;96;96;95;95;95 12:04:22 INFO - 2015-12-11 12:04:22,198 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;71;73;72;71;71;71;88;71;70 12:04:22 INFO - 2015-12-11 12:04:22,198 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;69;69;68;69;69;69;69;68;68 12:04:22 INFO - 2015-12-11 12:04:22,199 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;84;84;84;84;83;97;83;83;83 12:04:22 INFO - 2015-12-11 12:04:22,199 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;118;124;119;126;120;132;127;119;128;130 12:04:22 INFO - 2015-12-11 12:04:22,199 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;143;150;148;158;136;151;135;147;135 12:04:22 INFO - 2015-12-11 12:04:22,199 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;70;72;69;71;68;72;72;70;70 12:04:22 INFO - 2015-12-11 12:04:22,200 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:04:22 INFO - 2015-12-11 12:04:22,200 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:04:22 INFO - 2015-12-11 12:04:22,200 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1004 12:04:22 INFO - 2015-12-11 12:04:22,200 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:04:22 INFO - 2015-12-11 12:04:22,200 DEBUG : BROWSER_OUTPUT: __startTimestamp1449864262193__endTimestamp 12:04:22 INFO - 2015-12-11 12:04:22,200 DEBUG : BROWSER_OUTPUT: 12:04:22 INFO - 2015-12-11 12:04:22,201 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:04:22 INFO - 2015-12-11 12:04:22,202 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:04:22 INFO - 2015-12-11 12:04:22,202 DEBUG : BROWSER_OUTPUT: 12:04:22 INFO - 2015-12-11 12:04:22,202 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.10 Median:112.00 stddev:3.21 (2.9%) stddev-sans-first:3.38 12:04:22 INFO - 2015-12-11 12:04:22,202 DEBUG : BROWSER_OUTPUT: Values: 109.0 113.0 106.0 111.0 112.0 111.0 103.0 112.0 112.0 112.0 12:04:22 INFO - 2015-12-11 12:04:22,202 DEBUG : BROWSER_OUTPUT: 12:04:22 INFO - 2015-12-11 12:04:22,202 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.60 Median:152.50 stddev:15.16 (9.9%) stddev-sans-first:15.95 12:04:22 INFO - 2015-12-11 12:04:22,202 DEBUG : BROWSER_OUTPUT: Values: 154.0 131.0 151.0 170.0 133.0 151.0 157.0 131.0 171.0 137.0 12:04:22 INFO - 2015-12-11 12:04:22,202 DEBUG : BROWSER_OUTPUT: 12:04:22 INFO - 2015-12-11 12:04:22,203 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 12:04:22 INFO - 2015-12-11 12:04:22,203 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 162.0 163.0 161.0 161.0 162.0 161.0 162.0 162.0 12:04:22 INFO - 2015-12-11 12:04:22,203 DEBUG : BROWSER_OUTPUT: 12:04:22 INFO - 2015-12-11 12:04:22,203 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.40 Median:76.00 stddev:10.21 (13.4%) stddev-sans-first:10.37 12:04:22 INFO - 2015-12-11 12:04:22,203 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 83.0 89.0 72.0 79.0 72.0 100.0 92.0 73.0 12:04:22 INFO - 2015-12-11 12:04:22,203 DEBUG : BROWSER_OUTPUT: 12:04:22 INFO - 2015-12-11 12:04:22,203 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.70 Median:95.00 stddev:18.86 (19.8%) stddev-sans-first:19.52 12:04:22 INFO - 2015-12-11 12:04:22,203 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 135.0 94.0 95.0 95.0 134.0 96.0 94.0 133.0 12:04:22 INFO - 2015-12-11 12:04:22,204 DEBUG : BROWSER_OUTPUT: 12:04:22 INFO - 2015-12-11 12:04:22,204 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 12:04:22 INFO - 2015-12-11 12:04:22,204 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 12:04:22 INFO - 2015-12-11 12:04:22,204 DEBUG : BROWSER_OUTPUT: 12:04:22 INFO - 2015-12-11 12:04:22,204 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 12:04:22 INFO - 2015-12-11 12:04:22,204 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 146.0 147.0 147.0 146.0 147.0 146.0 146.0 148.0 12:04:22 INFO - 2015-12-11 12:04:22,204 DEBUG : BROWSER_OUTPUT: 12:04:22 INFO - 2015-12-11 12:04:22,205 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 12:04:22 INFO - 2015-12-11 12:04:22,205 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 12:04:22 INFO - 2015-12-11 12:04:22,205 DEBUG : BROWSER_OUTPUT: 12:04:22 INFO - 2015-12-11 12:04:22,205 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.00 Median:71.50 stddev:5.33 (7.5%) stddev-sans-first:5.64 12:04:22 INFO - 2015-12-11 12:04:22,205 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 73.0 72.0 71.0 71.0 71.0 88.0 71.0 70.0 12:04:22 INFO - 2015-12-11 12:04:22,205 DEBUG : BROWSER_OUTPUT: 12:04:22 INFO - 2015-12-11 12:04:22,205 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:0.71 (1.0%) stddev-sans-first:0.50 12:04:22 INFO - 2015-12-11 12:04:22,206 DEBUG : BROWSER_OUTPUT: Values: 67.0 69.0 69.0 68.0 69.0 69.0 69.0 69.0 68.0 68.0 12:04:22 INFO - 2015-12-11 12:04:22,206 DEBUG : BROWSER_OUTPUT: 12:04:22 INFO - 2015-12-11 12:04:22,206 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:84.00 stddev:4.45 (5.3%) stddev-sans-first:4.53 12:04:22 INFO - 2015-12-11 12:04:22,206 DEBUG : BROWSER_OUTPUT: Values: 81.0 84.0 84.0 84.0 84.0 83.0 97.0 83.0 83.0 83.0 12:04:22 INFO - 2015-12-11 12:04:22,206 DEBUG : BROWSER_OUTPUT: 12:04:22 INFO - 2015-12-11 12:04:22,206 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.30 Median:126.50 stddev:5.06 (4.0%) stddev-sans-first:4.82 12:04:22 INFO - 2015-12-11 12:04:22,208 DEBUG : BROWSER_OUTPUT: Values: 118.0 124.0 119.0 126.0 120.0 132.0 127.0 119.0 128.0 130.0 12:04:22 INFO - 2015-12-11 12:04:22,208 DEBUG : BROWSER_OUTPUT: 12:04:22 INFO - 2015-12-11 12:04:22,208 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.40 Median:147.50 stddev:7.75 (5.3%) stddev-sans-first:8.12 12:04:22 INFO - 2015-12-11 12:04:22,208 DEBUG : BROWSER_OUTPUT: Values: 141.0 143.0 150.0 148.0 158.0 136.0 151.0 135.0 147.0 135.0 12:04:22 INFO - 2015-12-11 12:04:22,208 DEBUG : BROWSER_OUTPUT: 12:04:22 INFO - 2015-12-11 12:04:22,208 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:71.00 stddev:1.35 (1.9%) stddev-sans-first:1.42 12:04:22 INFO - 2015-12-11 12:04:22,208 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 72.0 69.0 71.0 68.0 72.0 72.0 70.0 70.0 12:04:22 INFO - 2015-12-11 12:04:22,208 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:04:22 INFO - 2015-12-11 12:04:22,208 DEBUG : BROWSER_OUTPUT: 12:04:23 INFO - 2015-12-11 12:04:23,160 INFO : Browser exited with error code: 0 12:04:23 INFO - 2015-12-11 12:04:23,211 INFO : Completed test kraken (00:01:01) 12:04:23 INFO - 2015-12-11 12:04:23,211 INFO : Starting test v8_7 12:04:23 INFO - 2015-12-11 12:04:23,212 DEBUG : operating with platform_type : linux_ 12:04:23 INFO - 2015-12-11 12:04:23,212 INFO : Initialising browser for v8_7 test... 12:04:23 INFO - 2015-12-11 12:04:23,218 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRPfhoy/profile http://localhost:43858/getInfo.html 12:04:27 INFO - 2015-12-11 12:04:27,848 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:04:27 INFO - 2015-12-11 12:04:27,848 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:04:27 INFO - 2015-12-11 12:04:27,848 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:04:27 INFO - 2015-12-11 12:04:27,848 DEBUG : BROWSER_OUTPUT: __metrics 12:04:28 INFO - 2015-12-11 12:04:28,005 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:28 INFO - 2015-12-11 12:04:28,101 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:04:29 INFO - 2015-12-11 12:04:29,337 INFO : Browser initialized. 12:04:29 INFO - 2015-12-11 12:04:29,337 INFO : Running cycle 1/1 for v8_7 test... 12:04:29 INFO - 2015-12-11 12:04:29,337 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRPfhoy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:04:41 INFO - 2015-12-11 12:04:41,334 DEBUG : BROWSER_OUTPUT: RSS: Main: 142725120 12:04:41 INFO - 2015-12-11 12:04:41,334 DEBUG : BROWSER_OUTPUT: 12:05:02 INFO - 2015-12-11 12:05:02,711 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43858/tests/v8_7/run.html (next: http://localhost:43858/tests/v8_7/run.html) 12:05:02 INFO - 2015-12-11 12:05:02,969 DEBUG : BROWSER_OUTPUT: RSS: Main: 441683968 12:05:02 INFO - 2015-12-11 12:05:02,969 DEBUG : BROWSER_OUTPUT: 12:05:02 INFO - 2015-12-11 12:05:02,969 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:05:02 INFO - 2015-12-11 12:05:02,969 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:05:02 INFO - 2015-12-11 12:05:02,969 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:05:02 INFO - 2015-12-11 12:05:02,969 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:05:02 INFO - 2015-12-11 12:05:02,969 DEBUG : BROWSER_OUTPUT: |0;Richards;168.69095816464238 12:05:02 INFO - 2015-12-11 12:05:02,970 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.53236336504384 12:05:02 INFO - 2015-12-11 12:05:02,970 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.97780275358247 12:05:02 INFO - 2015-12-11 12:05:02,970 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5181.347150259067 12:05:02 INFO - 2015-12-11 12:05:02,970 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1980.1980198019803 12:05:02 INFO - 2015-12-11 12:05:02,970 DEBUG : BROWSER_OUTPUT: |5;Earley;801.924619085806 12:05:02 INFO - 2015-12-11 12:05:02,970 DEBUG : BROWSER_OUTPUT: |6;Boyer;11651.162790697674 12:05:02 INFO - 2015-12-11 12:05:02,970 DEBUG : BROWSER_OUTPUT: |7;RegExp;27108.108108108107 12:05:02 INFO - 2015-12-11 12:05:02,971 DEBUG : BROWSER_OUTPUT: |8;Splay;609.3845216331505 12:05:02 INFO - 2015-12-11 12:05:02,971 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4850.241545893719 12:05:02 INFO - 2015-12-11 12:05:02,971 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:05:02 INFO - 2015-12-11 12:05:02,971 DEBUG : BROWSER_OUTPUT: __startTimestamp1449864302963__endTimestamp 12:05:02 INFO - 2015-12-11 12:05:02,971 DEBUG : BROWSER_OUTPUT: 12:05:02 INFO - 2015-12-11 12:05:02,971 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:05:02 INFO - 2015-12-11 12:05:02,971 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:05:02 INFO - 2015-12-11 12:05:02,972 DEBUG : BROWSER_OUTPUT: 12:05:02 INFO - 2015-12-11 12:05:02,972 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.69 Median:168.69 stddev:0.00 (0.0%) 12:05:02 INFO - 2015-12-11 12:05:02,972 DEBUG : BROWSER_OUTPUT: Values: 168.7 12:05:02 INFO - 2015-12-11 12:05:02,972 DEBUG : BROWSER_OUTPUT: 12:05:02 INFO - 2015-12-11 12:05:02,972 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.53 Median:186.53 stddev:0.00 (0.0%) 12:05:02 INFO - 2015-12-11 12:05:02,972 DEBUG : BROWSER_OUTPUT: Values: 186.5 12:05:02 INFO - 2015-12-11 12:05:02,972 DEBUG : BROWSER_OUTPUT: 12:05:02 INFO - 2015-12-11 12:05:02,972 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.98 Median:280.98 stddev:0.00 (0.0%) 12:05:02 INFO - 2015-12-11 12:05:02,973 DEBUG : BROWSER_OUTPUT: Values: 281.0 12:05:02 INFO - 2015-12-11 12:05:02,973 DEBUG : BROWSER_OUTPUT: 12:05:02 INFO - 2015-12-11 12:05:02,973 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 12:05:02 INFO - 2015-12-11 12:05:02,973 DEBUG : BROWSER_OUTPUT: Values: 5181.3 12:05:02 INFO - 2015-12-11 12:05:02,973 DEBUG : BROWSER_OUTPUT: 12:05:02 INFO - 2015-12-11 12:05:02,973 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1980.20 Median:1980.20 stddev:0.00 (0.0%) 12:05:02 INFO - 2015-12-11 12:05:02,973 DEBUG : BROWSER_OUTPUT: Values: 1980.2 12:05:02 INFO - 2015-12-11 12:05:02,974 DEBUG : BROWSER_OUTPUT: 12:05:02 INFO - 2015-12-11 12:05:02,974 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:801.92 Median:801.92 stddev:0.00 (0.0%) 12:05:02 INFO - 2015-12-11 12:05:02,974 DEBUG : BROWSER_OUTPUT: Values: 801.9 12:05:02 INFO - 2015-12-11 12:05:02,974 DEBUG : BROWSER_OUTPUT: 12:05:02 INFO - 2015-12-11 12:05:02,974 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11651.16 Median:11651.16 stddev:0.00 (0.0%) 12:05:02 INFO - 2015-12-11 12:05:02,974 DEBUG : BROWSER_OUTPUT: Values: 11651.2 12:05:02 INFO - 2015-12-11 12:05:02,974 DEBUG : BROWSER_OUTPUT: 12:05:02 INFO - 2015-12-11 12:05:02,975 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27108.11 Median:27108.11 stddev:0.00 (0.0%) 12:05:02 INFO - 2015-12-11 12:05:02,975 DEBUG : BROWSER_OUTPUT: Values: 27108.1 12:05:02 INFO - 2015-12-11 12:05:02,975 DEBUG : BROWSER_OUTPUT: 12:05:02 INFO - 2015-12-11 12:05:02,975 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:609.38 Median:609.38 stddev:0.00 (0.0%) 12:05:02 INFO - 2015-12-11 12:05:02,975 DEBUG : BROWSER_OUTPUT: Values: 609.4 12:05:02 INFO - 2015-12-11 12:05:02,975 DEBUG : BROWSER_OUTPUT: 12:05:02 INFO - 2015-12-11 12:05:02,975 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 12:05:02 INFO - 2015-12-11 12:05:02,975 DEBUG : BROWSER_OUTPUT: Values: 4850.2 12:05:02 INFO - 2015-12-11 12:05:02,976 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:05:02 INFO - 2015-12-11 12:05:02,976 DEBUG : BROWSER_OUTPUT: 12:05:03 INFO - 2015-12-11 12:05:03,948 INFO : Browser exited with error code: 0 12:05:03 INFO - 2015-12-11 12:05:03,963 INFO : Completed test v8_7 (00:00:40) 12:05:04 INFO - 2015-12-11 12:05:04,015 INFO : Completed test suite (00:20:20) 12:05:04 INFO - 2015-12-11 12:05:04,015 DEBUG : Working with test: dromaeo_css 12:05:04 INFO - 2015-12-11 12:05:04,015 DEBUG : Generating results file: dromaeo_css 12:05:04 INFO - 2015-12-11 12:05:04,016 DEBUG : Working with test: kraken 12:05:04 INFO - 2015-12-11 12:05:04,016 DEBUG : Generating results file: kraken 12:05:04 INFO - 2015-12-11 12:05:04,017 INFO : javascript benchmark 12:05:04 INFO - 2015-12-11 12:05:04,017 DEBUG : Working with test: v8_7 12:05:04 INFO - 2015-12-11 12:05:04,017 DEBUG : Generating results file: v8_7 12:05:04 INFO - 2015-12-11 12:05:04,017 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:05:06 INFO - 2015-12-11 12:05:06,446 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 12:05:06 INFO - 2015-12-11 12:05:06,446 DEBUG : process_Request line: dromaeo_css 6225.04 graph.html#tests=[[72,132,35]] 12:05:06 INFO - 2015-12-11 12:05:06,446 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:05:06 INFO - 2015-12-11 12:05:06,566 DEBUG : process_Request line: kraken 1523.80 graph.html#tests=[[232,132,35]] 12:05:06 INFO - 2015-12-11 12:05:06,566 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:05:06 INFO - 2015-12-11 12:05:06,686 DEBUG : process_Request line: v8_7 19779.71 graph.html#tests=[[230,132,35]] 12:05:06 INFO - 2015-12-11 12:05:06,687 INFO : javascript benchmark 12:05:06 INFO - 2015-12-11 12:05:06,691 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2595.6755405574304, 2728.277006593252, 2728.9590656140163, 2741.273562505935, 2754.4904192724343, 4475.731456112636, 4651.9767401163035, 4696.2955556666475, 4709.128811169931, 4720.976395118024, 4563.452385713711, 4615.215413379725, 4652.162610730067, 4671.065786842637, 4675.976620116895, 4319.978400107995, 4323.308270676676, 4386.078923426092, 4417.447819022622, 4446.488653804805, 4166.270902592049, 4347.000189956312, 4383.649308055364, 4449.354843547683, 4466.397036400093, 4227.154569086195, 4286.61420472159, 4307.978460107711, 4323.243432399333, 4354.499232588261, 4313.633341165973, 4313.784310784448, 4314.352847072964, 4324.13517296542, 4352.151330490556, 4295.205387003414, 4299.398084268205, 4302.505211900609, 4331.7184383015, 4341.02326976431, 4328.11273688893, 4401.075774087413, 4433.556644335541, 4467.084247729208, 4617.0, 5053.216751403502, 5073.340465739467, 5075.441701412841, 5081.491850814926, 5132.384113906318, 5099.311592934943, 5109.080365534202, 5112.514311140436, 5113.61647876407, 5114.156164232897, 4577.22187228172, 4635.6986795858165, 4685.320628508915, 4688.296755486705, 4713.95286047142, 5095.592352611782, 5131.820386286537, 5134.666246693953, 5140.537351638371, 5176.0, 4911.115999120121, 4927.28554359623, 4930.531599498042, 4968.30443737877, 4970.15507363749, 4796.760161991887, 4908.435529914034, 4910.8281210157475, 4922.483139270396, 5045.142325804622, 4990.625703072212, 4998.02538504988, 4998.800047998112, 4999.250112483157, 5042.722650254198, 4968.677035992649, 4973.47778483254, 4976.278439626306, 4989.875253118701, 5012.1980483122525, 4071.185762847442, 4158.500979882373, 4196.496420429568, 4286.035641980592, 4299.914001719948, 3699.9075023124637, 3700.389435743126, 3705.0, 3736.4768932349493, 3737.8131093445763, 4320.006398528356, 4320.935185972213, 4323.740575565476, 4324.718893271927, 4361.629261512743, 4874.8537543873745, 4941.407031156285, 4992.051510213048, 5006.424261209934, 5125.589952803842, 4292.871213863589, 4304.461942257218, 4307.052448461333, 4308.246056940023, 4324.545922678137, 4466.642668586505, 4469.5306992765945, 4474.440694913136, 4476.865694029119, 4511.413516242867, 4631.675782695246, 4634.212183928673, 4752.405949256412, 4754.144254034169, 4758.119747846659, 5087.3132127163835, 5095.159298715818, 5118.488151185001, 5122.974385128051, 5162.845114646567, 4799.832005879777, 4803.783829727601, 4804.0872234275375, 4807.495213002584, 4847.878803029953, 4769.332293478985, 4866.416030076413, 4873.147199240189, 4875.731834749123, 4978.2034874419915, 5000.224965130411, 5066.898662026665, 5074.543291103819, 5081.034603425337, 5081.593472522115, 4915.43472500667, 4917.0903382874285, 4920.311156438173, 4921.3356196912955, 4951.10880041596, 4708.3643708100335, 4790.664653474223, 4842.394700662418, 4850.054239423279, 4945.184044632595, 4831.227003679394, 4843.6367272454, 4845.8061677533915, 4845.903081938412, 4870.90258194827, 4920.6555541111775, 4949.331840201527, 4950.579200767831, 4951.158303088411, 4994.675346102492, 4583.495815460364, 4670.766461676971, 4766.07061622994, 4768.928466072943, 4848.95151048485], "unit": "ms", "name": "dojo.html", "value": 4601.924361685491}, {"lowerIsBetter": false, "replicates": [566.8214512428588, 572.2617823008319, 575.9948889188365, 582.0657844160122, 582.1500609110698, 26492.470150597, 34594.30811383774, 35156.12109697259, 35260.47109293363, 35277.11807204818, 39175.21649567007, 39659.80170099153, 39674.60325396745, 39689.603103968955, 39729.0, 6960.269171736971, 7112.324329188745, 7874.094479134901, 8055.0, 8058.194180581953, 10078.84881726771, 10308.793824123513, 10323.070923616873, 10331.121854642364, 10334.793304133913, 10025.147862431702, 10111.393316401003, 10140.290179687425, 10169.847452288222, 10170.542325595328, 7257.0, 7435.925640743578, 9948.701538953843, 10041.497925103715, 10086.798264034715, 9907.0, 10058.245631577662, 10059.295849290553, 10061.748456288578, 10071.899281007169, 35883.0, 36332.455013174826, 36356.0, 36360.0, 36362.27275454476, 2860.4565132624734, 2888.0613800514916, 3190.872365105393, 3504.842282097312, 3592.8742494012845, 27703.168904932885, 27850.3037424064, 27862.442751145067, 28222.294442638893, 28224.858875705697, 3270.3949769292517, 3349.380364632551, 3357.4963755436634, 3390.3727810355163, 3407.2504049109157, 211737.0, 212929.0, 213813.0, 214030.0, 214123.0, 51426.228606570934, 52516.0, 56443.0, 56806.43193568094, 62135.0, 54944.17583736247, 55071.0, 55530.0, 55820.0, 55826.72086639541, 12693.365331733376, 12924.353782310847, 12930.159539629894, 12938.870611293954, 12949.54676586315, 9534.904650953402, 9674.854877176707, 9691.370060946016, 9692.22462203022, 9700.417974921527, 19035.428937131906, 19240.4227873164, 19243.230270789292, 19299.903500482407, 19309.710354344697, 7613.83005843332, 7828.334591559781, 7918.722844700408, 7978.840423191504, 8001.079875814239, 797.8882956386111, 865.2688478235881, 960.6349587156835, 969.6170012845027, 1025.733309339562, 26172.0, 26278.6058209127, 26302.736972630413, 28015.43969120647, 31188.84405578003, 899.7345782994032, 914.346242436661, 921.755734730297, 922.5802259971697, 977.5356705564942, 12521.56174533887, 13052.086353955321, 13188.142770719873, 13211.14127581704, 13228.801567976489, 318651.0, 322331.0, 324095.0, 324723.0, 326537.0, 45209.0, 45562.54437455583, 45607.0, 45644.54355456469, 45692.0, 1211.0614273937592, 1211.9757604847853, 1224.4428784903025, 1225.5894275417656, 1228.6928267933017, 23594.410139746644, 23725.458009381353, 27761.44477110406, 30230.395392091596, 30829.383412332078, 41973.370399443425, 42673.57326426696, 42761.786191068844, 42784.57215427806, 42868.0, 222223.0, 255419.0, 256914.0, 257552.0, 258251.0, 23288.0, 27135.72864271332, 27311.726882731713, 27392.726072739813, 27402.0, 34551.65448345484, 34990.30019399649, 35305.64694353126, 36001.81999089988, 36165.09587260339, 30382.54426183653, 30477.847610761804, 37497.4375384364, 38798.41802373023, 38842.805785970886, 32469.675303246666, 32973.34053318968, 33053.0, 33098.338033239685, 33209.83395083009, 32245.0, 33027.0, 33266.0, 33330.333393331515, 33451.330973380886, 27859.547093150824, 29855.0, 30062.398752025274, 30097.548536772403, 30143.849280753457, 23271.53456930818, 23417.648735268645, 23694.0, 23776.16783412572, 23783.762162378156], "unit": "ms", "name": "ext.html", "value": 17194.642865507605}, {"lowerIsBetter": false, "replicates": [332.4514550990865, 334.60349485859257, 335.625777258357, 337.1806510180262, 338.56325340311, 12739.745205095893, 13096.148750331246, 14664.12015279084, 15196.31616577254, 16186.190690465488, 9816.509174541263, 10022.749431264223, 10029.197664186866, 16032.198390080508, 16253.83746162538, 4614.976925115378, 4740.525947405249, 4742.312364707115, 4744.786484608184, 4760.928586071212, 3188.3463889902514, 3243.6431992480807, 5104.489551044884, 5266.762995665185, 5276.604254680895, 5215.322008138936, 5221.347331583552, 5222.086134926391, 5223.399309079467, 5250.579953603703, 4967.850964471072, 5102.183650615883, 5112.41207261166, 5112.872178195556, 5200.973995130019, 4931.334269873557, 4931.58081563064, 4932.506749325074, 4933.531314525115, 4934.925976110361, 11348.319100853892, 11730.0, 11731.120165987584, 11735.119866010084, 11743.882561174365, 1775.1922875091802, 1791.3640657566636, 1797.5416268851359, 1805.124514610413, 1874.8500119990367, 8726.738197854074, 9125.680601178994, 10635.361878287327, 12257.570985015482, 12469.812952805625, 1523.8019057522563, 1733.54927718794, 1796.9011704356255, 1806.5664240582298, 1808.620189760152, 54795.0, 57305.71347143279, 57772.13341799876, 57970.71014644942, 58136.70931645315, 10034.297599168134, 10041.899581004243, 10074.345167564084, 10081.294309398272, 10084.445355505371, 12704.42830072649, 12712.809307860389, 12717.491300348067, 12728.0, 12739.745205095845, 6777.152855893013, 6793.728250870009, 6801.591904485746, 6838.829029274308, 6876.0, 6377.202849643794, 6393.264774550893, 6424.164858568356, 6443.935560644333, 6444.226692796894, 4209.158168366339, 4210.7473551587, 4213.53651098385, 4268.466441694788, 4273.850415235452, 1609.1712767924528, 1659.3279721712727, 1661.7673525706412, 1699.7960244770707, 1713.5373449168655, 768.3161985832613, 774.8217909880759, 809.5426084262373, 816.4978538198965, 827.1769589258726, 14897.329620167118, 15089.24553772307, 16242.918785406233, 16523.256453459384, 16658.08380539058, 782.6791015683542, 801.6913488307043, 817.1664901800249, 819.848328059299, 821.6507984106851, 6234.657093859791, 8902.643894244287, 8979.0, 9065.274778017743, 9187.402818816889, 478448.0, 485097.0, 495686.0, 495787.0, 509047.0, 70316.0, 71567.0, 71730.0, 71751.28248717447, 72120.63939680268, 1008.2438171371472, 1021.6832781837654, 1021.7190272675074, 1032.9018743219383, 1079.0666073846066, 13877.722445551235, 13919.304034798422, 14229.573112806218, 14304.785428218376, 14676.119432834064, 30013.549796752628, 30382.696173037988, 30813.0, 31875.36249275048, 31940.36119277648, 40132.59867401405, 40831.38752918768, 43364.0, 43438.56561434345, 44131.55868441275, 8817.603207855534, 8966.103389661243, 8967.551622418723, 8988.86516702237, 9002.50486223264, 13240.742129497683, 15576.92211538935, 16384.590385239986, 16391.42630007944, 16543.751843722595, 13185.208887466782, 13274.07081504324, 13391.866081339062, 13589.184648921097, 13866.861331386557, 13000.804987925, 13036.0, 13293.335333233494, 13564.0, 13678.110922790385, 10996.835047474455, 11200.551977920792, 12659.113862029937, 12718.745625087631, 12963.870361296265, 8272.131426200403, 8291.295239904675, 8310.168983101641, 8342.749717508485, 8786.341024423065, 12608.810867837174, 12637.0, 12728.23630582168, 12751.681207969876, 12988.480460781462], "unit": "ms", "name": "jquery.html", "value": 7967.041896441256}, {"lowerIsBetter": false, "replicates": [1417.603071140081, 1647.884648074635, 1673.7071012572796, 1713.1263055841525, 1731.169038861347, 5952.851178720534, 6669.699863506142, 6787.7963661090125, 6804.693788779505, 6835.248122706498, 6366.713497892594, 6586.308437614053, 6586.37429444202, 6588.505862060352, 6593.274739778621, 1732.5668582854287, 1770.7078332075191, 2035.7557093148844, 2056.557840064386, 2097.129691178159, 2038.8063134002246, 2042.1831267492973, 2044.090379780998, 2044.867083639566, 2046.9692954605694, 2010.0954570443287, 2028.5739994601151, 2042.4485388944977, 2044.5093177637334, 2048.8770673759545, 1996.3212507747292, 2031.8171364577186, 2049.5695903860205, 2051.507638166837, 2070.2960993262363, 2077.6883467479847, 2124.033564728045, 2124.182189856916, 2125.4048866317457, 2125.883076430796, 6899.827504312382, 6972.267911869282, 6972.546784458994, 6977.406920411771, 6981.79054628362, 4055.047063939972, 4131.8967025824295, 4147.253494371012, 4151.501819781615, 4157.438745769343, 2645.061003343824, 2719.360950176707, 2733.2916926920675, 2741.6572928383953, 2760.8205466644604, 785.654312102673, 791.2917938445117, 815.1685281013392, 820.1839170025803, 853.9444936079135, 9160.267178625694, 9280.303977201736, 9333.859992100124, 9342.065793420672, 9343.439393636336, 3827.5789663137034, 3901.395283731026, 3938.8424463021734, 3939.5863434339553, 3940.960590394059, 8170.060443049126, 8172.264496195371, 8179.4274400792565, 8182.713605023796, 8194.262516373556, 4205.537390887, 4207.116505533872, 4214.557471465513, 4217.304144816132, 4217.768022758778, 3723.9255214896093, 3738.6448287412654, 3746.138388170736, 3759.4172903200047, 3764.284785890672, 3012.6384833819643, 3051.92370190747, 3275.950860737091, 3353.6311005789344, 3423.3495635829113, 1039.8284283093205, 1088.5482524752297, 1089.6622047165404, 1092.208149091902, 1094.037247222455, 864.6887120636566, 886.9201771840566, 909.1499448016126, 1147.6384938744268, 1149.93675347855, 6481.384268494486, 6483.7082331295205, 6527.836804079841, 6533.314002029719, 6554.213494380705, 550.2489102375309, 551.1732401397903, 561.6742289472096, 578.6990764802364, 715.8725008112244, 5202.115640341151, 5255.054090263713, 5269.499397557226, 5277.023750606073, 5288.391834938954, 8117.715879944291, 8539.74380768578, 8562.486250824846, 8577.614007369682, 8591.226789588967, 8344.499330040095, 8408.78978025542, 8416.747497575083, 8417.410781245377, 8431.451955622864, 6266.154069200691, 6467.870642587216, 6516.446102081281, 6554.606723596599, 6664.466842652576, 6529.118568993315, 6531.444827189742, 6564.737410503526, 6625.039369291522, 6634.4029037384935, 6913.619750913748, 7350.77947661571, 7355.264473552816, 7378.815529611588, 7427.702891884264, 7431.628418579157, 7567.31894129531, 7660.387169026353, 7683.231676832495, 7776.572288524186, 6152.969235153795, 6192.659403732838, 6226.906596400967, 6230.563860529719, 6271.027990661455, 5636.1545768133465, 5783.334916484489, 6457.483401327789, 6501.544891857525, 6689.832754181184, 6201.0, 6258.906116408167, 6285.057241413824, 6351.809445716636, 6438.710258038306, 6018.608790428783, 6142.416470435302, 6168.35232300602, 6288.402601752826, 6300.968495157678, 6299.716512756845, 6359.618422894641, 6382.042693595998, 6408.295087540274, 6412.743490260337, 5940.584159108821, 5948.702564871825, 5987.820365389045, 5993.910091348721, 6003.849903752441, 5888.440598143169, 5953.6725480097275, 5985.371535988658, 6002.039673652194, 6009.36901625323], "unit": "ms", "name": "mootools.html", "value": 3949.3245362940715}, {"lowerIsBetter": false, "replicates": [301.73748838510494, 307.09866541700114, 309.5063373918599, 313.4890129089585, 315.3503782208649, 5291.6824990500545, 5320.866978325539, 5329.600279978998, 5351.919721204175, 5361.946380536194, 5283.788648454057, 5291.497307755757, 5292.841214763554, 5294.947050529494, 5307.973460132704, 4149.6887733420035, 4162.8959276018195, 4166.958330416703, 4168.874933751992, 4173.749575025493, 3904.2386734586767, 4028.436018957348, 4167.729097608646, 4180.916381672365, 4181.226473102471, 3624.8912532624063, 3891.3384724596744, 3946.703997200207, 3990.3216453203027, 4005.3391190453685, 3993.8602148924792, 3995.8002099895034, 4078.530968938551, 4091.85678501251, 4094.529129150126, 3435.587729472454, 3578.3380074686265, 3608.0799396154075, 3637.2543628556346, 3643.0, 4945.9258111128365, 5020.0, 5067.138586440277, 5150.9742451287875, 5152.716600586966, 4709.693869898446, 4720.409948756405, 4721.693089949143, 4732.574068333866, 4734.810607575693, 5583.190437386556, 5616.466435688644, 5617.494425501724, 5622.409646987089, 5624.831255062355, 3890.5604926177493, 3891.299566078105, 3892.591277915835, 3896.240233154536, 3897.2984862724697, 5773.162891380768, 5822.650640961513, 5909.054551271819, 5922.437368449991, 5932.495737862244, 4024.0945787197647, 4025.657819085352, 4028.053407449247, 4029.6373326400767, 4032.7177097602885, 3773.019015056105, 4078.408630748525, 4081.0817566047995, 4085.9795701021303, 4087.2234275487563, 4459.974205932654, 4519.231730605739, 4648.9307459284555, 4651.511591282867, 4653.046125544255, 5565.638233514808, 5588.580856435784, 5592.217089607459, 5594.104943209067, 5607.663540187602, 1413.2156653057446, 1428.8928330375263, 1428.9857101428852, 1430.2777097565663, 1431.405966523881, 958.1999030809213, 961.927855410833, 963.3978763272954, 984.2077127911956, 985.5614251657944, 4922.261660750916, 4924.72913989734, 4938.728369939616, 4942.357493525818, 4942.481039490874, 5805.042168042226, 5838.2702162229725, 5839.153322768175, 5852.94147058524, 5857.15071314657, 4878.56092951636, 4904.60763138948, 4927.989762098761, 4928.827491037797, 4930.038642464757, 3050.42042012017, 3104.348086901776, 3115.4236466253815, 3133.3576616793503, 3141.858616362269, 5490.505854473116, 5491.341039075257, 5500.3949565547755, 5500.944990550123, 5505.03661859173, 6001.5798894077, 6007.699615019319, 6013.0, 6021.367756385516, 6021.60859544137, 5462.262594549685, 5494.780208791603, 5508.338999320107, 5513.283273174462, 5514.779408823602, 5666.0, 5785.392533783892, 5835.854103647443, 5840.853978650568, 5850.912236316373, 5663.093904975184, 5670.432956704297, 5680.630759000652, 5685.403032681509, 5686.061799802987, 5473.917891231555, 5491.395946445968, 5493.148561972901, 5494.972525137348, 5496.80761173357, 3895.0, 4033.334499807499, 4038.7172897896867, 4040.6565441937764, 4053.878383648377, 5545.085060964896, 5740.971295143498, 5783.161441590862, 5839.503642190291, 5841.18223448709, 5466.644668096561, 5543.501084902378, 5545.698535107885, 5552.083906155439, 5555.0, 5611.0, 5630.3525094613005, 5640.210370548045, 5650.29371328584, 5652.039153343859, 5399.568034557305, 5500.449955004628, 5506.889862202814, 5510.228568000403, 5518.365387980433, 5666.490015898589, 5671.319441667027, 5684.516816070681, 5687.090065589486, 5689.951617417809, 5533.557315414838, 5537.446255374431, 5544.7782088716, 5550.833474995757, 5554.222408862844], "unit": "ms", "name": "prototype.html", "value": 4197.40190439003}, {"lowerIsBetter": false, "replicates": [658.9308122647122, 662.3641304347826, 688.6453476459624, 751.1737089201882, 759.6543572674434, 11163.274387164829, 11303.491342889569, 11331.943340283296, 11366.60216892409, 12999.285039322856, 13060.542880999166, 13098.14862033967, 13127.146735462213, 13160.736785264313, 13216.93391533041, 637.1621317966859, 641.1024565608162, 808.2483290539795, 808.4502538273971, 808.6926967752246, 788.3456730913357, 795.1650766694976, 795.8010497375656, 796.0328201235498, 814.722994181981, 667.199360767079, 829.4442723375323, 829.85062688716, 831.2394159344193, 848.5629900601195, 656.9441597464221, 661.9702113404884, 667.0494545272991, 836.0302049622409, 842.4397775479299, 613.5827637206697, 614.2659521871366, 614.6865098799644, 625.1810128731377, 634.0077778276982, 11733.4719937603, 11813.940930295294, 11821.408929553574, 11822.113341499422, 11908.940455297754, 10630.946845265802, 10842.349459032483, 10878.456077196108, 10940.343579385262, 11403.657890263305, 8759.2992560595, 9408.43549387039, 9504.667336643253, 9654.131128198496, 9695.70912872615, 3105.0374383941053, 3136.498160294342, 3137.1529686984613, 3139.372125574894, 3180.0459862041525, 39558.20883582312, 39692.801535992425, 39780.20439591221, 39963.20073598541, 40062.599374006175, 8501.0, 8663.176998185289, 8756.8686469703, 9014.323925705598, 9133.49765762876, 14699.412023519153, 14706.33821478036, 14708.779368309484, 14725.337359818834, 14730.55808325752, 5955.67243801595, 6213.720382582795, 6223.097650840603, 6256.874862502725, 6416.903746443807, 3543.8936831895085, 3656.780593164419, 3669.2478042001326, 3675.6767563677054, 3682.1346983458866, 2621.685397752282, 2638.934026649349, 2640.828346157532, 2643.2863126955613, 2649.3509090273005, 429.9054208074219, 432.80740070668253, 434.27476114888213, 437.84190815294005, 445.8172149418723, 440.23399285244085, 514.26460161968, 514.4289838279507, 515.5823782735996, 521.0201235305823, 7178.641067946582, 7179.784606461814, 7199.604021778748, 7209.783706488814, 7413.8146546336775, 463.6522608043967, 530.6921985248547, 534.8208350202648, 550.6090675620354, 557.6542543622979, 3472.8610855566, 3481.89554313371, 3580.7493475456467, 3582.5880023797076, 3685.0603096210293, 48083.27875081877, 49146.50853491491, 49204.50795492071, 49300.0, 49759.751201243766, 44447.33329000068, 44540.77729611396, 44971.77514112408, 45435.77282113568, 46577.30134047992, 38605.806970964964, 38958.415623765664, 39918.60081399207, 42552.78723606424, 42682.57317426848, 7958.562279074707, 8031.237032481905, 8138.633761480866, 8311.625976831177, 8423.4945903246, 30785.230369240948, 31082.689173108884, 31498.370032598763, 31539.21151971219, 32002.19994500063, 35032.64967350396, 35245.82377088098, 37456.0, 39062.609373907035, 39295.607043929194, 10045.799084018132, 10366.170706343324, 10769.461526923778, 10795.460226988462, 11048.668539943814, 10964.451777411257, 11089.944550277198, 11129.0, 11215.271007384494, 11310.717232069264, 10160.898391016291, 10261.640842570772, 10343.0, 10532.210084243865, 10780.245382823126, 9989.450580217866, 10098.747531311776, 10141.391516509033, 10175.847362289423, 10384.740381490523, 9368.906310936803, 9383.859242111237, 9400.200982916529, 9488.95255523718, 9495.335326527076, 8659.956700216459, 8673.739787806377, 9284.350095493252, 9397.530123493934, 9536.174785100331, 8862.822743545223, 9122.498262595622, 9312.255019598551, 9345.132390206949, 9574.617015319309], "unit": "ms", "name": "yui.html", "value": 5567.676947435212}], "name": "dromaeo_css", "value": 6225.042952177132}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 113.0, 106.0, 111.0, 112.0, 111.0, 103.0, 112.0, 112.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 110.1}, {"lowerIsBetter": true, "replicates": [154.0, 131.0, 151.0, 170.0, 133.0, 151.0, 157.0, 131.0, 171.0, 137.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.6}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 162.0, 163.0, 161.0, 161.0, 162.0, 161.0, 162.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 83.0, 89.0, 72.0, 79.0, 72.0, 100.0, 92.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 80.4}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 135.0, 94.0, 95.0, 95.0, 134.0, 96.0, 94.0, 133.0], "unit": "ms", "name": "audio-oscillator", "value": 106.7}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 146.0, 146.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 73.0, 72.0, 71.0, 71.0, 71.0, 88.0, 71.0, 70.0], "unit": "ms", "name": "json-parse-financial", "value": 73.0}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 69.0, 68.0, 69.0, 69.0, 69.0, 69.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [81.0, 84.0, 84.0, 84.0, 84.0, 83.0, 97.0, 83.0, 83.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.6}, {"lowerIsBetter": true, "replicates": [118.0, 124.0, 119.0, 126.0, 120.0, 132.0, 127.0, 119.0, 128.0, 130.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.3}, {"lowerIsBetter": true, "replicates": [141.0, 143.0, 150.0, 148.0, 158.0, 136.0, 151.0, 135.0, 147.0, 135.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.4}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 72.0, 69.0, 71.0, 68.0, 72.0, 72.0, 70.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.5}], "name": "kraken", "value": 1523.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.69095816464238], "unit": "score", "name": "Richards", "value": 209.27025600000007}, {"lowerIsBetter": false, "replicates": [186.53236336504384], "unit": "score", "name": "DeltaBlue", "value": 354.4585980000001}, {"lowerIsBetter": false, "replicates": [280.97780275358247], "unit": "score", "name": "Encrypt", "value": 947.3381789999996}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [1980.1980198019803], "unit": "score", "name": "RayTrace", "value": 373.6944450000001}, {"lowerIsBetter": false, "replicates": [801.924619085806], "unit": "score", "name": "Earley", "value": 831.079361}, {"lowerIsBetter": false, "replicates": [11651.162790697674], "unit": "score", "name": "Boyer", "value": 57.20141516966067}, {"lowerIsBetter": false, "replicates": [27108.108108108107], "unit": "score", "name": "RegExp", "value": 33.60562811565303}, {"lowerIsBetter": false, "replicates": [609.3845216331505], "unit": "score", "name": "Splay", "value": 133.72673099999997}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 19779.711175970035}]} 12:05:06 INFO - RETURN: dromaeo_css: 6225.04 12:05:06 INFO - RETURN: kraken: 1523.80 12:05:06 INFO - RETURN: v8_7: 19779.71 12:05:06 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19779.71"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1523.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6225.04"}}} 12:05:06 INFO - Return code: 0 12:05:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:05:06 INFO - # TBPL SUCCESS # 12:05:06 INFO - Running post-action listener: _resource_record_post_action 12:05:06 INFO - Running post-run listener: _resource_record_post_run 12:05:07 INFO - Total resource usage - Wall time: 1239s; CPU: 13.0%; Read bytes: 8192; Write bytes: 505888768; Read time: 24; Write time: 640144 12:05:07 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 232112128; Read time: 0; Write time: 472816 12:05:07 INFO - run-tests - Wall time: 1224s; CPU: 13.0%; Read bytes: 8192; Write bytes: 273776640; Read time: 24; Write time: 167328 12:05:07 INFO - Running post-run listener: _upload_blobber_files 12:05:07 INFO - Blob upload gear active. 12:05:07 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:05:07 INFO - Copying logs to upload dir... 12:05:07 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1288.264633 ========= master_lag: 39.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 7 secs) (at 2015-12-11 12:05:46.847270) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-11 12:05:46.852217) ========= 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=c402a24d74c70935940d60dd000001de-1449861795.390981-1322611118 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.009910 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.03 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-11 12:05:46.892631) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 12:05:46.893040) ========= 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=c402a24d74c70935940d60dd000001de-1449861795.390981-1322611118 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004565 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 12:05:46.942979) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-11 12:05:46.944161) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-11 12:05:46.944445) ========= ========= Total master_lag: 39.35 =========